builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1449834633.99 results: success (0) buildid: 20151211023735 builduid: c14a532d01334282a9f8013f402d58b4 revision: 0dd42501bbe65904cf5a4f8b6e37408d60333045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.986891) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.987295) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:33.987735) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.061070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.061362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.136741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.137060) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.192270) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.192610) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.193279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.196604) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 03:50:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-11 03:50:36 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.389627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.389959) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016564 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.446963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:34.447288) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0dd42501bbe65904cf5a4f8b6e37408d60333045 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0dd42501bbe65904cf5a4f8b6e37408d60333045 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 03:50:37,062 truncating revision to first 12 chars 2015-12-11 03:50:37,063 Setting DEBUG logging. 2015-12-11 03:50:37,063 attempt 1/10 2015-12-11 03:50:37,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0dd42501bbe6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 03:50:37,615 unpacking tar archive at: mozilla-central-0dd42501bbe6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.302140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.302498) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.322630) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.322918) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 03:50:35.323360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-11 03:50:35.323653) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:38 INFO - MultiFileLogger online at 20151211 03:50:38 in /builds/slave/test 03:50:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:50:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:38 INFO - {'append_to_log': False, 03:50:38 INFO - 'base_work_dir': '/builds/slave/test', 03:50:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:50:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:38 INFO - 'branch': 'Firefox-Non-PGO', 03:50:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:38 INFO - 'config_files': ('talos/linux_config.py',), 03:50:38 INFO - 'default_actions': ('clobber', 03:50:38 INFO - 'read-buildbot-config', 03:50:38 INFO - 'download-and-extract', 03:50:38 INFO - 'populate-webroot', 03:50:38 INFO - 'create-virtualenv', 03:50:38 INFO - 'install', 03:50:38 INFO - 'run-tests'), 03:50:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:38 INFO - 'download_minidump_stackwalk': True, 03:50:38 INFO - 'download_symbols': 'ondemand', 03:50:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:38 INFO - 'installer_path': 'installer.exe', 03:50:38 INFO - 'log_level': 'info', 03:50:38 INFO - 'log_name': 'talos', 03:50:38 INFO - 'log_to_console': True, 03:50:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:38 INFO - 'opt_config_files': (), 03:50:38 INFO - 'pip_index': False, 03:50:38 INFO - 'sps_profile': False, 03:50:38 INFO - 'sps_profile_interval': 0, 03:50:38 INFO - 'suite': 'dromaeojs', 03:50:38 INFO - 'system_bits': '64', 03:50:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:38 INFO - 'title': 'talos-linux64-ix-056', 03:50:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:38 INFO - 'use_talos_json': True, 03:50:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:38 INFO - 'work_dir': 'build'} 03:50:38 INFO - ##### 03:50:38 INFO - ##### Running clobber step. 03:50:38 INFO - ##### 03:50:38 INFO - Running pre-action listener: _resource_record_pre_action 03:50:38 INFO - Running main action method: clobber 03:50:38 INFO - rmtree: /builds/slave/test/build 03:50:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:38 INFO - Running post-action listener: _resource_record_post_action 03:50:38 INFO - ##### 03:50:38 INFO - ##### Running read-buildbot-config step. 03:50:38 INFO - ##### 03:50:38 INFO - Running pre-action listener: _resource_record_pre_action 03:50:38 INFO - Running main action method: read_buildbot_config 03:50:38 INFO - Using buildbot properties: 03:50:38 INFO - { 03:50:38 INFO - "properties": { 03:50:38 INFO - "buildnumber": 343, 03:50:38 INFO - "product": "firefox", 03:50:38 INFO - "script_repo_revision": "production", 03:50:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:50:38 INFO - "repository": "", 03:50:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:50:38 INFO - "buildid": "20151211023735", 03:50:38 INFO - "slavename": "talos-linux64-ix-056", 03:50:38 INFO - "pgo_build": "False", 03:50:38 INFO - "basedir": "/builds/slave/test", 03:50:38 INFO - "project": "", 03:50:38 INFO - "platform": "ubuntu64_hw", 03:50:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:50:38 INFO - "slavebuilddir": "test", 03:50:38 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:50:38 INFO - "branch": "mozilla-central", 03:50:38 INFO - "repo_path": "mozilla-central", 03:50:38 INFO - "stage_platform": "linux64", 03:50:38 INFO - "builduid": "c14a532d01334282a9f8013f402d58b4", 03:50:38 INFO - "revision": "0dd42501bbe65904cf5a4f8b6e37408d60333045" 03:50:38 INFO - }, 03:50:38 INFO - "sourcestamp": { 03:50:38 INFO - "repository": "", 03:50:38 INFO - "hasPatch": false, 03:50:38 INFO - "project": "", 03:50:38 INFO - "branch": "mozilla-central-linux64-talos", 03:50:38 INFO - "changes": [ 03:50:38 INFO - { 03:50:38 INFO - "category": null, 03:50:38 INFO - "files": [ 03:50:38 INFO - { 03:50:38 INFO - "url": null, 03:50:38 INFO - "name": "https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:50:38 INFO - } 03:50:38 INFO - ], 03:50:38 INFO - "repository": "", 03:50:38 INFO - "rev": "0dd42501bbe65904cf5a4f8b6e37408d60333045", 03:50:38 INFO - "who": "cbook@mozilla.com", 03:50:38 INFO - "when": 1449834570, 03:50:38 INFO - "number": 7326981, 03:50:38 INFO - "comments": "merge fx-team to mozilla-central a=merge", 03:50:38 INFO - "project": "", 03:50:38 INFO - "at": "Fri 11 Dec 2015 03:49:30", 03:50:38 INFO - "branch": "mozilla-central-linux64-talos", 03:50:38 INFO - "revlink": "", 03:50:38 INFO - "properties": [ 03:50:38 INFO - [ 03:50:38 INFO - "buildid", 03:50:38 INFO - "20151211023735", 03:50:38 INFO - "Change" 03:50:38 INFO - ], 03:50:38 INFO - [ 03:50:38 INFO - "builduid", 03:50:38 INFO - "c14a532d01334282a9f8013f402d58b4", 03:50:38 INFO - "Change" 03:50:38 INFO - ], 03:50:38 INFO - [ 03:50:38 INFO - "pgo_build", 03:50:38 INFO - "False", 03:50:38 INFO - "Change" 03:50:38 INFO - ] 03:50:38 INFO - ], 03:50:38 INFO - "revision": "0dd42501bbe65904cf5a4f8b6e37408d60333045" 03:50:38 INFO - } 03:50:38 INFO - ], 03:50:38 INFO - "revision": "0dd42501bbe65904cf5a4f8b6e37408d60333045" 03:50:38 INFO - } 03:50:38 INFO - } 03:50:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:50:38 INFO - Running post-action listener: _resource_record_post_action 03:50:38 INFO - ##### 03:50:38 INFO - ##### Running download-and-extract step. 03:50:38 INFO - ##### 03:50:38 INFO - Running pre-action listener: _resource_record_pre_action 03:50:38 INFO - Running main action method: download_and_extract 03:50:38 INFO - mkdir: /builds/slave/test/build/tests 03:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:38 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:50:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json 03:50:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json 03:50:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:50:43 INFO - Downloaded 1302 bytes. 03:50:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:50:43 INFO - Using the following test package requirements: 03:50:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'jsshell-linux-x86_64.zip'], 03:50:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:50:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:50:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:50:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:50:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:43 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:50:46 INFO - Downloaded 21866577 bytes. 03:50:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:50:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:50:47 INFO - Return code: 0 03:50:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:47 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:50:51 INFO - Downloaded 21866577 bytes. 03:50:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:50:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:50:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:50:52 INFO - Return code: 0 03:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:52 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:50:54 INFO - Downloaded 11132038 bytes. 03:50:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:50:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:50:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:50:54 INFO - Return code: 0 03:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:54 INFO - https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:50:57 INFO - Downloaded 57728978 bytes. 03:50:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:57 INFO - mkdir: /builds/slave/test/properties 03:50:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:57 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:57 INFO - Contents: 03:50:57 INFO - build_url:https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:50:57 INFO - Running post-action listener: _resource_record_post_action 03:50:57 INFO - Running post-action listener: set_extra_try_arguments 03:50:57 INFO - ##### 03:50:57 INFO - ##### Running populate-webroot step. 03:50:57 INFO - ##### 03:50:57 INFO - Running pre-action listener: _resource_record_pre_action 03:50:57 INFO - Running main action method: populate_webroot 03:50:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:57 INFO - '--tppagecycles', 03:50:57 INFO - '7'], 03:50:57 INFO - 'tests': ['tsvgm']}}, 03:50:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:50:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'tests': ['damp', 'tps']}, 03:50:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['damp', 'tps']}, 03:50:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:50:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:57 INFO - 'other': {'tests': ['a11yr', 03:50:57 INFO - 'ts_paint', 03:50:57 INFO - 'tpaint', 03:50:57 INFO - 'sessionrestore', 03:50:57 INFO - 'sessionrestore_no_auto_restore']}, 03:50:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['a11yr', 03:50:57 INFO - 'ts_paint', 03:50:57 INFO - 'tpaint', 03:50:57 INFO - 'sessionrestore', 03:50:57 INFO - 'sessionrestore_no_auto_restore']}, 03:50:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['a11yr', 03:50:57 INFO - 'ts_paint', 03:50:57 INFO - 'tpaint', 03:50:57 INFO - 'sessionrestore', 03:50:57 INFO - 'sessionrestore_no_auto_restore']}, 03:50:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['a11yr', 03:50:57 INFO - 'ts_paint', 03:50:57 INFO - 'tpaint', 03:50:57 INFO - 'sessionrestore', 03:50:57 INFO - 'sessionrestore_no_auto_restore']}, 03:50:57 INFO - 'other_l64': {'tests': ['a11yr', 03:50:57 INFO - 'ts_paint', 03:50:57 INFO - 'tpaint', 03:50:57 INFO - 'sessionrestore', 03:50:57 INFO - 'sessionrestore_no_auto_restore']}, 03:50:57 INFO - 'other_nol64': {'tests': ['a11yr', 03:50:57 INFO - 'ts_paint', 03:50:57 INFO - 'tpaint', 03:50:57 INFO - 'sessionrestore', 03:50:57 INFO - 'sessionrestore_no_auto_restore']}, 03:50:57 INFO - 'svgr': {'tests': ['tsvgx', 03:50:57 INFO - 'tsvgr_opacity', 03:50:57 INFO - 'tart', 03:50:57 INFO - 'tscrollx', 03:50:57 INFO - 'cart']}, 03:50:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['tsvgx', 03:50:57 INFO - 'tsvgr_opacity', 03:50:57 INFO - 'tart', 03:50:57 INFO - 'tscrollx', 03:50:57 INFO - 'cart']}, 03:50:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'tests': ['tp5o']}, 03:50:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'talos_options': ['--e10s'], 03:50:57 INFO - 'tests': ['tp5o']}, 03:50:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'talos_options': ['--xperf_path', 03:50:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:57 INFO - 'tests': ['tp5n']}, 03:50:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:57 INFO - 'talos_options': ['--e10s', 03:50:57 INFO - '--xperf_path', 03:50:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:57 INFO - 'tests': ['tp5n']}}, 03:50:57 INFO - 'talos.zip': {'path': '', 03:50:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:57 INFO - Running post-action listener: _resource_record_post_action 03:50:57 INFO - ##### 03:50:57 INFO - ##### Running create-virtualenv step. 03:50:57 INFO - ##### 03:50:57 INFO - Running pre-action listener: _resource_record_pre_action 03:50:57 INFO - Running main action method: create_virtualenv 03:50:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:50:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:57 INFO - Using real prefix '/usr' 03:50:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:59 INFO - Installing pip.................done. 03:50:59 INFO - Return code: 0 03:50:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:50:59 INFO - Using env: {'DISPLAY': ':0', 03:50:59 INFO - 'HOME': '/home/cltbld', 03:50:59 INFO - 'LANG': 'en_US.UTF-8', 03:50:59 INFO - 'LANGUAGE': 'en_US:en', 03:50:59 INFO - 'LOGNAME': 'cltbld', 03:50:59 INFO - 'MAIL': '/var/mail/cltbld', 03:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:59 INFO - 'MOZ_NO_REMOTE': '1', 03:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:59 INFO - 'NO_EM_RESTART': '1', 03:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:59 INFO - 'PWD': '/builds/slave/test', 03:50:59 INFO - 'SHELL': '/bin/bash', 03:50:59 INFO - 'SHLVL': '1', 03:50:59 INFO - 'TERM': 'linux', 03:50:59 INFO - 'TMOUT': '86400', 03:50:59 INFO - 'USER': 'cltbld', 03:50:59 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:59 INFO - '_': '/tools/buildbot/bin/python'} 03:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:50:59 INFO - Cleaning up... 03:50:59 INFO - Return code: 0 03:50:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:50:59 INFO - Using env: {'DISPLAY': ':0', 03:50:59 INFO - 'HOME': '/home/cltbld', 03:50:59 INFO - 'LANG': 'en_US.UTF-8', 03:50:59 INFO - 'LANGUAGE': 'en_US:en', 03:50:59 INFO - 'LOGNAME': 'cltbld', 03:50:59 INFO - 'MAIL': '/var/mail/cltbld', 03:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:59 INFO - 'MOZ_NO_REMOTE': '1', 03:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:59 INFO - 'NO_EM_RESTART': '1', 03:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:59 INFO - 'PWD': '/builds/slave/test', 03:50:59 INFO - 'SHELL': '/bin/bash', 03:50:59 INFO - 'SHLVL': '1', 03:50:59 INFO - 'TERM': 'linux', 03:50:59 INFO - 'TMOUT': '86400', 03:50:59 INFO - 'USER': 'cltbld', 03:50:59 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:59 INFO - '_': '/tools/buildbot/bin/python'} 03:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:00 INFO - Downloading/unpacking psutil>=0.7.1 03:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:51:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:51:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:01 INFO - Installing collected packages: psutil 03:51:01 INFO - Running setup.py install for psutil 03:51:02 INFO - building 'psutil._psutil_linux' extension 03:51:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:51:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:51:02 INFO - building 'psutil._psutil_posix' extension 03:51:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:51:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:51:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:51:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:51:02 INFO - Successfully installed psutil 03:51:02 INFO - Cleaning up... 03:51:02 INFO - Return code: 0 03:51:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:51:02 INFO - Using env: {'DISPLAY': ':0', 03:51:02 INFO - 'HOME': '/home/cltbld', 03:51:02 INFO - 'LANG': 'en_US.UTF-8', 03:51:02 INFO - 'LANGUAGE': 'en_US:en', 03:51:02 INFO - 'LOGNAME': 'cltbld', 03:51:02 INFO - 'MAIL': '/var/mail/cltbld', 03:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:02 INFO - 'MOZ_NO_REMOTE': '1', 03:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:02 INFO - 'NO_EM_RESTART': '1', 03:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:02 INFO - 'PWD': '/builds/slave/test', 03:51:02 INFO - 'SHELL': '/bin/bash', 03:51:02 INFO - 'SHLVL': '1', 03:51:02 INFO - 'TERM': 'linux', 03:51:02 INFO - 'TMOUT': '86400', 03:51:02 INFO - 'USER': 'cltbld', 03:51:02 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:02 INFO - '_': '/tools/buildbot/bin/python'} 03:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:51:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:51:04 INFO - Installing collected packages: mozsystemmonitor 03:51:04 INFO - Running setup.py install for mozsystemmonitor 03:51:04 INFO - Successfully installed mozsystemmonitor 03:51:04 INFO - Cleaning up... 03:51:04 INFO - Return code: 0 03:51:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:51:04 INFO - Using env: {'DISPLAY': ':0', 03:51:04 INFO - 'HOME': '/home/cltbld', 03:51:04 INFO - 'LANG': 'en_US.UTF-8', 03:51:04 INFO - 'LANGUAGE': 'en_US:en', 03:51:04 INFO - 'LOGNAME': 'cltbld', 03:51:04 INFO - 'MAIL': '/var/mail/cltbld', 03:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:04 INFO - 'MOZ_NO_REMOTE': '1', 03:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:04 INFO - 'NO_EM_RESTART': '1', 03:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:04 INFO - 'PWD': '/builds/slave/test', 03:51:04 INFO - 'SHELL': '/bin/bash', 03:51:04 INFO - 'SHLVL': '1', 03:51:04 INFO - 'TERM': 'linux', 03:51:04 INFO - 'TMOUT': '86400', 03:51:04 INFO - 'USER': 'cltbld', 03:51:04 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:04 INFO - '_': '/tools/buildbot/bin/python'} 03:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:07 INFO - Downloading docopt-0.6.1.tar.gz 03:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:07 INFO - Running setup.py install for blobuploader 03:51:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:07 INFO - Running setup.py install for requests 03:51:07 INFO - Running setup.py install for docopt 03:51:07 INFO - Successfully installed blobuploader requests docopt 03:51:07 INFO - Cleaning up... 03:51:07 INFO - Return code: 0 03:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:51:07 INFO - Using env: {'DISPLAY': ':0', 03:51:07 INFO - 'HOME': '/home/cltbld', 03:51:07 INFO - 'LANG': 'en_US.UTF-8', 03:51:07 INFO - 'LANGUAGE': 'en_US:en', 03:51:07 INFO - 'LOGNAME': 'cltbld', 03:51:07 INFO - 'MAIL': '/var/mail/cltbld', 03:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:07 INFO - 'MOZ_NO_REMOTE': '1', 03:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:07 INFO - 'NO_EM_RESTART': '1', 03:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:07 INFO - 'PWD': '/builds/slave/test', 03:51:07 INFO - 'SHELL': '/bin/bash', 03:51:07 INFO - 'SHLVL': '1', 03:51:07 INFO - 'TERM': 'linux', 03:51:07 INFO - 'TMOUT': '86400', 03:51:07 INFO - 'USER': 'cltbld', 03:51:07 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:07 INFO - '_': '/tools/buildbot/bin/python'} 03:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:07 INFO - Running setup.py (path:/tmp/pip-YXrJZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:08 INFO - Running setup.py (path:/tmp/pip-LBrCf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:08 INFO - Running setup.py (path:/tmp/pip-i7G7nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:08 INFO - Running setup.py (path:/tmp/pip-PPVzGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:08 INFO - Running setup.py (path:/tmp/pip-zcV75N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:08 INFO - Running setup.py (path:/tmp/pip-J8XYYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:08 INFO - Running setup.py (path:/tmp/pip-PrBPkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:08 INFO - Running setup.py (path:/tmp/pip-Ww0rGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:08 INFO - Running setup.py (path:/tmp/pip-CX0kxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:08 INFO - Running setup.py (path:/tmp/pip-lRp8AQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:08 INFO - Running setup.py (path:/tmp/pip-1MBaQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:08 INFO - Running setup.py (path:/tmp/pip-IO37X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:08 INFO - Running setup.py (path:/tmp/pip-qi6Y3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:08 INFO - Running setup.py (path:/tmp/pip-UjjME5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:09 INFO - Running setup.py (path:/tmp/pip-Zw32ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:09 INFO - Running setup.py (path:/tmp/pip-AYq1f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:09 INFO - Running setup.py (path:/tmp/pip-ePIgO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:09 INFO - Running setup.py install for manifestparser 03:51:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:09 INFO - Running setup.py install for mozcrash 03:51:09 INFO - Running setup.py install for mozdebug 03:51:09 INFO - Running setup.py install for mozdevice 03:51:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:51:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:09 INFO - Running setup.py install for mozfile 03:51:09 INFO - Running setup.py install for mozhttpd 03:51:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:09 INFO - Running setup.py install for mozinfo 03:51:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:09 INFO - Running setup.py install for mozInstall 03:51:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Running setup.py install for mozleak 03:51:10 INFO - Running setup.py install for mozlog 03:51:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Running setup.py install for moznetwork 03:51:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Running setup.py install for mozprocess 03:51:10 INFO - Running setup.py install for mozprofile 03:51:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Running setup.py install for mozrunner 03:51:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:10 INFO - Running setup.py install for mozscreenshot 03:51:10 INFO - Running setup.py install for moztest 03:51:10 INFO - Running setup.py install for mozversion 03:51:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:11 INFO - Cleaning up... 03:51:11 INFO - Return code: 0 03:51:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:51:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:51:11 INFO - Using env: {'DISPLAY': ':0', 03:51:11 INFO - 'HOME': '/home/cltbld', 03:51:11 INFO - 'LANG': 'en_US.UTF-8', 03:51:11 INFO - 'LANGUAGE': 'en_US:en', 03:51:11 INFO - 'LOGNAME': 'cltbld', 03:51:11 INFO - 'MAIL': '/var/mail/cltbld', 03:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:11 INFO - 'MOZ_NO_REMOTE': '1', 03:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:11 INFO - 'NO_EM_RESTART': '1', 03:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:11 INFO - 'PWD': '/builds/slave/test', 03:51:11 INFO - 'SHELL': '/bin/bash', 03:51:11 INFO - 'SHLVL': '1', 03:51:11 INFO - 'TERM': 'linux', 03:51:11 INFO - 'TMOUT': '86400', 03:51:11 INFO - 'USER': 'cltbld', 03:51:11 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:11 INFO - '_': '/tools/buildbot/bin/python'} 03:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:11 INFO - Running setup.py (path:/tmp/pip-wSJ9E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:11 INFO - Running setup.py (path:/tmp/pip-MlNKrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:11 INFO - Running setup.py (path:/tmp/pip-RKQqjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:11 INFO - Running setup.py (path:/tmp/pip-kC_met-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:11 INFO - Running setup.py (path:/tmp/pip-ePmlBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:11 INFO - Running setup.py (path:/tmp/pip-K8Yk2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:11 INFO - Running setup.py (path:/tmp/pip-5erOje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:11 INFO - Running setup.py (path:/tmp/pip-neHkZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:11 INFO - Running setup.py (path:/tmp/pip-VImCbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:11 INFO - Running setup.py (path:/tmp/pip-dH5Fjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:11 INFO - Running setup.py (path:/tmp/pip-B_0PYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:12 INFO - Running setup.py (path:/tmp/pip-NIx_8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:12 INFO - Running setup.py (path:/tmp/pip-87ZjtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:12 INFO - Running setup.py (path:/tmp/pip-KmooKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:12 INFO - Running setup.py (path:/tmp/pip-q9O6Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:12 INFO - Running setup.py (path:/tmp/pip-E0Rk_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:12 INFO - Running setup.py (path:/tmp/pip-5G_AlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:51:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:14 INFO - Downloading blessings-1.5.1.tar.gz 03:51:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:14 INFO - Installing collected packages: blessings 03:51:14 INFO - Running setup.py install for blessings 03:51:14 INFO - Successfully installed blessings 03:51:14 INFO - Cleaning up... 03:51:14 INFO - Return code: 0 03:51:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:14 INFO - Reading from file tmpfile_stdout 03:51:14 INFO - Current package versions: 03:51:14 INFO - argparse == 1.2.1 03:51:14 INFO - blessings == 1.5.1 03:51:14 INFO - blobuploader == 1.2.4 03:51:14 INFO - docopt == 0.6.1 03:51:14 INFO - manifestparser == 1.1 03:51:14 INFO - mozInstall == 1.12 03:51:14 INFO - mozcrash == 0.16 03:51:14 INFO - mozdebug == 0.1 03:51:14 INFO - mozdevice == 0.47 03:51:14 INFO - mozfile == 1.2 03:51:14 INFO - mozhttpd == 0.7 03:51:14 INFO - mozinfo == 0.9 03:51:14 INFO - mozleak == 0.1 03:51:14 INFO - mozlog == 3.1 03:51:14 INFO - moznetwork == 0.27 03:51:14 INFO - mozprocess == 0.22 03:51:14 INFO - mozprofile == 0.27 03:51:14 INFO - mozrunner == 6.11 03:51:14 INFO - mozscreenshot == 0.1 03:51:14 INFO - mozsystemmonitor == 0.0 03:51:14 INFO - moztest == 0.7 03:51:14 INFO - mozversion == 1.4 03:51:14 INFO - psutil == 3.1.1 03:51:14 INFO - requests == 1.2.3 03:51:14 INFO - wsgiref == 0.1.2 03:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:51:14 INFO - Using env: {'DISPLAY': ':0', 03:51:14 INFO - 'HOME': '/home/cltbld', 03:51:14 INFO - 'LANG': 'en_US.UTF-8', 03:51:14 INFO - 'LANGUAGE': 'en_US:en', 03:51:14 INFO - 'LOGNAME': 'cltbld', 03:51:14 INFO - 'MAIL': '/var/mail/cltbld', 03:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:14 INFO - 'MOZ_NO_REMOTE': '1', 03:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:14 INFO - 'NO_EM_RESTART': '1', 03:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:14 INFO - 'PWD': '/builds/slave/test', 03:51:14 INFO - 'SHELL': '/bin/bash', 03:51:14 INFO - 'SHLVL': '1', 03:51:14 INFO - 'TERM': 'linux', 03:51:14 INFO - 'TMOUT': '86400', 03:51:14 INFO - 'USER': 'cltbld', 03:51:14 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:14 INFO - '_': '/tools/buildbot/bin/python'} 03:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:51:14 INFO - Cleaning up... 03:51:14 INFO - Return code: 0 03:51:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:51:14 INFO - Using env: {'DISPLAY': ':0', 03:51:14 INFO - 'HOME': '/home/cltbld', 03:51:14 INFO - 'LANG': 'en_US.UTF-8', 03:51:14 INFO - 'LANGUAGE': 'en_US:en', 03:51:14 INFO - 'LOGNAME': 'cltbld', 03:51:14 INFO - 'MAIL': '/var/mail/cltbld', 03:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:14 INFO - 'MOZ_NO_REMOTE': '1', 03:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:14 INFO - 'NO_EM_RESTART': '1', 03:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:14 INFO - 'PWD': '/builds/slave/test', 03:51:14 INFO - 'SHELL': '/bin/bash', 03:51:14 INFO - 'SHLVL': '1', 03:51:14 INFO - 'TERM': 'linux', 03:51:14 INFO - 'TMOUT': '86400', 03:51:14 INFO - 'USER': 'cltbld', 03:51:14 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:14 INFO - '_': '/tools/buildbot/bin/python'} 03:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:15 INFO - Downloading/unpacking jsonschema 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:51:16 INFO - Downloading/unpacking functools32 (from jsonschema) 03:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:17 INFO - warning: no files found matching '*.txt' 03:51:17 INFO - no previously-included directories found matching 'build' 03:51:17 INFO - no previously-included directories found matching 'dist' 03:51:17 INFO - no previously-included directories found matching '.git*' 03:51:17 INFO - Installing collected packages: jsonschema, functools32 03:51:17 INFO - Running setup.py install for functools32 03:51:17 INFO - warning: no files found matching '*.txt' 03:51:17 INFO - no previously-included directories found matching 'build' 03:51:17 INFO - no previously-included directories found matching 'dist' 03:51:17 INFO - no previously-included directories found matching '.git*' 03:51:17 INFO - Successfully installed jsonschema functools32 03:51:17 INFO - Cleaning up... 03:51:17 INFO - Return code: 0 03:51:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faabb5ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16bd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:51:17 INFO - Using env: {'DISPLAY': ':0', 03:51:17 INFO - 'HOME': '/home/cltbld', 03:51:17 INFO - 'LANG': 'en_US.UTF-8', 03:51:17 INFO - 'LANGUAGE': 'en_US:en', 03:51:17 INFO - 'LOGNAME': 'cltbld', 03:51:17 INFO - 'MAIL': '/var/mail/cltbld', 03:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:17 INFO - 'MOZ_NO_REMOTE': '1', 03:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:17 INFO - 'NO_EM_RESTART': '1', 03:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:17 INFO - 'PWD': '/builds/slave/test', 03:51:17 INFO - 'SHELL': '/bin/bash', 03:51:17 INFO - 'SHLVL': '1', 03:51:17 INFO - 'TERM': 'linux', 03:51:17 INFO - 'TMOUT': '86400', 03:51:17 INFO - 'USER': 'cltbld', 03:51:17 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:17 INFO - '_': '/tools/buildbot/bin/python'} 03:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:17 INFO - Downloading/unpacking flake8 03:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:51:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:51:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:51:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:19 INFO - no previously-included directories found matching 'docs/_build' 03:51:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:51:19 INFO - Running setup.py install for pep8 03:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:19 INFO - no previously-included directories found matching 'docs/_build' 03:51:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:51:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:51:19 INFO - Cleaning up... 03:51:20 INFO - Return code: 0 03:51:20 INFO - Running post-action listener: _resource_record_post_action 03:51:20 INFO - Running post-action listener: _start_resource_monitoring 03:51:20 INFO - Starting resource monitoring. 03:51:20 INFO - ##### 03:51:20 INFO - ##### Running install step. 03:51:20 INFO - ##### 03:51:20 INFO - Running pre-action listener: _resource_record_pre_action 03:51:20 INFO - Running main action method: install 03:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:20 INFO - Reading from file tmpfile_stdout 03:51:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:20 INFO - Reading from file tmpfile_stdout 03:51:20 INFO - Output received: 03:51:20 INFO - Usage: mozinstall [options] installer 03:51:20 INFO - Options: 03:51:20 INFO - -h, --help show this help message and exit 03:51:20 INFO - -d DEST, --destination=DEST 03:51:20 INFO - Directory to install application into. [default: 03:51:20 INFO - "/builds/slave/test"] 03:51:20 INFO - --app=APP Application being installed. [default: firefox] 03:51:20 INFO - mkdir: /builds/slave/test/build/application 03:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:51:34 INFO - Reading from file tmpfile_stdout 03:51:34 INFO - Output received: 03:51:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:34 INFO - Running post-action listener: _resource_record_post_action 03:51:34 INFO - ##### 03:51:34 INFO - ##### Running run-tests step. 03:51:34 INFO - ##### 03:51:34 INFO - Running pre-action listener: _resource_record_pre_action 03:51:34 INFO - Running main action method: run_tests 03:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:34 INFO - Python 2.7.3 03:51:34 INFO - Return code: 0 03:51:34 INFO - grabbing minidump binary from tooltool 03:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:51:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:51:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:34 INFO - Return code: 0 03:51:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:51:35 INFO - Return code: 0 03:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test/build 03:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 03:51:35 INFO - Using env: {'DISPLAY': ':0', 03:51:35 INFO - 'HOME': '/home/cltbld', 03:51:35 INFO - 'LANG': 'en_US.UTF-8', 03:51:35 INFO - 'LANGUAGE': 'en_US:en', 03:51:35 INFO - 'LOGNAME': 'cltbld', 03:51:35 INFO - 'MAIL': '/var/mail/cltbld', 03:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:35 INFO - 'MOZ_NO_REMOTE': '1', 03:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:35 INFO - 'NO_EM_RESTART': '1', 03:51:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:35 INFO - 'PWD': '/builds/slave/test', 03:51:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:35 INFO - 'SHELL': '/bin/bash', 03:51:35 INFO - 'SHLVL': '1', 03:51:35 INFO - 'TERM': 'linux', 03:51:35 INFO - 'TMOUT': '86400', 03:51:35 INFO - 'USER': 'cltbld', 03:51:35 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831', 03:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:35 INFO - '_': '/tools/buildbot/bin/python'} 03:51:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 03:51:36 INFO - mozversion INFO | application_buildid: 20151211023735 03:51:36 INFO - mozversion INFO | application_changeset: 0dd42501bbe65904cf5a4f8b6e37408d60333045 03:51:36 INFO - mozversion INFO | application_display_name: Nightly 03:51:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:36 INFO - mozversion INFO | application_name: Firefox 03:51:36 INFO - mozversion INFO | application_remotingname: firefox 03:51:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:51:36 INFO - mozversion INFO | application_vendor: Mozilla 03:51:36 INFO - mozversion INFO | application_version: 45.0a1 03:51:36 INFO - mozversion INFO | platform_buildid: 20151211023735 03:51:36 INFO - mozversion INFO | platform_changeset: 0dd42501bbe65904cf5a4f8b6e37408d60333045 03:51:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:51:36 INFO - mozversion INFO | platform_version: 45.0a1 03:51:36 INFO - 2015-12-11 03:51:36,093 DEBUG : using testdate: 1449834696 03:51:36 INFO - 2015-12-11 03:51:36,093 DEBUG : actual date: 1449834696 03:51:36 INFO - 2015-12-11 03:51:36,141 INFO : starting webserver on 'localhost:42424' 03:51:36 INFO - 2015-12-11 03:51:36,142 INFO : Starting test suite talos-linux64-ix-056 03:51:36 INFO - 2015-12-11 03:51:36,142 INFO : Starting test dromaeo_css 03:51:36 INFO - 2015-12-11 03:51:36,143 DEBUG : operating with platform_type : linux_ 03:51:36 INFO - 2015-12-11 03:51:36,143 INFO : Initialising browser for dromaeo_css test... 03:51:36 INFO - 2015-12-11 03:51:36,157 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSTPYVL/profile http://localhost:42424/getInfo.html 03:51:40 INFO - 2015-12-11 03:51:40,938 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:51:40 INFO - 2015-12-11 03:51:40,938 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:51:40 INFO - 2015-12-11 03:51:40,938 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:51:40 INFO - 2015-12-11 03:51:40,938 DEBUG : BROWSER_OUTPUT: __metrics 03:51:41 INFO - 2015-12-11 03:51:41,055 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:51:41 INFO - 2015-12-11 03:51:41,136 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:51:42 INFO - 2015-12-11 03:51:42,476 INFO : Browser initialized. 03:51:42 INFO - 2015-12-11 03:51:42,476 INFO : Running cycle 1/1 for dromaeo_css test... 03:51:42 INFO - 2015-12-11 03:51:42,477 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSTPYVL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:51:54 INFO - 2015-12-11 03:51:54,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 143200256 03:51:54 INFO - 2015-12-11 03:51:54,488 DEBUG : BROWSER_OUTPUT: 03:52:45 INFO - 2015-12-11 03:52:45,992 DEBUG : BROWSER_OUTPUT: 1449834765990 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:54:57 INFO - 2015-12-11 03:54:57,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42424/tests/dromaeo/cssquery-ext.html) 03:54:59 INFO - 2015-12-11 03:54:59,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 272637952 03:54:59 INFO - 2015-12-11 03:54:59,150 DEBUG : BROWSER_OUTPUT: 03:58:01 INFO - 2015-12-11 03:58:01,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-ext.html (next: http://localhost:42424/tests/dromaeo/cssquery-jquery.html) 03:58:02 INFO - 2015-12-11 03:58:02,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 231288832 03:58:02 INFO - 2015-12-11 03:58:02,361 DEBUG : BROWSER_OUTPUT: 04:01:04 INFO - 2015-12-11 04:01:04,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42424/tests/dromaeo/cssquery-mootools.html) 04:01:05 INFO - 2015-12-11 04:01:05,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 213422080 04:01:05 INFO - 2015-12-11 04:01:05,038 DEBUG : BROWSER_OUTPUT: 04:04:07 INFO - 2015-12-11 04:04:07,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42424/tests/dromaeo/cssquery-prototype.html) 04:04:07 INFO - 2015-12-11 04:04:07,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 207675392 04:04:07 INFO - 2015-12-11 04:04:07,579 DEBUG : BROWSER_OUTPUT: 04:07:10 INFO - 2015-12-11 04:07:10,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42424/tests/dromaeo/cssquery-yui.html) 04:07:11 INFO - 2015-12-11 04:07:11,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 210051072 04:07:11 INFO - 2015-12-11 04:07:11,051 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-yui.html (next: http://localhost:42424/tests/dromaeo/cssquery-dojo.html) 04:10:13 INFO - 2015-12-11 04:10:13,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 271405056 04:10:13 INFO - 2015-12-11 04:10:13,969 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,970 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:10:13 INFO - 2015-12-11 04:10:13,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:10:13 INFO - 2015-12-11 04:10:13,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:10:13 INFO - 2015-12-11 04:10:13,971 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:10:13 INFO - 2015-12-11 04:10:13,974 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2614.0981361430304;2701.176141276911;2706.5940108983636;2718.1166121010665;2718.3883626184106;4479.238529449994;4569.543045695437;4654.6276297896175;4719.882002949928;4756.857294281169;4571.428571428563;4626.8380606678775;4750.548697873705;4764.118638051963;4808.591269742076;4267.530571637118;4353.194658988097;4390.429244198258;4391.516933137353;4403.779811009453;4304.7632380219075;4337.566243375669;4407.096545208241;4443.933340999887;4459.44256967879;4136.834526618932;4400.7579583122915;4421.557844215585;4463.6429085673235;4518.932216016746;4256.638185754215;4293.592108749664;4357.041450880801;4358.346248062784;4358.869233922987;4264.296391095466;4272.145570885836;4300.526942036374;4310.762908040057;4330.090680957002;4391.49497807753;4497.392851965008;4548.681592288541;4573.908521829545;4579.038401935598;4894.119058569456;4934.037862616791;4959.156943319645;4980.82567110153;5014.52362025607;5012.373453318335;5032.84901452957;5046.369203849519;5056.216286475602;5113.233015047773;4467;4581.79381927814;4698.483166851644;4699.459562150328;4703.341532185496;5024.036901511073;5042.042012017705;5059;5062.544371006627;5196.142636464941;4963.751812409365;4987.10232158215;4990.126727822617;5013.323201367769;5015.774290156952;5084.46613105626;5089.923651145235;5094.057599344133;5096.286519887219;5142.588592912558;4798.328234047236;4857.635677324215;5029.044481548494;5038.874028149252;5050.292958985671;4792.976035119872;4916.70499770015;4939.407271127416;4945.23348880924;4957.7769000395065;4173.749575025508;4186.706930514895;4195.49654041517;4198.8110535026;4235.216484950294;3682.747865725666;3685.539307586552;3688.7417880748626;3695.3902606070237;3712.2575484903127;4136.544980052252;4236.533981262059;4238.3430568261965;4245.957540424618;4340.631046361032;5015.122353588181;5022.472640372781;5038.848834534897;5049.192129259301;5051.217061355495;4329.307310830252;4332.891677708019;4333.393324934512;4333.674974376871;4374.321980093091;4219.578042195756;4311.094670119247;4316.093620339764;4328.956710432918;4414.249577571821;4785.760711964388;4798.424189097331;4813.278008298783;4818.783154757974;4871.610271178226;5053.595712343077;5056.064628043824;5057.898842023065;5058.924116138187;5101.081805274937;4632.536746325341;4634.536546345338;4726.432828060517;4745.027269409694;4750.406199225097;4940.9505904941925;4965.677230979974;4971.527704868032;4975.104481193275;5019.3976722793495;5001.424836143745;5033.672811267256;5037.596992240538;5041.773120209526;5089.720065396439;4652.674312798072;4762.714237145782;4767.475577686382;4768.523147685204;4887.731174785421;4893.192623217272;4934.481879402754;4944.134776414185;4948.406191257072;4981.501849815135;4830.492798256273;4833.130036593447;4833.595485981159;4852.975735121443;4881.90236195267;4757.476677565534;4853.199222128309;4856.660033797601;4857.028594281087;4868.878278043077;4694.835680751157;4751.287306903992;4843.903121937612;4851.417829860439;4886.511348865085 04:10:13 INFO - 2015-12-11 04:10:13,975 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.3637998201978;581.1399129288652;582.4437662032759;583.2476105823488;586.0359708279877;26969;35623.821880890595;36054.81972590133;36211.818940905294;36309.81845090778;40624.593754062524;41325.17349653013;41457.58542414575;41468.58531414685;41583.79208103955;6929.995150703145;7041.0494583231375;7878.330341920943;8052.798680032987;8054.798630034237;10182.694519164437;10431.113355364803;10438.321509101923;10442.791144177112;10472.738181545446;10115.039071288253;10206.591736330538;10207.795844083113;10229.079382855578;10230.23273254509;6998.3001699829865;7154.928450715478;7176.3541281284415;7196.496245262833;10127.189824813997;6902.516823822334;10121.949390253076;10445.216608754297;10466.842997355046;10479.79040419195;37719.05702357463;37882;38012.23975520474;38051.80974095112;38135.61864381348;2725.046233818168;2749.2164733050986;2788.876458366622;2890.56641503774;3161.2096975756062;28792.745700490945;29332.706672933426;29391.2652183695;29532.557011644843;29724.851375743197;3287.375398674244;3316.9004929852144;3359.0762540301366;3376.5610470638903;3455.550778398792;212083;212151;212433;212641;213102;56601.43398566044;56912;56920.146197807066;57035.429645703014;57109.42890571124;50851.728706782626;52758.208626870626;53021.734891326065;53198.73400632972;61334.38665613287;12793.36033198355;13268.203907765565;13275.66810829737;13284.800727989088;13318.467261309439;9239.953800230956;9260.953695231481;9291;9315;9331.393459425115;19327.05142136944;19538.97145942381;19564.21743130259;19644.508887277647;19718.8028119717;7517.661705223169;7567.621618919032;7607.885881711779;7690.730824421118;7693.307602315706;816.4815342257709;844.4890841041082;974.2741657465092;1013.3514550687565;1022.4172221833633;26294;26730.465390692076;27056.729432705815;27062.188134356;28971;868.1795703060548;907.9863802042975;936.3539157980971;936.8922573904089;1033.963811266602;12424.881760641585;12709.682257943441;12716.237025778482;12720.554780582821;12723.55467558631;252004;254679;256143;256782;257866;45948.54051459509;46085.30872036922;46299.53700462952;46339;46558.5344146561;1174.3541052421135;1196.1148749925167;1200.5257923120319;1201.7656556971306;1206.324458303353;23814;25757.613635795104;27037.59443608387;27104.1868743938;27111.72888271092;36775.26449471049;37177.07057323481;37509.4373584391;37547.06132346713;37636.2472750538;226454;231524;232572;233030;233070;25809.870950645127;26239;26372.736272637027;26684.599731003662;26702.732972670026;38002;38580;38805.2238955225;39122.608773911896;39225;29635.259118522208;29743.702562974093;29935.55096673595;32788;34311.82844085863;31104.22239444032;31925.840370797996;32980;32986.84546040973;33032;29843.10470685883;29981.250468738457;30208.848955755082;30232.244193895327;30238;28320.858395707888;29060.854695726386;30668.84665576747;31054.22364440817;32902.8170630109;22957.196498122485;23495.295141145794;23507.647385288892;23528.6470702943;24074 04:10:13 INFO - 2015-12-11 04:10:13,978 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.2684553713524;335.09691381726225;335.59393134307487;336.40120585358056;338.4381926002835;12358.134930554865;12799.48802047917;14764.630884227887;15199.772003419943;16091.034537927719;8172.060213075498;9986.800263994715;10276.434796086212;13610.251436171007;14799.926000369984;4619;4728.40894888139;4730.479647238818;4733.952660473403;4735.289706544028;3503;3628.183658676803;4999.700017998914;5088.821891233808;5276.868078298054;5148.974255128738;5167.7932882684645;5185.066687996159;5222.112240919053;5226.42509323976;5061.569766569827;5138.974305128488;5144.8938478227365;5153.742312884378;5177.48225177483;4918.213085906238;4918.360613120271;4918.631102667278;4927.901441971177;4928.285398617216;11942.880571194264;13012.47950082005;17765.822341776548;19373.450123990046;19406.1267242973;1809.9276328603676;1817.9454616361531;1827.607064481143;1835.8806677565915;1856.3873921605837;9017.458952462874;9239.72280831576;9249.306302027375;11366.545338186463;12370.62888113358;1685.073209734641;1700.9659806803918;1702.319072371049;1763.8941663500102;1780.287884846059;49909.50090499085;50436.49563504392;51998.740006299726;53918.191227131625;56254.718726406514;9519.904800952041;9808.31341806081;9954;9962.750931226778;10024.548895299584;12511.74976500465;12534.81197782034;12560.560380386643;12565.497380104876;12577.056720745797;6917.412019978358;6953.965230173817;6965.930340696629;6985.720571177198;6991.265917078736;6548.050532672831;6557.409833115043;6595.604263744191;6599.977003564455;6608.00879868014;4233.703640745119;4260.0840819223395;4277.059047009653;4293.420388247547;4316.848910288125;1663.8336166383508;1684.6967545841867;1691.9577010574835;1722.3282919661342;1749.9737503937451;789.455275859655;799.9880001799978;815.5106935838568;943.6319835264252;983.3264214013424;15471.303791329417;16633.0851803152;16663.583410414838;17133;17225.22486488111;728.1953441447231;797.4776521378507;811.9675212991532;838.4508147163617;921.5162039929091;8240.175982401712;8586;8711.869321960176;8739.475631462132;8981;476454;486816;488925;491493;496546;68251.65874170598;72037.2796272041;72432;72532.63733681403;73635.26364736391;1035.637526865591;1038.984415233757;1053.3574519543072;1073.350622873166;1076.5962763963514;14349.928250358682;14530.273486325852;14544.345504452536;14786.63033424173;15114.773278401053;33818.154546136546;33972.66027339695;34139.31721365608;34981.30037399187;35013.47479787754;42593.36109958415;42970.57029429666;44716.77641611771;45806;46293.305600416694;8757.60590773404;8883.156100170474;8905.73282801517;8966.596503157243;12874.485020599072;16732.832671673128;17041.18820394621;17199.65600687954;17211.139443027547;17699.64600707953;14861.92569037148;15284.388624454898;15724.371025159324;15806.60483487922;15833.920830396235;13982.720345592828;14643.414263429344;14737.410503579737;14742.11547307165;14754.114753114847;10918.727031824268;13648;14666.85333146655;14852.108873467194;15668.451604193799;13002.609921702364;13003.544875929298;13193.670158246121;13215.801762973371;13258.80111798343;13380.531681391105;13703.314834258446;13737.656558586115;13776.448942042207;13924.4430222794 04:10:13 INFO - 2015-12-11 04:10:13,979 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1255.7488502299532;1628.2998310726387;1696.711559034964;1702.8893121947071;1731.9134043297831;5910.0839369897685;6736.629485378302;6923.896141557874;6929.3763561279475;6939.514234003609;6846;6966.756163534277;6984.755533556327;7007.229204787469;7033.8944915826305;1742.4946765438071;1769.2480695704273;1935.5838494723632;1974.8123928226833;2017.2132868181347;1991.5519008223107;2002.5994801039778;2009.6382651122792;2011.7083022961663;2014.2345908554728;1972.901354932255;1990.542175299682;2060.9484762880898;2062.8143467087957;2063.5769667218183;2032.7255820464343;2049.139361468187;2076.1384025629345;2080.0847627044054;2082.125507286943;1986.6225417170835;2016.0726066009654;2019.2024150460634;2019.8081182287658;2023.4435530229305;6962.582245065312;7033.226345102034;7033.964830175816;7061.929380706179;7064;4034.273830710471;4130.008797888515;4131.35963925592;4131.710780245384;4135.97932010341;2538.2765911715073;2595.4679290745353;2617.214835549347;2624.160268713993;2634.802389820771;845.1379592815356;859.621766422772;862.560094351885;870.3515880668879;875.0724232313704;9253.02843201461;9286;9287;9292.860607090899;9302.674406395812;3730.3658378075793;3799.430085487199;3826.349520581508;3828.693704503633;3838.7504812187117;8161.918380816234;8170.468919520212;8174.918250817415;8179.877301840477;8195.836083278302;4152.273352163359;4167.395727619478;4169.583041695806;4176;4176.102138040336;3783.621637836194;3820.503334566489;3823.5088315556955;3825.9808700956874;3833;2975.702429757007;3009.8344591047266;3339.1652086978256;3352.7485438592203;3412.6587341265677;1044.6813721814767;1045.3780000899453;1050.695298363466;1062.1555863088863;1073.0717928991521;932.2914584915513;932.4638332958576;980.7106903463352;1044.8119338518989;1210.6186551236333;6559.967200164064;6587.670616469158;6598.505112116611;6605.042268871083;6620.966895165493;1045.0907710291942;1046.4767616191905;1078.1751959750798;1080.2006515178712;1091.6343025086526;4839.806407743651;4894.95105048945;4896.167651499253;4900.681455705368;4901.240307752304;7939.841203175904;8216.876746848802;8319.916800832036;8329.33365330772;8430.536320502308;8136;8235.094139644634;8236.382271329674;8237.546934918517;8245.587720613945;6450.77422290227;6487.35126487357;6501.349865013461;6511.544191906616;6570.8028759137305;6224;6256.968715156395;6286.779962701284;6292.2134733158355;6303.054541818764;7402.148752893271;7427.257274272745;7502.174760776419;7551.471397002157;7554.395648348229;7491.550506969599;7499.925000749922;7652.311291983749;7906.9209307906185;7926.643301051351;5949.732262048132;6025.307089684742;6043.576949613484;6044.24446944132;6044.395560444096;5449.073657478159;5596.1605759136455;6426.518011149089;6686.097376854257;6719.731210751711;6129.295131059806;6158.846028849314;6208.81373558794;6252.343503932022;6327.651979141007;6180.072989051679;6209;6252.968735156295;6257.561970662192;6311.27420346666;6323.557350985387;6339.778107766206;6344.397282258178;6354.586951848115;6375;5891.263592050994;5919.112133180058;5922.585419020627;5925.585209035326;5932.466078052996;5814.30228372598;5874.412558744091;5881.264841894763;5884.735186916513;5898.498627616701 04:10:13 INFO - 2015-12-11 04:10:13,981 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.2173620289783;317.58872260422754;323.3839535684519;325.5767502247079;326.49067454770545;5289.100852855015;5336.866578335539;5345.518903298703;5354.732263386834;5373.140297552392;5256.842294731155;5257.947420525794;5282.339707536558;5285.920711189326;5290.0477913975465;4160.687948403866;4165.291900376943;4166.333386658135;4168.854090106847;4181.853635122771;3905.258000979805;4048.109415928491;4172.520160181588;4182.079942412664;4195.223883581547;3963.5838236985132;3998.1403998140395;3999.4800675912093;4002.2195671844;4124.835006599747;4082.2447847148223;4090.427340172393;4132.876013719563;4134.00783811883;4136.834526618932;3654.1230104774927;3657.2685462907257;3658.1220507078374;3658.5609726832686;3662.414013757786;4872.317875497433;5011.799528018875;5063.518965698289;5127.154019586801;5128.8461346159675;4701.318308845232;4715.24556071027;4717.622590192776;4721.693089949143;4731.834385796515;5554.19464177696;5600.215969764236;5606.411326810667;5609.0184217762135;5615.606907516475;3865.381538953754;3938.1532970411213;3943.4479172915817;3943.7830919299427;3947.782871942042;5846.210761547221;5855.560832937546;5855.590108692393;5862.355140934494;5864.560157988125;4125.422440858282;4132.752034877917;4132.91734165315;4133.855315063958;4137.110521237948;3950.802459877052;4069.1658210066867;4080.3063479208604;4185.874423767292;4202.600752928467;4707.105649926503;4720.811167553328;4730.739809310521;4731.668783185213;4737.8104875805275;5534.308211473566;5570.888582228333;5577.609567330329;5580.693061881636;5585.3297604287745;1453.4767483705857;1487.8512148785035;1488.151753500516;1488.3228131200278;1488.8064551608438;1029.2846471702244;1032.055669062799;1036.9066783989476;1048.9685309440729;1060.81966065769;4859.125357435625;4869.464358920516;4873.463918968911;4881.438634557;4884.389451318585;5759.884802303931;5765.971170144207;5766.106253530709;5771.163181338682;5776.191333213354;4859.246816743411;4869.513048695102;4870.342503762017;4871.196252618349;4873.731944743002;3028.8637011334545;3076.1694342527394;3100.5349197620085;3105.223694076481;3119.7036281553214;5490.780368785284;5512.641678290898;5518.310211223597;5522.171674248895;5532.363778165482;6001.579889407787;6004.6097003695495;6010.849728756816;6011.939880601226;6011.969940150271;5485.341758988947;5490.615656904059;5505.091659876156;5508.228847961209;5516.420775818561;5674.290713660793;5808.883822323614;5809.157672137601;5813.069908814569;5819.272590926134;5687.971560142173;5700.914486282792;5701.771929122789;5712.714364281853;5730.369659337553;5490.917636235539;5491.917621235605;5493.450654934474;5495.807646732345;5507.421720719267;3931.5675275719077;3963.1875465530075;3996.620321069494;4003.099302656879;4046.109855831712;5503.669779813224;5646.689432081111;5809.535237180931;5812.476877081083;5816.156657284755;5384.596155288291;5448.155535891943;5488.862778430571;5489;5497.890042199214;5585.944140558542;5587.804426845041;5593.216949627137;5597.328320601554;5606.411326810626;5331.813386531453;5461.235427040297;5461.317335333083;5464.207689885024;5469.261649677402;5585.5531557476115;5613.326400831763;5636.915446268227;5639.577031722555;5652;5504.669719816824;5509.5041446270025;5510.614257001971;5511.889762204813;5513.365962914316 04:10:13 INFO - 2015-12-11 04:10:13,984 DEBUG : BROWSER_OUTPUT: |5;yui.html;611.9938800611992;678.304737643915;685.7497013590041;686.2622680618333;797.772634799082;11613.070954323655;11916.165868389216;11923.344216068113;11957.521699132047;11960.34218118003;11420.714482137952;12120;12143.635690929264;12156.149069565134;12181;633.866887953528;640.270092095012;801.4710291207804;808.4906508899385;817.3134566963749;801.2708435323857;809.7935026568217;811.8051667599792;815.2947700239309;817.480899628737;851.748734123432;854.9487030778142;861.1431625532604;861.1861790607878;861.1990848510883;658.9538732288742;668.1914882991586;841.1294310388719;842.2798507276252;844.1937949258444;631.7346714379971;632.8417895526119;633.0283015571076;633.6103296472683;635.5106567942659;11806.409679516075;11919.880801191965;11948.462319195656;11950.760984780343;11980;10903;11428.458247504335;11579.53681852725;11608.129390295762;11612.361320127475;9025.187733104052;9143.177114059767;9159.084091590788;9214.953925230398;9288.53557322138;3184.538241954927;3238.935221295561;3247.431699452586;3271.9672803272138;3321.7342612590933;37267;37274.695385661646;37312.81343593292;37377.58025086347;37390.81304593487;8856.202941735275;9108.271338292921;9187.908120918839;9478.431294122374;9671.806563868824;16560.420385286456;16641.16794160287;16704.74942875858;16795.748063779054;16797.160141992852;6280.654563999024;6329.936700632935;6349.587276826992;6410.8076757697345;6449.161608990801;3481.9825900870333;3543.831468465161;3594.4967704521387;3605.837737301828;3607.639236076371;2686.8849427487767;2726.877290521931;2736.1107640017076;2736.151792944194;2738.3564862257354;470.34359837607957;472.518031607765;472.962163026957;484.13098488213035;484.1478996965296;448.854122410218;473.3160582957662;487.41023361731993;525.8422473258083;537.4088502647057;7865.842683146419;8045.557494337868;8168.509889406536;8255.42212045151;8333.208345207195;442.6237697956711;486.83690963527613;500.0948283606684;554.2683657571966;562.8424041268452;3397.1676939150066;3428.245785927092;3471.1148657092785;3518.665726755954;3549.698275646599;43356;46175.53824461712;46186.538134618895;46208.07583848372;46220.537794621625;40315.395269070985;40905.59094409077;41743.582564174576;41819.1636167281;41877.581224187976;37602.43596346057;37860.81069594689;38163.61836381656;38292.61707382946;38670.03324916843;7342.6695798688115;7473.588952607659;7676.769696909102;7756.379489640703;7889.289963903277;30396.696033039385;30805;30959.0712278632;31858.522122167724;32787.18032049218;36715.44926826046;37232;37603.62396376111;38112.42831357476;38186.42720359141;9290.814183716422;9470.289728270545;9886.703398898044;10121.493925303557;10121.544530495998;11010.50452729645;11145.609903653332;11285.548578056785;11418;11472.139589530652;9717.9028209717;10015.098641122335;10042.246831487522;10550.261481696207;10574.10120139766;10530.684079477627;10846.783064338511;11092.611758588411;11131.387773672526;11217.775644487228;8266.338692904674;9882.160016398686;9914.553845076845;10055.095041446304;10375.948120259653;8089.47418417801;8449.493030418194;8575.31397488212;8810.603522841615;8871.778205544913;7083.468739844635;8665.913340866511;8788.38481306328;8812.691555795516;9002.414843035182 04:10:13 INFO - 2015-12-11 04:10:13,985 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:10:13 INFO - 2015-12-11 04:10:13,985 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:10:13 INFO - 2015-12-11 04:10:13,985 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1109 04:10:13 INFO - 2015-12-11 04:10:13,985 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:10:13 INFO - 2015-12-11 04:10:13,986 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835813970__endTimestamp 04:10:13 INFO - 2015-12-11 04:10:13,986 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,986 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:10:13 INFO - 2015-12-11 04:10:13,986 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:10:13 INFO - 2015-12-11 04:10:13,987 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,987 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4624.45 Median:4762.71 stddev:481.86 (10.1%) stddev-sans-first:456.80 04:10:13 INFO - 2015-12-11 04:10:13,987 DEBUG : BROWSER_OUTPUT: Values: 2614.1 2701.2 2706.6 2718.1 2718.4 4479.2 4569.5 4654.6 4719.9 4756.9 4571.4 4626.8 4750.5 4764.1 4808.6 4267.5 4353.2 4390.4 4391.5 4403.8 4304.8 4337.6 4407.1 4443.9 4459.4 4136.8 4400.8 4421.6 4463.6 4518.9 4256.6 4293.6 4357.0 4358.3 4358.9 4264.3 4272.1 4300.5 4310.8 4330.1 4391.5 4497.4 4548.7 4573.9 4579.0 4894.1 4934.0 4959.2 4980.8 5014.5 5012.4 5032.8 5046.4 5056.2 5113.2 4467.0 4581.8 4698.5 4699.5 4703.3 5024.0 5042.0 5059.0 5062.5 5196.1 4963.8 4987.1 4990.1 5013.3 5015.8 5084.5 5089.9 5094.1 5096.3 5142.6 4798.3 4857.6 5029.0 5038.9 5050.3 4793.0 4916.7 4939.4 4945.2 4957.8 4173.7 4186.7 4195.5 4198.8 4235.2 3682.7 3685.5 3688.7 3695.4 3712.3 4136.5 4236.5 4238.3 4246.0 4340.6 5015.1 5022.5 5038.8 5049.2 5051.2 4329.3 4332.9 4333.4 4333.7 4374.3 4219.6 4311.1 4316.1 4329.0 4414.2 4785.8 4798.4 4813.3 4818.8 4871.6 5053.6 5056.1 5057.9 5058.9 5101.1 4632.5 4634.5 4726.4 4745.0 4750.4 4941.0 4965.7 4971.5 4975.1 5019.4 5001.4 5033.7 5037.6 5041.8 5089.7 4652.7 4762.7 4767.5 4768.5 4887.7 4893.2 4934.5 4944.1 4948.4 4981.5 4830.5 4833.1 4833.6 4853.0 4881.9 4757.5 4853.2 4856.7 4857.0 4868.9 4694.8 4751.3 4843.9 4851.4 4886.5 04:10:13 INFO - 2015-12-11 04:10:13,987 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,987 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39468.00 Median:30220.55 stddev:60755.53 (201.0%) stddev-sans-first:60855.80 04:10:13 INFO - 2015-12-11 04:10:13,988 DEBUG : BROWSER_OUTPUT: Values: 578.4 581.1 582.4 583.2 586.0 26969.0 35623.8 36054.8 36211.8 36309.8 40624.6 41325.2 41457.6 41468.6 41583.8 6930.0 7041.0 7878.3 8052.8 8054.8 10182.7 10431.1 10438.3 10442.8 10472.7 10115.0 10206.6 10207.8 10229.1 10230.2 6998.3 7154.9 7176.4 7196.5 10127.2 6902.5 10121.9 10445.2 10466.8 10479.8 37719.1 37882.0 38012.2 38051.8 38135.6 2725.0 2749.2 2788.9 2890.6 3161.2 28792.7 29332.7 29391.3 29532.6 29724.9 3287.4 3316.9 3359.1 3376.6 3455.6 212083.0 212151.0 212433.0 212641.0 213102.0 56601.4 56912.0 56920.1 57035.4 57109.4 50851.7 52758.2 53021.7 53198.7 61334.4 12793.4 13268.2 13275.7 13284.8 13318.5 9240.0 9261.0 9291.0 9315.0 9331.4 19327.1 19539.0 19564.2 19644.5 19718.8 7517.7 7567.6 7607.9 7690.7 7693.3 816.5 844.5 974.3 1013.4 1022.4 26294.0 26730.5 27056.7 27062.2 28971.0 868.2 908.0 936.4 936.9 1034.0 12424.9 12709.7 12716.2 12720.6 12723.6 252004.0 254679.0 256143.0 256782.0 257866.0 45948.5 46085.3 46299.5 46339.0 46558.5 1174.4 1196.1 1200.5 1201.8 1206.3 23814.0 25757.6 27037.6 27104.2 27111.7 36775.3 37177.1 37509.4 37547.1 37636.2 226454.0 231524.0 232572.0 233030.0 233070.0 25809.9 26239.0 26372.7 26684.6 26702.7 38002.0 38580.0 38805.2 39122.6 39225.0 29635.3 29743.7 29935.6 32788.0 34311.8 31104.2 31925.8 32980.0 32986.8 33032.0 29843.1 29981.3 30208.8 30232.2 30238.0 28320.9 29060.9 30668.8 31054.2 32902.8 22957.2 23495.3 23507.6 23528.6 24074.0 04:10:13 INFO - 2015-12-11 04:10:13,988 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,989 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26500.75 Median:34997.39 stddev:79667.74 (227.6%) stddev-sans-first:79866.99 04:10:13 INFO - 2015-12-11 04:10:13,989 DEBUG : BROWSER_OUTPUT: Values: 330.3 335.1 335.6 336.4 338.4 12358.1 12799.5 14764.6 15199.8 16091.0 8172.1 9986.8 10276.4 13610.3 14799.9 4619.0 4728.4 4730.5 4734.0 4735.3 3503.0 3628.2 4999.7 5088.8 5276.9 5149.0 5167.8 5185.1 5222.1 5226.4 5061.6 5139.0 5144.9 5153.7 5177.5 4918.2 4918.4 4918.6 4927.9 4928.3 11942.9 13012.5 17765.8 19373.5 19406.1 1809.9 1817.9 1827.6 1835.9 1856.4 9017.5 9239.7 9249.3 11366.5 12370.6 1685.1 1701.0 1702.3 1763.9 1780.3 49909.5 50436.5 51998.7 53918.2 56254.7 9519.9 9808.3 9954.0 9962.8 10024.5 12511.7 12534.8 12560.6 12565.5 12577.1 6917.4 6954.0 6965.9 6985.7 6991.3 6548.1 6557.4 6595.6 6600.0 6608.0 4233.7 4260.1 4277.1 4293.4 4316.8 1663.8 1684.7 1692.0 1722.3 1750.0 789.5 800.0 815.5 943.6 983.3 15471.3 16633.1 16663.6 17133.0 17225.2 728.2 797.5 812.0 838.5 921.5 8240.2 8586.0 8711.9 8739.5 8981.0 476454.0 486816.0 488925.0 491493.0 496546.0 68251.7 72037.3 72432.0 72532.6 73635.3 1035.6 1039.0 1053.4 1073.4 1076.6 14349.9 14530.3 14544.3 14786.6 15114.8 33818.2 33972.7 34139.3 34981.3 35013.5 42593.4 42970.6 44716.8 45806.0 46293.3 8757.6 8883.2 8905.7 8966.6 12874.5 16732.8 17041.2 17199.7 17211.1 17699.6 14861.9 15284.4 15724.4 15806.6 15833.9 13982.7 14643.4 14737.4 14742.1 14754.1 10918.7 13648.0 14666.9 14852.1 15668.5 13002.6 13003.5 13193.7 13215.8 13258.8 13380.5 13703.3 13737.7 13776.4 13924.4 04:10:13 INFO - 2015-12-11 04:10:13,989 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,989 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4838.29 Median:5987.52 stddev:2492.47 (41.6%) stddev-sans-first:2484.91 04:10:13 INFO - 2015-12-11 04:10:13,989 DEBUG : BROWSER_OUTPUT: Values: 1255.7 1628.3 1696.7 1702.9 1731.9 5910.1 6736.6 6923.9 6929.4 6939.5 6846.0 6966.8 6984.8 7007.2 7033.9 1742.5 1769.2 1935.6 1974.8 2017.2 1991.6 2002.6 2009.6 2011.7 2014.2 1972.9 1990.5 2060.9 2062.8 2063.6 2032.7 2049.1 2076.1 2080.1 2082.1 1986.6 2016.1 2019.2 2019.8 2023.4 6962.6 7033.2 7034.0 7061.9 7064.0 4034.3 4130.0 4131.4 4131.7 4136.0 2538.3 2595.5 2617.2 2624.2 2634.8 845.1 859.6 862.6 870.4 875.1 9253.0 9286.0 9287.0 9292.9 9302.7 3730.4 3799.4 3826.3 3828.7 3838.8 8161.9 8170.5 8174.9 8179.9 8195.8 4152.3 4167.4 4169.6 4176.0 4176.1 3783.6 3820.5 3823.5 3826.0 3833.0 2975.7 3009.8 3339.2 3352.7 3412.7 1044.7 1045.4 1050.7 1062.2 1073.1 932.3 932.5 980.7 1044.8 1210.6 6560.0 6587.7 6598.5 6605.0 6621.0 1045.1 1046.5 1078.2 1080.2 1091.6 4839.8 4895.0 4896.2 4900.7 4901.2 7939.8 8216.9 8319.9 8329.3 8430.5 8136.0 8235.1 8236.4 8237.5 8245.6 6450.8 6487.4 6501.3 6511.5 6570.8 6224.0 6257.0 6286.8 6292.2 6303.1 7402.1 7427.3 7502.2 7551.5 7554.4 7491.6 7499.9 7652.3 7906.9 7926.6 5949.7 6025.3 6043.6 6044.2 6044.4 5449.1 5596.2 6426.5 6686.1 6719.7 6129.3 6158.8 6208.8 6252.3 6327.7 6180.1 6209.0 6253.0 6257.6 6311.3 6323.6 6339.8 6344.4 6354.6 6375.0 5891.3 5919.1 5922.6 5925.6 5932.5 5814.3 5874.4 5881.3 5884.7 5898.5 04:10:13 INFO - 2015-12-11 04:10:13,990 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,991 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4642.45 Median:5257.39 stddev:1348.01 (25.6%) stddev-sans-first:1312.10 04:10:13 INFO - 2015-12-11 04:10:13,991 DEBUG : BROWSER_OUTPUT: Values: 316.2 317.6 323.4 325.6 326.5 5289.1 5336.9 5345.5 5354.7 5373.1 5256.8 5257.9 5282.3 5285.9 5290.0 4160.7 4165.3 4166.3 4168.9 4181.9 3905.3 4048.1 4172.5 4182.1 4195.2 3963.6 3998.1 3999.5 4002.2 4124.8 4082.2 4090.4 4132.9 4134.0 4136.8 3654.1 3657.3 3658.1 3658.6 3662.4 4872.3 5011.8 5063.5 5127.2 5128.8 4701.3 4715.2 4717.6 4721.7 4731.8 5554.2 5600.2 5606.4 5609.0 5615.6 3865.4 3938.2 3943.4 3943.8 3947.8 5846.2 5855.6 5855.6 5862.4 5864.6 4125.4 4132.8 4132.9 4133.9 4137.1 3950.8 4069.2 4080.3 4185.9 4202.6 4707.1 4720.8 4730.7 4731.7 4737.8 5534.3 5570.9 5577.6 5580.7 5585.3 1453.5 1487.9 1488.2 1488.3 1488.8 1029.3 1032.1 1036.9 1049.0 1060.8 4859.1 4869.5 4873.5 4881.4 4884.4 5759.9 5766.0 5766.1 5771.2 5776.2 4859.2 4869.5 4870.3 4871.2 4873.7 3028.9 3076.2 3100.5 3105.2 3119.7 5490.8 5512.6 5518.3 5522.2 5532.4 6001.6 6004.6 6010.8 6011.9 6012.0 5485.3 5490.6 5505.1 5508.2 5516.4 5674.3 5808.9 5809.2 5813.1 5819.3 5688.0 5700.9 5701.8 5712.7 5730.4 5490.9 5491.9 5493.5 5495.8 5507.4 3931.6 3963.2 3996.6 4003.1 4046.1 5503.7 5646.7 5809.5 5812.5 5816.2 5384.6 5448.2 5488.9 5489.0 5497.9 5585.9 5587.8 5593.2 5597.3 5606.4 5331.8 5461.2 5461.3 5464.2 5469.3 5585.6 5613.3 5636.9 5639.6 5652.0 5504.7 5509.5 5510.6 5511.9 5513.4 04:10:13 INFO - 2015-12-11 04:10:13,991 DEBUG : BROWSER_OUTPUT: 04:10:13 INFO - 2015-12-11 04:10:13,991 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11770.40 Median:23312.20 stddev:12894.43 (55.3%) stddev-sans-first:12903.37 04:10:13 INFO - 2015-12-11 04:10:13,991 DEBUG : BROWSER_OUTPUT: Values: 612.0 678.3 685.7 686.3 797.8 11613.1 11916.2 11923.3 11957.5 11960.3 11420.7 12120.0 12143.6 12156.1 12181.0 633.9 640.3 801.5 808.5 817.3 801.3 809.8 811.8 815.3 817.5 851.7 854.9 861.1 861.2 861.2 659.0 668.2 841.1 842.3 844.2 631.7 632.8 633.0 633.6 635.5 11806.4 11919.9 11948.5 11950.8 11980.0 10903.0 11428.5 11579.5 11608.1 11612.4 9025.2 9143.2 9159.1 9215.0 9288.5 3184.5 3238.9 3247.4 3272.0 3321.7 37267.0 37274.7 37312.8 37377.6 37390.8 8856.2 9108.3 9187.9 9478.4 9671.8 16560.4 16641.2 16704.7 16795.7 16797.2 6280.7 6329.9 6349.6 6410.8 6449.2 3482.0 3543.8 3594.5 3605.8 3607.6 2686.9 2726.9 2736.1 2736.2 2738.4 470.3 472.5 473.0 484.1 484.1 448.9 473.3 487.4 525.8 537.4 7865.8 8045.6 8168.5 8255.4 8333.2 442.6 486.8 500.1 554.3 562.8 3397.2 3428.2 3471.1 3518.7 3549.7 43356.0 46175.5 46186.5 46208.1 46220.5 40315.4 40905.6 41743.6 41819.2 41877.6 37602.4 37860.8 38163.6 38292.6 38670.0 7342.7 7473.6 7676.8 7756.4 7889.3 30396.7 30805.0 30959.1 31858.5 32787.2 36715.4 37232.0 37603.6 38112.4 38186.4 9290.8 9470.3 9886.7 10121.5 10121.5 11010.5 11145.6 11285.5 11418.0 11472.1 9717.9 10015.1 10042.2 10550.3 10574.1 10530.7 10846.8 11092.6 11131.4 11217.8 8266.3 9882.2 9914.6 10055.1 10375.9 8089.5 8449.5 8575.3 8810.6 8871.8 7083.5 8665.9 8788.4 8812.7 9002.4 04:10:13 INFO - 2015-12-11 04:10:13,991 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:10:13 INFO - 2015-12-11 04:10:13,991 DEBUG : BROWSER_OUTPUT: 04:10:14 INFO - 2015-12-11 04:10:14,735 INFO : Browser exited with error code: 0 04:10:14 INFO - 2015-12-11 04:10:14,751 INFO : Completed test dromaeo_css (00:18:38) 04:10:14 INFO - 2015-12-11 04:10:14,751 INFO : Starting test kraken 04:10:14 INFO - 2015-12-11 04:10:14,751 DEBUG : operating with platform_type : linux_ 04:10:14 INFO - 2015-12-11 04:10:14,751 INFO : Initialising browser for kraken test... 04:10:14 INFO - 2015-12-11 04:10:14,758 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxC22qa/profile http://localhost:42424/getInfo.html 04:10:19 INFO - 2015-12-11 04:10:19,386 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:10:19 INFO - 2015-12-11 04:10:19,386 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:10:19 INFO - 2015-12-11 04:10:19,386 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:10:19 INFO - 2015-12-11 04:10:19,386 DEBUG : BROWSER_OUTPUT: __metrics 04:10:19 INFO - 2015-12-11 04:10:19,515 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:10:19 INFO - 2015-12-11 04:10:19,599 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:10:20 INFO - 2015-12-11 04:10:20,876 INFO : Browser initialized. 04:10:20 INFO - 2015-12-11 04:10:20,877 INFO : Running cycle 1/1 for kraken test... 04:10:20 INFO - 2015-12-11 04:10:20,877 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxC22qa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:10:32 INFO - 2015-12-11 04:10:32,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 142422016 04:10:32 INFO - 2015-12-11 04:10:32,852 DEBUG : BROWSER_OUTPUT: 04:10:35 INFO - 2015-12-11 04:10:35,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:36 INFO - 2015-12-11 04:10:36,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 180031488 04:10:36 INFO - 2015-12-11 04:10:36,116 DEBUG : BROWSER_OUTPUT: 04:10:38 INFO - 2015-12-11 04:10:38,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-dft) 04:10:39 INFO - 2015-12-11 04:10:39,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 168525824 04:10:39 INFO - 2015-12-11 04:10:39,434 DEBUG : BROWSER_OUTPUT: 04:10:42 INFO - 2015-12-11 04:10:42,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-fft) 04:10:43 INFO - 2015-12-11 04:10:43,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 153972736 04:10:43 INFO - 2015-12-11 04:10:43,042 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2015-12-11 04:10:45,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-oscillator) 04:10:45 INFO - 2015-12-11 04:10:45,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 155848704 04:10:45 INFO - 2015-12-11 04:10:45,668 DEBUG : BROWSER_OUTPUT: 04:10:47 INFO - 2015-12-11 04:10:47,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:48 INFO - 2015-12-11 04:10:48,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 157806592 04:10:48 INFO - 2015-12-11 04:10:48,540 DEBUG : BROWSER_OUTPUT: 04:10:51 INFO - 2015-12-11 04:10:51,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:52 INFO - 2015-12-11 04:10:52,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 157409280 04:10:52 INFO - 2015-12-11 04:10:52,162 DEBUG : BROWSER_OUTPUT: 04:10:55 INFO - 2015-12-11 04:10:55,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:56 INFO - 2015-12-11 04:10:56,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 158593024 04:10:56 INFO - 2015-12-11 04:10:56,192 DEBUG : BROWSER_OUTPUT: 04:10:59 INFO - 2015-12-11 04:10:59,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42424/tests/kraken/driver.html?testName=json-parse-financial) 04:10:59 INFO - 2015-12-11 04:10:59,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 157458432 04:10:59 INFO - 2015-12-11 04:10:59,632 DEBUG : BROWSER_OUTPUT: 04:11:01 INFO - 2015-12-11 04:11:01,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:02 INFO - 2015-12-11 04:11:02,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 167403520 04:11:02 INFO - 2015-12-11 04:11:02,008 DEBUG : BROWSER_OUTPUT: 04:11:03 INFO - 2015-12-11 04:11:03,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:04 INFO - 2015-12-11 04:11:04,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 167628800 04:11:04 INFO - 2015-12-11 04:11:04,501 DEBUG : BROWSER_OUTPUT: 04:11:06 INFO - 2015-12-11 04:11:06,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:07 INFO - 2015-12-11 04:11:07,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 179228672 04:11:07 INFO - 2015-12-11 04:11:07,201 DEBUG : BROWSER_OUTPUT: 04:11:09 INFO - 2015-12-11 04:11:09,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:10 INFO - 2015-12-11 04:11:10,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 182571008 04:11:10 INFO - 2015-12-11 04:11:10,334 DEBUG : BROWSER_OUTPUT: 04:11:12 INFO - 2015-12-11 04:11:12,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:13 INFO - 2015-12-11 04:11:13,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 180551680 04:11:13 INFO - 2015-12-11 04:11:13,504 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42424/tests/kraken/driver.html?testName=ai-astar) 04:11:15 INFO - 2015-12-11 04:11:15,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 239136768 04:11:15 INFO - 2015-12-11 04:11:15,548 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,550 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:11:15 INFO - 2015-12-11 04:11:15,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:11:15 INFO - 2015-12-11 04:11:15,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:11:15 INFO - 2015-12-11 04:11:15,550 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:11:15 INFO - 2015-12-11 04:11:15,552 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;106;112;113;113;101;112;111;112 04:11:15 INFO - 2015-12-11 04:11:15,552 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;132;152;162;134;161;149;129;168;129 04:11:15 INFO - 2015-12-11 04:11:15,552 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;165;164;164;164;164;163;163 04:11:15 INFO - 2015-12-11 04:11:15,552 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;84;93;73;74;72;116;90;73 04:11:15 INFO - 2015-12-11 04:11:15,552 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;136;95;96;95;137;96;97;132 04:11:15 INFO - 2015-12-11 04:11:15,552 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;110;110;110;111;110;109 04:11:15 INFO - 2015-12-11 04:11:15,552 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;147;147;147;147;146;147;150 04:11:15 INFO - 2015-12-11 04:11:15,553 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;95;96;96;96;95 04:11:15 INFO - 2015-12-11 04:11:15,553 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;73;72;74;74;74;82;75;71 04:11:15 INFO - 2015-12-11 04:11:15,553 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;68;69;68;69;68;68;67 04:11:15 INFO - 2015-12-11 04:11:15,553 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;84;85;84;85;82;83;85;81 04:11:15 INFO - 2015-12-11 04:11:15,553 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;118;125;117;127;119;127;118;120;119 04:11:15 INFO - 2015-12-11 04:11:15,553 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;153;148;147;147;140;146;146;145;138 04:11:15 INFO - 2015-12-11 04:11:15,553 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;69;68;69;70;69;71;69;71 04:11:15 INFO - 2015-12-11 04:11:15,554 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:11:15 INFO - 2015-12-11 04:11:15,554 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:11:15 INFO - 2015-12-11 04:11:15,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1027 04:11:15 INFO - 2015-12-11 04:11:15,554 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:11:15 INFO - 2015-12-11 04:11:15,554 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835875549__endTimestamp 04:11:15 INFO - 2015-12-11 04:11:15,554 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,562 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:11:15 INFO - 2015-12-11 04:11:15,562 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:11:15 INFO - 2015-12-11 04:11:15,562 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,562 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:4.22 04:11:15 INFO - 2015-12-11 04:11:15,562 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 106.0 112.0 113.0 113.0 101.0 112.0 111.0 112.0 04:11:15 INFO - 2015-12-11 04:11:15,562 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.50 stddev:14.79 (9.7%) stddev-sans-first:15.52 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: Values: 153.0 132.0 152.0 162.0 134.0 161.0 149.0 129.0 168.0 129.0 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 165.0 164.0 164.0 164.0 164.0 163.0 163.0 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.20 Median:74.00 stddev:14.20 (19.2%) stddev-sans-first:14.75 04:11:15 INFO - 2015-12-11 04:11:15,563 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 84.0 93.0 73.0 74.0 72.0 116.0 90.0 73.0 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.60 Median:96.00 stddev:18.96 (19.7%) stddev-sans-first:19.64 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 136.0 95.0 96.0 95.0 137.0 96.0 97.0 132.0 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 110.0 110.0 110.0 111.0 110.0 109.0 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,564 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 04:11:15 INFO - 2015-12-11 04:11:15,565 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 150.0 04:11:15 INFO - 2015-12-11 04:11:15,565 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,565 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:11:15 INFO - 2015-12-11 04:11:15,565 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 04:11:15 INFO - 2015-12-11 04:11:15,565 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,565 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:74.00 stddev:3.00 (4.1%) stddev-sans-first:3.15 04:11:15 INFO - 2015-12-11 04:11:15,565 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 72.0 74.0 74.0 74.0 82.0 75.0 71.0 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 69.0 68.0 69.0 68.0 68.0 67.0 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.43 (1.7%) stddev-sans-first:1.42 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 84.0 85.0 84.0 85.0 82.0 83.0 85.0 81.0 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,566 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:119.50 stddev:3.87 (3.2%) stddev-sans-first:4.04 04:11:15 INFO - 2015-12-11 04:11:15,567 DEBUG : BROWSER_OUTPUT: Values: 119.0 118.0 125.0 117.0 127.0 119.0 127.0 118.0 120.0 119.0 04:11:15 INFO - 2015-12-11 04:11:15,567 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,567 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:146.50 stddev:5.52 (3.8%) stddev-sans-first:4.39 04:11:15 INFO - 2015-12-11 04:11:15,567 DEBUG : BROWSER_OUTPUT: Values: 134.0 153.0 148.0 147.0 147.0 140.0 146.0 146.0 145.0 138.0 04:11:15 INFO - 2015-12-11 04:11:15,567 DEBUG : BROWSER_OUTPUT: 04:11:15 INFO - 2015-12-11 04:11:15,567 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.12 04:11:15 INFO - 2015-12-11 04:11:15,567 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 68.0 69.0 70.0 69.0 71.0 69.0 71.0 04:11:15 INFO - 2015-12-11 04:11:15,568 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:11:15 INFO - 2015-12-11 04:11:15,568 DEBUG : BROWSER_OUTPUT: 04:11:16 INFO - 2015-12-11 04:11:16,463 INFO : Browser exited with error code: 0 04:11:16 INFO - 2015-12-11 04:11:16,520 INFO : Completed test kraken (00:01:01) 04:11:16 INFO - 2015-12-11 04:11:16,520 INFO : Starting test v8_7 04:11:16 INFO - 2015-12-11 04:11:16,520 DEBUG : operating with platform_type : linux_ 04:11:16 INFO - 2015-12-11 04:11:16,520 INFO : Initialising browser for v8_7 test... 04:11:16 INFO - 2015-12-11 04:11:16,527 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPyiUM_/profile http://localhost:42424/getInfo.html 04:11:21 INFO - 2015-12-11 04:11:21,024 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:11:21 INFO - 2015-12-11 04:11:21,025 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:11:21 INFO - 2015-12-11 04:11:21,025 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:11:21 INFO - 2015-12-11 04:11:21,025 DEBUG : BROWSER_OUTPUT: __metrics 04:11:21 INFO - 2015-12-11 04:11:21,169 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:11:21 INFO - 2015-12-11 04:11:21,245 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:11:22 INFO - 2015-12-11 04:11:22,498 INFO : Browser initialized. 04:11:22 INFO - 2015-12-11 04:11:22,498 INFO : Running cycle 1/1 for v8_7 test... 04:11:22 INFO - 2015-12-11 04:11:22,498 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPyiUM_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:11:34 INFO - 2015-12-11 04:11:34,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 142848000 04:11:34 INFO - 2015-12-11 04:11:34,546 DEBUG : BROWSER_OUTPUT: 04:11:55 INFO - 2015-12-11 04:11:55,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42424/tests/v8_7/run.html (next: http://localhost:42424/tests/v8_7/run.html) 04:11:56 INFO - 2015-12-11 04:11:56,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 441729024 04:11:56 INFO - 2015-12-11 04:11:56,234 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,234 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:11:56 INFO - 2015-12-11 04:11:56,234 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:11:56 INFO - 2015-12-11 04:11:56,234 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:11:56 INFO - 2015-12-11 04:11:56,234 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:11:56 INFO - 2015-12-11 04:11:56,234 DEBUG : BROWSER_OUTPUT: |0;Richards;168.26518593303047 04:11:56 INFO - 2015-12-11 04:11:56,234 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.2147587511826 04:11:56 INFO - 2015-12-11 04:11:56,235 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 04:11:56 INFO - 2015-12-11 04:11:56,235 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 04:11:56 INFO - 2015-12-11 04:11:56,235 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2022.2222222222222 04:11:56 INFO - 2015-12-11 04:11:56,235 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 04:11:56 INFO - 2015-12-11 04:11:56,235 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 04:11:56 INFO - 2015-12-11 04:11:56,235 DEBUG : BROWSER_OUTPUT: |7;RegExp;27162.162162162163 04:11:56 INFO - 2015-12-11 04:11:56,235 DEBUG : BROWSER_OUTPUT: |8;Splay;629.4670846394985 04:11:56 INFO - 2015-12-11 04:11:56,236 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 04:11:56 INFO - 2015-12-11 04:11:56,236 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:11:56 INFO - 2015-12-11 04:11:56,236 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835916232__endTimestamp 04:11:56 INFO - 2015-12-11 04:11:56,236 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,236 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:11:56 INFO - 2015-12-11 04:11:56,237 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:11:56 INFO - 2015-12-11 04:11:56,237 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,237 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.27 Median:168.27 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,237 DEBUG : BROWSER_OUTPUT: Values: 168.3 04:11:56 INFO - 2015-12-11 04:11:56,237 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,237 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.21 Median:189.21 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: Values: 189.2 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: Values: 278.8 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: Values: 5154.6 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2022.22 Median:2022.22 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: Values: 2022.2 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: Values: 794.3 04:11:56 INFO - 2015-12-11 04:11:56,239 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: Values: 12382.7 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: Values: 27162.2 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:629.47 Median:629.47 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: Values: 629.5 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: Values: 4864.1 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:11:56 INFO - 2015-12-11 04:11:56,240 DEBUG : BROWSER_OUTPUT: 04:11:57 INFO - 2015-12-11 04:11:57,215 INFO : Browser exited with error code: 0 04:11:57 INFO - 2015-12-11 04:11:57,227 INFO : Completed test v8_7 (00:00:40) 04:11:57 INFO - 2015-12-11 04:11:57,244 INFO : Completed test suite (00:20:21) 04:11:57 INFO - 2015-12-11 04:11:57,244 DEBUG : Working with test: dromaeo_css 04:11:57 INFO - 2015-12-11 04:11:57,244 DEBUG : Generating results file: dromaeo_css 04:11:57 INFO - 2015-12-11 04:11:57,245 DEBUG : Working with test: kraken 04:11:57 INFO - 2015-12-11 04:11:57,246 DEBUG : Generating results file: kraken 04:11:57 INFO - 2015-12-11 04:11:57,246 INFO : javascript benchmark 04:11:57 INFO - 2015-12-11 04:11:57,246 DEBUG : Working with test: v8_7 04:11:57 INFO - 2015-12-11 04:11:57,246 DEBUG : Generating results file: v8_7 04:11:57 INFO - 2015-12-11 04:11:57,247 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:57 INFO - 2015-12-11 04:11:57,296 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:11:57 INFO - 2015-12-11 04:11:57,296 DEBUG : process_Request line: dromaeo_css 6263.09 graph.html#tests=[[72,94,35]] 04:11:57 INFO - 2015-12-11 04:11:57,296 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:57 INFO - 2015-12-11 04:11:57,333 DEBUG : process_Request line: kraken 1523.30 graph.html#tests=[[232,94,35]] 04:11:57 INFO - 2015-12-11 04:11:57,333 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:57 INFO - 2015-12-11 04:11:57,363 DEBUG : process_Request line: v8_7 19568.19 graph.html#tests=[[230,94,35]] 04:11:57 INFO - 2015-12-11 04:11:57,364 INFO : javascript benchmark 04:11:57 INFO - 2015-12-11 04:11:57,368 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.0981361430304, 2701.176141276911, 2706.5940108983636, 2718.1166121010665, 2718.3883626184106, 4479.238529449994, 4569.543045695437, 4654.6276297896175, 4719.882002949928, 4756.857294281169, 4571.428571428563, 4626.8380606678775, 4750.548697873705, 4764.118638051963, 4808.591269742076, 4267.530571637118, 4353.194658988097, 4390.429244198258, 4391.516933137353, 4403.779811009453, 4304.7632380219075, 4337.566243375669, 4407.096545208241, 4443.933340999887, 4459.44256967879, 4136.834526618932, 4400.7579583122915, 4421.557844215585, 4463.6429085673235, 4518.932216016746, 4256.638185754215, 4293.592108749664, 4357.041450880801, 4358.346248062784, 4358.869233922987, 4264.296391095466, 4272.145570885836, 4300.526942036374, 4310.762908040057, 4330.090680957002, 4391.49497807753, 4497.392851965008, 4548.681592288541, 4573.908521829545, 4579.038401935598, 4894.119058569456, 4934.037862616791, 4959.156943319645, 4980.82567110153, 5014.52362025607, 5012.373453318335, 5032.84901452957, 5046.369203849519, 5056.216286475602, 5113.233015047773, 4467.0, 4581.79381927814, 4698.483166851644, 4699.459562150328, 4703.341532185496, 5024.036901511073, 5042.042012017705, 5059.0, 5062.544371006627, 5196.142636464941, 4963.751812409365, 4987.10232158215, 4990.126727822617, 5013.323201367769, 5015.774290156952, 5084.46613105626, 5089.923651145235, 5094.057599344133, 5096.286519887219, 5142.588592912558, 4798.328234047236, 4857.635677324215, 5029.044481548494, 5038.874028149252, 5050.292958985671, 4792.976035119872, 4916.70499770015, 4939.407271127416, 4945.23348880924, 4957.7769000395065, 4173.749575025508, 4186.706930514895, 4195.49654041517, 4198.8110535026, 4235.216484950294, 3682.747865725666, 3685.539307586552, 3688.7417880748626, 3695.3902606070237, 3712.2575484903127, 4136.544980052252, 4236.533981262059, 4238.3430568261965, 4245.957540424618, 4340.631046361032, 5015.122353588181, 5022.472640372781, 5038.848834534897, 5049.192129259301, 5051.217061355495, 4329.307310830252, 4332.891677708019, 4333.393324934512, 4333.674974376871, 4374.321980093091, 4219.578042195756, 4311.094670119247, 4316.093620339764, 4328.956710432918, 4414.249577571821, 4785.760711964388, 4798.424189097331, 4813.278008298783, 4818.783154757974, 4871.610271178226, 5053.595712343077, 5056.064628043824, 5057.898842023065, 5058.924116138187, 5101.081805274937, 4632.536746325341, 4634.536546345338, 4726.432828060517, 4745.027269409694, 4750.406199225097, 4940.9505904941925, 4965.677230979974, 4971.527704868032, 4975.104481193275, 5019.3976722793495, 5001.424836143745, 5033.672811267256, 5037.596992240538, 5041.773120209526, 5089.720065396439, 4652.674312798072, 4762.714237145782, 4767.475577686382, 4768.523147685204, 4887.731174785421, 4893.192623217272, 4934.481879402754, 4944.134776414185, 4948.406191257072, 4981.501849815135, 4830.492798256273, 4833.130036593447, 4833.595485981159, 4852.975735121443, 4881.90236195267, 4757.476677565534, 4853.199222128309, 4856.660033797601, 4857.028594281087, 4868.878278043077, 4694.835680751157, 4751.287306903992, 4843.903121937612, 4851.417829860439, 4886.511348865085], "unit": "ms", "name": "dojo.html", "value": 4594.666156890342}, {"lowerIsBetter": false, "replicates": [578.3637998201978, 581.1399129288652, 582.4437662032759, 583.2476105823488, 586.0359708279877, 26969.0, 35623.821880890595, 36054.81972590133, 36211.818940905294, 36309.81845090778, 40624.593754062524, 41325.17349653013, 41457.58542414575, 41468.58531414685, 41583.79208103955, 6929.995150703145, 7041.0494583231375, 7878.330341920943, 8052.798680032987, 8054.798630034237, 10182.694519164437, 10431.113355364803, 10438.321509101923, 10442.791144177112, 10472.738181545446, 10115.039071288253, 10206.591736330538, 10207.795844083113, 10229.079382855578, 10230.23273254509, 6998.3001699829865, 7154.928450715478, 7176.3541281284415, 7196.496245262833, 10127.189824813997, 6902.516823822334, 10121.949390253076, 10445.216608754297, 10466.842997355046, 10479.79040419195, 37719.05702357463, 37882.0, 38012.23975520474, 38051.80974095112, 38135.61864381348, 2725.046233818168, 2749.2164733050986, 2788.876458366622, 2890.56641503774, 3161.2096975756062, 28792.745700490945, 29332.706672933426, 29391.2652183695, 29532.557011644843, 29724.851375743197, 3287.375398674244, 3316.9004929852144, 3359.0762540301366, 3376.5610470638903, 3455.550778398792, 212083.0, 212151.0, 212433.0, 212641.0, 213102.0, 56601.43398566044, 56912.0, 56920.146197807066, 57035.429645703014, 57109.42890571124, 50851.728706782626, 52758.208626870626, 53021.734891326065, 53198.73400632972, 61334.38665613287, 12793.36033198355, 13268.203907765565, 13275.66810829737, 13284.800727989088, 13318.467261309439, 9239.953800230956, 9260.953695231481, 9291.0, 9315.0, 9331.393459425115, 19327.05142136944, 19538.97145942381, 19564.21743130259, 19644.508887277647, 19718.8028119717, 7517.661705223169, 7567.621618919032, 7607.885881711779, 7690.730824421118, 7693.307602315706, 816.4815342257709, 844.4890841041082, 974.2741657465092, 1013.3514550687565, 1022.4172221833633, 26294.0, 26730.465390692076, 27056.729432705815, 27062.188134356, 28971.0, 868.1795703060548, 907.9863802042975, 936.3539157980971, 936.8922573904089, 1033.963811266602, 12424.881760641585, 12709.682257943441, 12716.237025778482, 12720.554780582821, 12723.55467558631, 252004.0, 254679.0, 256143.0, 256782.0, 257866.0, 45948.54051459509, 46085.30872036922, 46299.53700462952, 46339.0, 46558.5344146561, 1174.3541052421135, 1196.1148749925167, 1200.5257923120319, 1201.7656556971306, 1206.324458303353, 23814.0, 25757.613635795104, 27037.59443608387, 27104.1868743938, 27111.72888271092, 36775.26449471049, 37177.07057323481, 37509.4373584391, 37547.06132346713, 37636.2472750538, 226454.0, 231524.0, 232572.0, 233030.0, 233070.0, 25809.870950645127, 26239.0, 26372.736272637027, 26684.599731003662, 26702.732972670026, 38002.0, 38580.0, 38805.2238955225, 39122.608773911896, 39225.0, 29635.259118522208, 29743.702562974093, 29935.55096673595, 32788.0, 34311.82844085863, 31104.22239444032, 31925.840370797996, 32980.0, 32986.84546040973, 33032.0, 29843.10470685883, 29981.250468738457, 30208.848955755082, 30232.244193895327, 30238.0, 28320.858395707888, 29060.854695726386, 30668.84665576747, 31054.22364440817, 32902.8170630109, 22957.196498122485, 23495.295141145794, 23507.647385288892, 23528.6470702943, 24074.0], "unit": "ms", "name": "ext.html", "value": 16827.486608729076}, {"lowerIsBetter": false, "replicates": [330.2684553713524, 335.09691381726225, 335.59393134307487, 336.40120585358056, 338.4381926002835, 12358.134930554865, 12799.48802047917, 14764.630884227887, 15199.772003419943, 16091.034537927719, 8172.060213075498, 9986.800263994715, 10276.434796086212, 13610.251436171007, 14799.926000369984, 4619.0, 4728.40894888139, 4730.479647238818, 4733.952660473403, 4735.289706544028, 3503.0, 3628.183658676803, 4999.700017998914, 5088.821891233808, 5276.868078298054, 5148.974255128738, 5167.7932882684645, 5185.066687996159, 5222.112240919053, 5226.42509323976, 5061.569766569827, 5138.974305128488, 5144.8938478227365, 5153.742312884378, 5177.48225177483, 4918.213085906238, 4918.360613120271, 4918.631102667278, 4927.901441971177, 4928.285398617216, 11942.880571194264, 13012.47950082005, 17765.822341776548, 19373.450123990046, 19406.1267242973, 1809.9276328603676, 1817.9454616361531, 1827.607064481143, 1835.8806677565915, 1856.3873921605837, 9017.458952462874, 9239.72280831576, 9249.306302027375, 11366.545338186463, 12370.62888113358, 1685.073209734641, 1700.9659806803918, 1702.319072371049, 1763.8941663500102, 1780.287884846059, 49909.50090499085, 50436.49563504392, 51998.740006299726, 53918.191227131625, 56254.718726406514, 9519.904800952041, 9808.31341806081, 9954.0, 9962.750931226778, 10024.548895299584, 12511.74976500465, 12534.81197782034, 12560.560380386643, 12565.497380104876, 12577.056720745797, 6917.412019978358, 6953.965230173817, 6965.930340696629, 6985.720571177198, 6991.265917078736, 6548.050532672831, 6557.409833115043, 6595.604263744191, 6599.977003564455, 6608.00879868014, 4233.703640745119, 4260.0840819223395, 4277.059047009653, 4293.420388247547, 4316.848910288125, 1663.8336166383508, 1684.6967545841867, 1691.9577010574835, 1722.3282919661342, 1749.9737503937451, 789.455275859655, 799.9880001799978, 815.5106935838568, 943.6319835264252, 983.3264214013424, 15471.303791329417, 16633.0851803152, 16663.583410414838, 17133.0, 17225.22486488111, 728.1953441447231, 797.4776521378507, 811.9675212991532, 838.4508147163617, 921.5162039929091, 8240.175982401712, 8586.0, 8711.869321960176, 8739.475631462132, 8981.0, 476454.0, 486816.0, 488925.0, 491493.0, 496546.0, 68251.65874170598, 72037.2796272041, 72432.0, 72532.63733681403, 73635.26364736391, 1035.637526865591, 1038.984415233757, 1053.3574519543072, 1073.350622873166, 1076.5962763963514, 14349.928250358682, 14530.273486325852, 14544.345504452536, 14786.63033424173, 15114.773278401053, 33818.154546136546, 33972.66027339695, 34139.31721365608, 34981.30037399187, 35013.47479787754, 42593.36109958415, 42970.57029429666, 44716.77641611771, 45806.0, 46293.305600416694, 8757.60590773404, 8883.156100170474, 8905.73282801517, 8966.596503157243, 12874.485020599072, 16732.832671673128, 17041.18820394621, 17199.65600687954, 17211.139443027547, 17699.64600707953, 14861.92569037148, 15284.388624454898, 15724.371025159324, 15806.60483487922, 15833.920830396235, 13982.720345592828, 14643.414263429344, 14737.410503579737, 14742.11547307165, 14754.114753114847, 10918.727031824268, 13648.0, 14666.85333146655, 14852.108873467194, 15668.451604193799, 13002.609921702364, 13003.544875929298, 13193.670158246121, 13215.801762973371, 13258.80111798343, 13380.531681391105, 13703.314834258446, 13737.656558586115, 13776.448942042207, 13924.4430222794], "unit": "ms", "name": "jquery.html", "value": 8329.315752912125}, {"lowerIsBetter": false, "replicates": [1255.7488502299532, 1628.2998310726387, 1696.711559034964, 1702.8893121947071, 1731.9134043297831, 5910.0839369897685, 6736.629485378302, 6923.896141557874, 6929.3763561279475, 6939.514234003609, 6846.0, 6966.756163534277, 6984.755533556327, 7007.229204787469, 7033.8944915826305, 1742.4946765438071, 1769.2480695704273, 1935.5838494723632, 1974.8123928226833, 2017.2132868181347, 1991.5519008223107, 2002.5994801039778, 2009.6382651122792, 2011.7083022961663, 2014.2345908554728, 1972.901354932255, 1990.542175299682, 2060.9484762880898, 2062.8143467087957, 2063.5769667218183, 2032.7255820464343, 2049.139361468187, 2076.1384025629345, 2080.0847627044054, 2082.125507286943, 1986.6225417170835, 2016.0726066009654, 2019.2024150460634, 2019.8081182287658, 2023.4435530229305, 6962.582245065312, 7033.226345102034, 7033.964830175816, 7061.929380706179, 7064.0, 4034.273830710471, 4130.008797888515, 4131.35963925592, 4131.710780245384, 4135.97932010341, 2538.2765911715073, 2595.4679290745353, 2617.214835549347, 2624.160268713993, 2634.802389820771, 845.1379592815356, 859.621766422772, 862.560094351885, 870.3515880668879, 875.0724232313704, 9253.02843201461, 9286.0, 9287.0, 9292.860607090899, 9302.674406395812, 3730.3658378075793, 3799.430085487199, 3826.349520581508, 3828.693704503633, 3838.7504812187117, 8161.918380816234, 8170.468919520212, 8174.918250817415, 8179.877301840477, 8195.836083278302, 4152.273352163359, 4167.395727619478, 4169.583041695806, 4176.0, 4176.102138040336, 3783.621637836194, 3820.503334566489, 3823.5088315556955, 3825.9808700956874, 3833.0, 2975.702429757007, 3009.8344591047266, 3339.1652086978256, 3352.7485438592203, 3412.6587341265677, 1044.6813721814767, 1045.3780000899453, 1050.695298363466, 1062.1555863088863, 1073.0717928991521, 932.2914584915513, 932.4638332958576, 980.7106903463352, 1044.8119338518989, 1210.6186551236333, 6559.967200164064, 6587.670616469158, 6598.505112116611, 6605.042268871083, 6620.966895165493, 1045.0907710291942, 1046.4767616191905, 1078.1751959750798, 1080.2006515178712, 1091.6343025086526, 4839.806407743651, 4894.95105048945, 4896.167651499253, 4900.681455705368, 4901.240307752304, 7939.841203175904, 8216.876746848802, 8319.916800832036, 8329.33365330772, 8430.536320502308, 8136.0, 8235.094139644634, 8236.382271329674, 8237.546934918517, 8245.587720613945, 6450.77422290227, 6487.35126487357, 6501.349865013461, 6511.544191906616, 6570.8028759137305, 6224.0, 6256.968715156395, 6286.779962701284, 6292.2134733158355, 6303.054541818764, 7402.148752893271, 7427.257274272745, 7502.174760776419, 7551.471397002157, 7554.395648348229, 7491.550506969599, 7499.925000749922, 7652.311291983749, 7906.9209307906185, 7926.643301051351, 5949.732262048132, 6025.307089684742, 6043.576949613484, 6044.24446944132, 6044.395560444096, 5449.073657478159, 5596.1605759136455, 6426.518011149089, 6686.097376854257, 6719.731210751711, 6129.295131059806, 6158.846028849314, 6208.81373558794, 6252.343503932022, 6327.651979141007, 6180.072989051679, 6209.0, 6252.968735156295, 6257.561970662192, 6311.27420346666, 6323.557350985387, 6339.778107766206, 6344.397282258178, 6354.586951848115, 6375.0, 5891.263592050994, 5919.112133180058, 5922.585419020627, 5925.585209035326, 5932.466078052996, 5814.30228372598, 5874.412558744091, 5881.264841894763, 5884.735186916513, 5898.498627616701], "unit": "ms", "name": "mootools.html", "value": 3989.9931955470233}, {"lowerIsBetter": false, "replicates": [316.2173620289783, 317.58872260422754, 323.3839535684519, 325.5767502247079, 326.49067454770545, 5289.100852855015, 5336.866578335539, 5345.518903298703, 5354.732263386834, 5373.140297552392, 5256.842294731155, 5257.947420525794, 5282.339707536558, 5285.920711189326, 5290.0477913975465, 4160.687948403866, 4165.291900376943, 4166.333386658135, 4168.854090106847, 4181.853635122771, 3905.258000979805, 4048.109415928491, 4172.520160181588, 4182.079942412664, 4195.223883581547, 3963.5838236985132, 3998.1403998140395, 3999.4800675912093, 4002.2195671844, 4124.835006599747, 4082.2447847148223, 4090.427340172393, 4132.876013719563, 4134.00783811883, 4136.834526618932, 3654.1230104774927, 3657.2685462907257, 3658.1220507078374, 3658.5609726832686, 3662.414013757786, 4872.317875497433, 5011.799528018875, 5063.518965698289, 5127.154019586801, 5128.8461346159675, 4701.318308845232, 4715.24556071027, 4717.622590192776, 4721.693089949143, 4731.834385796515, 5554.19464177696, 5600.215969764236, 5606.411326810667, 5609.0184217762135, 5615.606907516475, 3865.381538953754, 3938.1532970411213, 3943.4479172915817, 3943.7830919299427, 3947.782871942042, 5846.210761547221, 5855.560832937546, 5855.590108692393, 5862.355140934494, 5864.560157988125, 4125.422440858282, 4132.752034877917, 4132.91734165315, 4133.855315063958, 4137.110521237948, 3950.802459877052, 4069.1658210066867, 4080.3063479208604, 4185.874423767292, 4202.600752928467, 4707.105649926503, 4720.811167553328, 4730.739809310521, 4731.668783185213, 4737.8104875805275, 5534.308211473566, 5570.888582228333, 5577.609567330329, 5580.693061881636, 5585.3297604287745, 1453.4767483705857, 1487.8512148785035, 1488.151753500516, 1488.3228131200278, 1488.8064551608438, 1029.2846471702244, 1032.055669062799, 1036.9066783989476, 1048.9685309440729, 1060.81966065769, 4859.125357435625, 4869.464358920516, 4873.463918968911, 4881.438634557, 4884.389451318585, 5759.884802303931, 5765.971170144207, 5766.106253530709, 5771.163181338682, 5776.191333213354, 4859.246816743411, 4869.513048695102, 4870.342503762017, 4871.196252618349, 4873.731944743002, 3028.8637011334545, 3076.1694342527394, 3100.5349197620085, 3105.223694076481, 3119.7036281553214, 5490.780368785284, 5512.641678290898, 5518.310211223597, 5522.171674248895, 5532.363778165482, 6001.579889407787, 6004.6097003695495, 6010.849728756816, 6011.939880601226, 6011.969940150271, 5485.341758988947, 5490.615656904059, 5505.091659876156, 5508.228847961209, 5516.420775818561, 5674.290713660793, 5808.883822323614, 5809.157672137601, 5813.069908814569, 5819.272590926134, 5687.971560142173, 5700.914486282792, 5701.771929122789, 5712.714364281853, 5730.369659337553, 5490.917636235539, 5491.917621235605, 5493.450654934474, 5495.807646732345, 5507.421720719267, 3931.5675275719077, 3963.1875465530075, 3996.620321069494, 4003.099302656879, 4046.109855831712, 5503.669779813224, 5646.689432081111, 5809.535237180931, 5812.476877081083, 5816.156657284755, 5384.596155288291, 5448.155535891943, 5488.862778430571, 5489.0, 5497.890042199214, 5585.944140558542, 5587.804426845041, 5593.216949627137, 5597.328320601554, 5606.411326810626, 5331.813386531453, 5461.235427040297, 5461.317335333083, 5464.207689885024, 5469.261649677402, 5585.5531557476115, 5613.326400831763, 5636.915446268227, 5639.577031722555, 5652.0, 5504.669719816824, 5509.5041446270025, 5510.614257001971, 5511.889762204813, 5513.365962914316], "unit": "ms", "name": "prototype.html", "value": 4220.063349292573}, {"lowerIsBetter": false, "replicates": [611.9938800611992, 678.304737643915, 685.7497013590041, 686.2622680618333, 797.772634799082, 11613.070954323655, 11916.165868389216, 11923.344216068113, 11957.521699132047, 11960.34218118003, 11420.714482137952, 12120.0, 12143.635690929264, 12156.149069565134, 12181.0, 633.866887953528, 640.270092095012, 801.4710291207804, 808.4906508899385, 817.3134566963749, 801.2708435323857, 809.7935026568217, 811.8051667599792, 815.2947700239309, 817.480899628737, 851.748734123432, 854.9487030778142, 861.1431625532604, 861.1861790607878, 861.1990848510883, 658.9538732288742, 668.1914882991586, 841.1294310388719, 842.2798507276252, 844.1937949258444, 631.7346714379971, 632.8417895526119, 633.0283015571076, 633.6103296472683, 635.5106567942659, 11806.409679516075, 11919.880801191965, 11948.462319195656, 11950.760984780343, 11980.0, 10903.0, 11428.458247504335, 11579.53681852725, 11608.129390295762, 11612.361320127475, 9025.187733104052, 9143.177114059767, 9159.084091590788, 9214.953925230398, 9288.53557322138, 3184.538241954927, 3238.935221295561, 3247.431699452586, 3271.9672803272138, 3321.7342612590933, 37267.0, 37274.695385661646, 37312.81343593292, 37377.58025086347, 37390.81304593487, 8856.202941735275, 9108.271338292921, 9187.908120918839, 9478.431294122374, 9671.806563868824, 16560.420385286456, 16641.16794160287, 16704.74942875858, 16795.748063779054, 16797.160141992852, 6280.654563999024, 6329.936700632935, 6349.587276826992, 6410.8076757697345, 6449.161608990801, 3481.9825900870333, 3543.831468465161, 3594.4967704521387, 3605.837737301828, 3607.639236076371, 2686.8849427487767, 2726.877290521931, 2736.1107640017076, 2736.151792944194, 2738.3564862257354, 470.34359837607957, 472.518031607765, 472.962163026957, 484.13098488213035, 484.1478996965296, 448.854122410218, 473.3160582957662, 487.41023361731993, 525.8422473258083, 537.4088502647057, 7865.842683146419, 8045.557494337868, 8168.509889406536, 8255.42212045151, 8333.208345207195, 442.6237697956711, 486.83690963527613, 500.0948283606684, 554.2683657571966, 562.8424041268452, 3397.1676939150066, 3428.245785927092, 3471.1148657092785, 3518.665726755954, 3549.698275646599, 43356.0, 46175.53824461712, 46186.538134618895, 46208.07583848372, 46220.537794621625, 40315.395269070985, 40905.59094409077, 41743.582564174576, 41819.1636167281, 41877.581224187976, 37602.43596346057, 37860.81069594689, 38163.61836381656, 38292.61707382946, 38670.03324916843, 7342.6695798688115, 7473.588952607659, 7676.769696909102, 7756.379489640703, 7889.289963903277, 30396.696033039385, 30805.0, 30959.0712278632, 31858.522122167724, 32787.18032049218, 36715.44926826046, 37232.0, 37603.62396376111, 38112.42831357476, 38186.42720359141, 9290.814183716422, 9470.289728270545, 9886.703398898044, 10121.493925303557, 10121.544530495998, 11010.50452729645, 11145.609903653332, 11285.548578056785, 11418.0, 11472.139589530652, 9717.9028209717, 10015.098641122335, 10042.246831487522, 10550.261481696207, 10574.10120139766, 10530.684079477627, 10846.783064338511, 11092.611758588411, 11131.387773672526, 11217.775644487228, 8266.338692904674, 9882.160016398686, 9914.553845076845, 10055.095041446304, 10375.948120259653, 8089.47418417801, 8449.493030418194, 8575.31397488212, 8810.603522841615, 8871.778205544913, 7083.468739844635, 8665.913340866511, 8788.38481306328, 8812.691555795516, 9002.414843035182], "unit": "ms", "name": "yui.html", "value": 5565.61788319795}], "name": "dromaeo_css", "value": 6263.0932022322795}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 112.0, 113.0, 113.0, 101.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 152.0, 162.0, 134.0, 161.0, 149.0, 129.0, 168.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 165.0, 164.0, 164.0, 164.0, 164.0, 163.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 84.0, 93.0, 73.0, 74.0, 72.0, 116.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 136.0, 95.0, 96.0, 95.0, 137.0, 96.0, 97.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 72.0, 74.0, 74.0, 74.0, 82.0, 75.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 85.0, 84.0, 85.0, 82.0, 83.0, 85.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 125.0, 117.0, 127.0, 119.0, 127.0, 118.0, 120.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [134.0, 153.0, 148.0, 147.0, 147.0, 140.0, 146.0, 146.0, 145.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 71.0, 69.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1523.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.26518593303047], "unit": "score", "name": "Richards", "value": 209.79978600000007}, {"lowerIsBetter": false, "replicates": [189.2147587511826], "unit": "score", "name": "DeltaBlue", "value": 349.43363}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [2022.2222222222222], "unit": "score", "name": "RayTrace", "value": 365.9286263736265}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [27162.162162162163], "unit": "score", "name": "RegExp", "value": 33.538751243781114}, {"lowerIsBetter": false, "replicates": [629.4670846394985], "unit": "score", "name": "Splay", "value": 129.46030378486054}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 19568.185444751536}]} 04:11:57 INFO - RETURN: dromaeo_css: 6263.09 04:11:57 INFO - RETURN: kraken: 1523.30 04:11:57 INFO - RETURN: v8_7: 19568.19 04:11:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19568.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1523.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6263.09"}}} 04:11:57 INFO - Return code: 0 04:11:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:11:57 INFO - # TBPL SUCCESS # 04:11:57 INFO - Running post-action listener: _resource_record_post_action 04:11:57 INFO - Running post-run listener: _resource_record_post_run 04:11:58 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505974784; Read time: 16; Write time: 573368 04:11:58 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 232042496; Read time: 0; Write time: 346572 04:11:58 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273932288; Read time: 16; Write time: 226796 04:11:58 INFO - Running post-run listener: _upload_blobber_files 04:11:58 INFO - Blob upload gear active. 04:11:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:11:58 INFO - Copying logs to upload dir... 04:11:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.750434 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-11 04:11:56.076619) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 04:11:56.079826) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010165 build_url: 'https://queue.taskcluster.net/v1/task/0AfJrDxCQZWO80IHMsff1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 04:11:56.133208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:11:56.133709) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1449827964.726498-1296474831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:11:56.185272) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:11:56.185773) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:11:56.186228) ========= ========= Total master_lag: 0.28 =========