builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1450293033.29 results: success (0) buildid: 20151216104802 builduid: 7bf4170c77a349b08ed15842528d121a revision: e564d6f8056de7f11e0d7ba1def66635c6cefb8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.289972) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.290400) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.290711) ========= 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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006356 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.335788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.336090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.387766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.388087) ========= 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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.437114) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.437460) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.437864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.438166) ========= 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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 11:10:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.9M=0s 2015-12-16 11:10:33 (95.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.646590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.646914) ========= 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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013849 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.697488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:33.697894) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e564d6f8056de7f11e0d7ba1def66635c6cefb8f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e564d6f8056de7f11e0d7ba1def66635c6cefb8f --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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 11:10:34,102 truncating revision to first 12 chars 2015-12-16 11:10:34,102 Setting DEBUG logging. 2015-12-16 11:10:34,102 attempt 1/10 2015-12-16 11:10:34,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e564d6f8056d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 11:10:34,568 unpacking tar archive at: fx-team-e564d6f8056d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:34.484120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:34.484437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:34.494497) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:34.494778) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 11:10:34.495193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-16 11:10:34.495521) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:10:34 INFO - MultiFileLogger online at 20151216 11:10:34 in /builds/slave/test 11:10:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:10:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:10:34 INFO - {'append_to_log': False, 11:10:34 INFO - 'base_work_dir': '/builds/slave/test', 11:10:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:10:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:10:34 INFO - 'branch': 'Fx-Team-Non-PGO', 11:10:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:10:34 INFO - 'config_files': ('talos/linux_config.py',), 11:10:34 INFO - 'default_actions': ('clobber', 11:10:34 INFO - 'read-buildbot-config', 11:10:34 INFO - 'download-and-extract', 11:10:34 INFO - 'populate-webroot', 11:10:34 INFO - 'create-virtualenv', 11:10:34 INFO - 'install', 11:10:34 INFO - 'run-tests'), 11:10:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:10:34 INFO - 'download_minidump_stackwalk': True, 11:10:34 INFO - 'download_symbols': 'ondemand', 11:10:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:10:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:10:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:10:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:10:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:10:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:10:34 INFO - 'installer_path': 'installer.exe', 11:10:34 INFO - 'log_level': 'info', 11:10:34 INFO - 'log_name': 'talos', 11:10:34 INFO - 'log_to_console': True, 11:10:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:10:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:10:34 INFO - 'opt_config_files': (), 11:10:34 INFO - 'pip_index': False, 11:10:34 INFO - 'sps_profile': False, 11:10:34 INFO - 'sps_profile_interval': 0, 11:10:34 INFO - 'suite': 'dromaeojs-e10s', 11:10:34 INFO - 'system_bits': '64', 11:10:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:10:34 INFO - 'title': 'talos-linux64-ix-056', 11:10:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:10:34 INFO - 'use_talos_json': True, 11:10:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:10:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:10:34 INFO - 'work_dir': 'build'} 11:10:34 INFO - ##### 11:10:34 INFO - ##### Running clobber step. 11:10:34 INFO - ##### 11:10:34 INFO - Running pre-action listener: _resource_record_pre_action 11:10:34 INFO - Running main action method: clobber 11:10:34 INFO - rmtree: /builds/slave/test/build 11:10:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:10:35 INFO - Running post-action listener: _resource_record_post_action 11:10:35 INFO - ##### 11:10:35 INFO - ##### Running read-buildbot-config step. 11:10:35 INFO - ##### 11:10:35 INFO - Running pre-action listener: _resource_record_pre_action 11:10:35 INFO - Running main action method: read_buildbot_config 11:10:35 INFO - Using buildbot properties: 11:10:35 INFO - { 11:10:35 INFO - "properties": { 11:10:35 INFO - "buildnumber": 589, 11:10:35 INFO - "product": "firefox", 11:10:35 INFO - "script_repo_revision": "production", 11:10:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:10:35 INFO - "repository": "", 11:10:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:10:35 INFO - "buildid": "20151216104802", 11:10:35 INFO - "slavename": "talos-linux64-ix-056", 11:10:35 INFO - "pgo_build": "False", 11:10:35 INFO - "basedir": "/builds/slave/test", 11:10:35 INFO - "project": "", 11:10:35 INFO - "platform": "ubuntu64_hw", 11:10:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:10:35 INFO - "slavebuilddir": "test", 11:10:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:10:35 INFO - "branch": "fx-team", 11:10:35 INFO - "repo_path": "integration/fx-team", 11:10:35 INFO - "stage_platform": "linux64", 11:10:35 INFO - "builduid": "7bf4170c77a349b08ed15842528d121a", 11:10:35 INFO - "revision": "e564d6f8056de7f11e0d7ba1def66635c6cefb8f" 11:10:35 INFO - }, 11:10:35 INFO - "sourcestamp": { 11:10:35 INFO - "repository": "", 11:10:35 INFO - "hasPatch": false, 11:10:35 INFO - "project": "", 11:10:35 INFO - "branch": "fx-team-linux64-talos", 11:10:35 INFO - "changes": [ 11:10:35 INFO - { 11:10:35 INFO - "category": null, 11:10:35 INFO - "files": [ 11:10:35 INFO - { 11:10:35 INFO - "url": null, 11:10:35 INFO - "name": "https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 11:10:35 INFO - } 11:10:35 INFO - ], 11:10:35 INFO - "repository": "", 11:10:35 INFO - "rev": "e564d6f8056de7f11e0d7ba1def66635c6cefb8f", 11:10:35 INFO - "who": "cliu@mozilla.com", 11:10:35 INFO - "when": 1450292983, 11:10:35 INFO - "number": 7367644, 11:10:35 INFO - "comments": "Bug 1212611 - Use system notification for website notifications in Android. r=mfinkle", 11:10:35 INFO - "project": "", 11:10:35 INFO - "at": "Wed 16 Dec 2015 11:09:43", 11:10:35 INFO - "branch": "fx-team-linux64-talos", 11:10:35 INFO - "revlink": "", 11:10:35 INFO - "properties": [ 11:10:35 INFO - [ 11:10:35 INFO - "buildid", 11:10:35 INFO - "20151216104802", 11:10:35 INFO - "Change" 11:10:35 INFO - ], 11:10:35 INFO - [ 11:10:35 INFO - "builduid", 11:10:35 INFO - "7bf4170c77a349b08ed15842528d121a", 11:10:35 INFO - "Change" 11:10:35 INFO - ], 11:10:35 INFO - [ 11:10:35 INFO - "pgo_build", 11:10:35 INFO - "False", 11:10:35 INFO - "Change" 11:10:35 INFO - ] 11:10:35 INFO - ], 11:10:35 INFO - "revision": "e564d6f8056de7f11e0d7ba1def66635c6cefb8f" 11:10:35 INFO - } 11:10:35 INFO - ], 11:10:35 INFO - "revision": "e564d6f8056de7f11e0d7ba1def66635c6cefb8f" 11:10:35 INFO - } 11:10:35 INFO - } 11:10:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:10:35 INFO - Running post-action listener: _resource_record_post_action 11:10:35 INFO - ##### 11:10:35 INFO - ##### Running download-and-extract step. 11:10:35 INFO - ##### 11:10:35 INFO - Running pre-action listener: _resource_record_pre_action 11:10:35 INFO - Running main action method: download_and_extract 11:10:35 INFO - mkdir: /builds/slave/test/build/tests 11:10:35 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')]} 11:10:35 INFO - https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:10:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/test_packages.json 11:10:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/test_packages.json 11:10:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:10:39 INFO - Downloaded 1302 bytes. 11:10:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:10:39 INFO - Using the following test package requirements: 11:10:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:10:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:39 INFO - u'jsshell-linux-x86_64.zip'], 11:10:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:10:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:10:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:10:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:10:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:10:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:10:39 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')]} 11:10:39 INFO - https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:10:48 INFO - Downloaded 21870662 bytes. 11:10:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:10:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:10:49 INFO - Return code: 0 11:10:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:10:49 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')]} 11:10:49 INFO - https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:10:50 INFO - Downloaded 21870662 bytes. 11:10:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:10:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:10:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:10:51 INFO - Return code: 0 11:10:51 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')]} 11:10:51 INFO - https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:10:52 INFO - Downloaded 11132052 bytes. 11:10:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:10:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:10:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:10:52 INFO - Return code: 0 11:10: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')]} 11:10:52 INFO - https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:10:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:10:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:10:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:10:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:10:54 INFO - Downloaded 57773863 bytes. 11:10:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:10:54 INFO - mkdir: /builds/slave/test/properties 11:10:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:10:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:10:54 INFO - Contents: 11:10:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:10:54 INFO - Running post-action listener: _resource_record_post_action 11:10:54 INFO - Running post-action listener: set_extra_try_arguments 11:10:54 INFO - ##### 11:10:54 INFO - ##### Running populate-webroot step. 11:10:54 INFO - ##### 11:10:54 INFO - Running pre-action listener: _resource_record_pre_action 11:10:54 INFO - Running main action method: populate_webroot 11:10:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:10:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:10:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:10:54 INFO - '--tppagecycles', 11:10:54 INFO - '7'], 11:10:54 INFO - 'tests': ['tsvgm']}}, 11:10:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:10:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:10:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:10:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:10:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'tests': ['damp', 'tps']}, 11:10:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['damp', 'tps']}, 11:10:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:10:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:10:54 INFO - 'other': {'tests': ['a11yr', 11:10:54 INFO - 'ts_paint', 11:10:54 INFO - 'tpaint', 11:10:54 INFO - 'sessionrestore', 11:10:54 INFO - 'sessionrestore_no_auto_restore']}, 11:10:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['a11yr', 11:10:54 INFO - 'ts_paint', 11:10:54 INFO - 'tpaint', 11:10:54 INFO - 'sessionrestore', 11:10:54 INFO - 'sessionrestore_no_auto_restore']}, 11:10:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['a11yr', 11:10:54 INFO - 'ts_paint', 11:10:54 INFO - 'tpaint', 11:10:54 INFO - 'sessionrestore', 11:10:54 INFO - 'sessionrestore_no_auto_restore']}, 11:10:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['a11yr', 11:10:54 INFO - 'ts_paint', 11:10:54 INFO - 'tpaint', 11:10:54 INFO - 'sessionrestore', 11:10:54 INFO - 'sessionrestore_no_auto_restore']}, 11:10:54 INFO - 'other_l64': {'tests': ['a11yr', 11:10:54 INFO - 'ts_paint', 11:10:54 INFO - 'tpaint', 11:10:54 INFO - 'sessionrestore', 11:10:54 INFO - 'sessionrestore_no_auto_restore']}, 11:10:54 INFO - 'other_nol64': {'tests': ['a11yr', 11:10:54 INFO - 'ts_paint', 11:10:54 INFO - 'tpaint', 11:10:54 INFO - 'sessionrestore', 11:10:54 INFO - 'sessionrestore_no_auto_restore']}, 11:10:54 INFO - 'svgr': {'tests': ['tsvgx', 11:10:54 INFO - 'tsvgr_opacity', 11:10:54 INFO - 'tart', 11:10:54 INFO - 'tscrollx', 11:10:54 INFO - 'cart']}, 11:10:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['tsvgx', 11:10:54 INFO - 'tsvgr_opacity', 11:10:54 INFO - 'tart', 11:10:54 INFO - 'tscrollx', 11:10:54 INFO - 'cart']}, 11:10:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'tests': ['tp5o']}, 11:10:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'talos_options': ['--e10s'], 11:10:54 INFO - 'tests': ['tp5o']}, 11:10:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'talos_options': ['--xperf_path', 11:10:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:54 INFO - 'tests': ['tp5n']}, 11:10:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:54 INFO - 'talos_options': ['--e10s', 11:10:54 INFO - '--xperf_path', 11:10:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:54 INFO - 'tests': ['tp5n']}}, 11:10:54 INFO - 'talos.zip': {'path': '', 11:10:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:10:54 INFO - Running post-action listener: _resource_record_post_action 11:10:54 INFO - ##### 11:10:54 INFO - ##### Running create-virtualenv step. 11:10:54 INFO - ##### 11:10:54 INFO - Running pre-action listener: _resource_record_pre_action 11:10:54 INFO - Running main action method: create_virtualenv 11:10:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:10:54 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 11:10:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:10:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:10:54 INFO - Using real prefix '/usr' 11:10:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:10:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:10:56 INFO - Installing pip.................done. 11:10:56 INFO - Return code: 0 11:10:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:10:56 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')]} 11:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:56 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')]} 11:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:56 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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:10:56 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 11:10:56 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 11:10:56 INFO - Using env: {'DISPLAY': ':0', 11:10:56 INFO - 'HOME': '/home/cltbld', 11:10:56 INFO - 'LANG': 'en_US.UTF-8', 11:10:56 INFO - 'LANGUAGE': 'en_US:en', 11:10:56 INFO - 'LOGNAME': 'cltbld', 11:10:56 INFO - 'MAIL': '/var/mail/cltbld', 11:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:56 INFO - 'MOZ_NO_REMOTE': '1', 11:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:56 INFO - 'NO_EM_RESTART': '1', 11:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:56 INFO - 'PWD': '/builds/slave/test', 11:10:56 INFO - 'SHELL': '/bin/bash', 11:10:56 INFO - 'SHLVL': '1', 11:10:56 INFO - 'TERM': 'linux', 11:10:56 INFO - 'TMOUT': '86400', 11:10:56 INFO - 'USER': 'cltbld', 11:10:56 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:56 INFO - '_': '/tools/buildbot/bin/python'} 11:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:57 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 11:10:57 INFO - Cleaning up... 11:10:57 INFO - Return code: 0 11:10:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:10:57 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')]} 11:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:57 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')]} 11:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:57 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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:10:57 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 11:10:57 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 11:10:57 INFO - Using env: {'DISPLAY': ':0', 11:10:57 INFO - 'HOME': '/home/cltbld', 11:10:57 INFO - 'LANG': 'en_US.UTF-8', 11:10:57 INFO - 'LANGUAGE': 'en_US:en', 11:10:57 INFO - 'LOGNAME': 'cltbld', 11:10:57 INFO - 'MAIL': '/var/mail/cltbld', 11:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:57 INFO - 'MOZ_NO_REMOTE': '1', 11:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:57 INFO - 'NO_EM_RESTART': '1', 11:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:57 INFO - 'PWD': '/builds/slave/test', 11:10:57 INFO - 'SHELL': '/bin/bash', 11:10:57 INFO - 'SHLVL': '1', 11:10:57 INFO - 'TERM': 'linux', 11:10:57 INFO - 'TMOUT': '86400', 11:10:57 INFO - 'USER': 'cltbld', 11:10:57 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:57 INFO - '_': '/tools/buildbot/bin/python'} 11:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:57 INFO - Downloading/unpacking psutil>=0.7.1 11:10:57 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 11:10:57 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 11:10:57 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 11:10:57 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 11:10:57 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 11:10:57 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 11:10:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:10:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:10:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:59 INFO - Installing collected packages: psutil 11:10:59 INFO - Running setup.py install for psutil 11:10:59 INFO - building 'psutil._psutil_linux' extension 11:10:59 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 11:10:59 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 11:10:59 INFO - building 'psutil._psutil_posix' extension 11:10:59 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 11:10:59 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 11:10:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:59 INFO - Successfully installed psutil 11:10:59 INFO - Cleaning up... 11:10:59 INFO - Return code: 0 11:10:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:10: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')]} 11:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10: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')]} 11:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10: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', '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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:10: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:10: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 mozsystemmonitor==0.0.0 11:10:59 INFO - Using env: {'DISPLAY': ':0', 11:10:59 INFO - 'HOME': '/home/cltbld', 11:10:59 INFO - 'LANG': 'en_US.UTF-8', 11:10:59 INFO - 'LANGUAGE': 'en_US:en', 11:10:59 INFO - 'LOGNAME': 'cltbld', 11:10:59 INFO - 'MAIL': '/var/mail/cltbld', 11:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:59 INFO - 'MOZ_NO_REMOTE': '1', 11:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:59 INFO - 'NO_EM_RESTART': '1', 11:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:59 INFO - 'PWD': '/builds/slave/test', 11:10:59 INFO - 'SHELL': '/bin/bash', 11:10:59 INFO - 'SHLVL': '1', 11:10:59 INFO - 'TERM': 'linux', 11:10:59 INFO - 'TMOUT': '86400', 11:10:59 INFO - 'USER': 'cltbld', 11:10:59 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:59 INFO - '_': '/tools/buildbot/bin/python'} 11:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:10:59 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 11:10:59 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 11:10:59 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 11:10:59 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 11:10:59 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 11:10:59 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 11:11:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:11:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:11:01 INFO - Installing collected packages: mozsystemmonitor 11:11:01 INFO - Running setup.py install for mozsystemmonitor 11:11:01 INFO - Successfully installed mozsystemmonitor 11:11:01 INFO - Cleaning up... 11:11:01 INFO - Return code: 0 11:11:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:11:01 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')]} 11:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:01 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')]} 11:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:01 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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:11:01 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 11:11:01 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 11:11:01 INFO - Using env: {'DISPLAY': ':0', 11:11:01 INFO - 'HOME': '/home/cltbld', 11:11:01 INFO - 'LANG': 'en_US.UTF-8', 11:11:01 INFO - 'LANGUAGE': 'en_US:en', 11:11:01 INFO - 'LOGNAME': 'cltbld', 11:11:01 INFO - 'MAIL': '/var/mail/cltbld', 11:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:01 INFO - 'MOZ_NO_REMOTE': '1', 11:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:01 INFO - 'NO_EM_RESTART': '1', 11:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:01 INFO - 'PWD': '/builds/slave/test', 11:11:01 INFO - 'SHELL': '/bin/bash', 11:11:01 INFO - 'SHLVL': '1', 11:11:01 INFO - 'TERM': 'linux', 11:11:01 INFO - 'TMOUT': '86400', 11:11:01 INFO - 'USER': 'cltbld', 11:11:01 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:01 INFO - '_': '/tools/buildbot/bin/python'} 11:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:01 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 11:11:01 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 11:11:01 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 11:11:01 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 11:11:01 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 11:11:01 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 11:11:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:11:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11:03 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 11:11:03 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 11:11:03 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 11:11:03 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 11:11:03 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 11:11:03 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 11:11:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:11:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:04 INFO - Downloading docopt-0.6.1.tar.gz 11:11:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:11:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:04 INFO - Running setup.py install for blobuploader 11:11:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:11:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:11:04 INFO - Running setup.py install for requests 11:11:04 INFO - Running setup.py install for docopt 11:11:04 INFO - Successfully installed blobuploader requests docopt 11:11:04 INFO - Cleaning up... 11:11:04 INFO - Return code: 0 11:11:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:04 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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:11:04 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 11:11:04 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 11:11:04 INFO - Using env: {'DISPLAY': ':0', 11:11:04 INFO - 'HOME': '/home/cltbld', 11:11:04 INFO - 'LANG': 'en_US.UTF-8', 11:11:04 INFO - 'LANGUAGE': 'en_US:en', 11:11:04 INFO - 'LOGNAME': 'cltbld', 11:11:04 INFO - 'MAIL': '/var/mail/cltbld', 11:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:04 INFO - 'MOZ_NO_REMOTE': '1', 11:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:04 INFO - 'NO_EM_RESTART': '1', 11:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:04 INFO - 'PWD': '/builds/slave/test', 11:11:04 INFO - 'SHELL': '/bin/bash', 11:11:04 INFO - 'SHLVL': '1', 11:11:04 INFO - 'TERM': 'linux', 11:11:04 INFO - 'TMOUT': '86400', 11:11:04 INFO - 'USER': 'cltbld', 11:11:04 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:04 INFO - '_': '/tools/buildbot/bin/python'} 11:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:05 INFO - Running setup.py (path:/tmp/pip-yAX4tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:05 INFO - Running setup.py (path:/tmp/pip-wb8wdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:05 INFO - Running setup.py (path:/tmp/pip-nmF_Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:05 INFO - Running setup.py (path:/tmp/pip-TFNqGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:05 INFO - Running setup.py (path:/tmp/pip-HLU2rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:05 INFO - Running setup.py (path:/tmp/pip-jTpb8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:05 INFO - Running setup.py (path:/tmp/pip-jHAa7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:05 INFO - Running setup.py (path:/tmp/pip-tx0EsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:05 INFO - Running setup.py (path:/tmp/pip-VFvDIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:05 INFO - Running setup.py (path:/tmp/pip-fow_pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:05 INFO - Running setup.py (path:/tmp/pip-WnD9Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:05 INFO - Running setup.py (path:/tmp/pip-p5u7NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:06 INFO - Running setup.py (path:/tmp/pip-JohO0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:06 INFO - Running setup.py (path:/tmp/pip-sGVI2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:06 INFO - Running setup.py (path:/tmp/pip-hyJE3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:06 INFO - Running setup.py (path:/tmp/pip-FIA9la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:06 INFO - Running setup.py (path:/tmp/pip-olqfP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:06 INFO - Running setup.py install for manifestparser 11:11:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:11:06 INFO - Running setup.py install for mozcrash 11:11:06 INFO - Running setup.py install for mozdebug 11:11:06 INFO - Running setup.py install for mozdevice 11:11:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:11:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:11:06 INFO - Running setup.py install for mozfile 11:11:06 INFO - Running setup.py install for mozhttpd 11:11:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Running setup.py install for mozinfo 11:11:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Running setup.py install for mozInstall 11:11:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Running setup.py install for mozleak 11:11:07 INFO - Running setup.py install for mozlog 11:11:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Running setup.py install for moznetwork 11:11:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Running setup.py install for mozprocess 11:11:07 INFO - Running setup.py install for mozprofile 11:11:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Running setup.py install for mozrunner 11:11:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:11:07 INFO - Running setup.py install for mozscreenshot 11:11:07 INFO - Running setup.py install for moztest 11:11:08 INFO - Running setup.py install for mozversion 11:11:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:11:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:08 INFO - Cleaning up... 11:11:08 INFO - Return code: 0 11:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:08 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')]} 11:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 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')]} 11:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:08 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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:11:08 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 11:11:08 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 11:11:08 INFO - Using env: {'DISPLAY': ':0', 11:11:08 INFO - 'HOME': '/home/cltbld', 11:11:08 INFO - 'LANG': 'en_US.UTF-8', 11:11:08 INFO - 'LANGUAGE': 'en_US:en', 11:11:08 INFO - 'LOGNAME': 'cltbld', 11:11:08 INFO - 'MAIL': '/var/mail/cltbld', 11:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:08 INFO - 'MOZ_NO_REMOTE': '1', 11:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:08 INFO - 'NO_EM_RESTART': '1', 11:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:08 INFO - 'PWD': '/builds/slave/test', 11:11:08 INFO - 'SHELL': '/bin/bash', 11:11:08 INFO - 'SHLVL': '1', 11:11:08 INFO - 'TERM': 'linux', 11:11:08 INFO - 'TMOUT': '86400', 11:11:08 INFO - 'USER': 'cltbld', 11:11:08 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:08 INFO - '_': '/tools/buildbot/bin/python'} 11:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:08 INFO - Running setup.py (path:/tmp/pip-K3xTmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:08 INFO - Running setup.py (path:/tmp/pip-QAItSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:08 INFO - Running setup.py (path:/tmp/pip-j7krDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:08 INFO - Running setup.py (path:/tmp/pip-YwVTyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:08 INFO - Running setup.py (path:/tmp/pip-gTvAwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:08 INFO - Running setup.py (path:/tmp/pip-ei98Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:08 INFO - Running setup.py (path:/tmp/pip-udWmmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:08 INFO - Running setup.py (path:/tmp/pip-Vjc35A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:08 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)) 11:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:08 INFO - Running setup.py (path:/tmp/pip-IMH1MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:09 INFO - Running setup.py (path:/tmp/pip-9NRtMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:09 INFO - Running setup.py (path:/tmp/pip-CgL0IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:09 INFO - Running setup.py (path:/tmp/pip-k0UQ7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:09 INFO - Running setup.py (path:/tmp/pip-PLFImW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:09 INFO - Running setup.py (path:/tmp/pip-bXL39e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:09 INFO - Running setup.py (path:/tmp/pip-idwPAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:09 INFO - Running setup.py (path:/tmp/pip-NYLWvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:09 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)) 11:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:09 INFO - Running setup.py (path:/tmp/pip-wGBF81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:09 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)) 11:11:09 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)) 11:11:09 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)) 11:11:09 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)) 11:11:09 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)) 11:11:09 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)) 11:11:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:11:09 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 11:11:09 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 11:11:09 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 11:11:09 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 11:11:09 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 11:11:09 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 11:11:11 INFO - Downloading blessings-1.5.1.tar.gz 11:11:11 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 11:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:11:11 INFO - Installing collected packages: blessings 11:11:11 INFO - Running setup.py install for blessings 11:11:11 INFO - Successfully installed blessings 11:11:11 INFO - Cleaning up... 11:11:11 INFO - Return code: 0 11:11:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:11 INFO - Reading from file tmpfile_stdout 11:11:11 INFO - Current package versions: 11:11:11 INFO - argparse == 1.2.1 11:11:11 INFO - blessings == 1.5.1 11:11:11 INFO - blobuploader == 1.2.4 11:11:11 INFO - docopt == 0.6.1 11:11:11 INFO - manifestparser == 1.1 11:11:11 INFO - mozInstall == 1.12 11:11:11 INFO - mozcrash == 0.16 11:11:11 INFO - mozdebug == 0.1 11:11:11 INFO - mozdevice == 0.47 11:11:11 INFO - mozfile == 1.2 11:11:11 INFO - mozhttpd == 0.7 11:11:11 INFO - mozinfo == 0.9 11:11:11 INFO - mozleak == 0.1 11:11:11 INFO - mozlog == 3.1 11:11:11 INFO - moznetwork == 0.27 11:11:11 INFO - mozprocess == 0.22 11:11:11 INFO - mozprofile == 0.27 11:11:11 INFO - mozrunner == 6.11 11:11:11 INFO - mozscreenshot == 0.1 11:11:11 INFO - mozsystemmonitor == 0.0 11:11:11 INFO - moztest == 0.7 11:11:11 INFO - mozversion == 1.4 11:11:11 INFO - psutil == 3.1.1 11:11:11 INFO - requests == 1.2.3 11:11:11 INFO - wsgiref == 0.1.2 11:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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/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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:11: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/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 11:11: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/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 11:11:11 INFO - Using env: {'DISPLAY': ':0', 11:11:11 INFO - 'HOME': '/home/cltbld', 11:11:11 INFO - 'LANG': 'en_US.UTF-8', 11:11:11 INFO - 'LANGUAGE': 'en_US:en', 11:11:11 INFO - 'LOGNAME': 'cltbld', 11:11:11 INFO - 'MAIL': '/var/mail/cltbld', 11:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:11 INFO - 'MOZ_NO_REMOTE': '1', 11:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:11 INFO - 'NO_EM_RESTART': '1', 11:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:11 INFO - 'PWD': '/builds/slave/test', 11:11:11 INFO - 'SHELL': '/bin/bash', 11:11:11 INFO - 'SHLVL': '1', 11:11:11 INFO - 'TERM': 'linux', 11:11:11 INFO - 'TMOUT': '86400', 11:11:11 INFO - 'USER': 'cltbld', 11:11:11 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:11 INFO - '_': '/tools/buildbot/bin/python'} 11:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:12 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)) 11:11:12 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)) 11:11:12 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)) 11:11:12 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)) 11:11:12 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)) 11:11:12 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)) 11:11:12 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)) 11:11:12 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)) 11:11: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:11:12 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)) 11:11:12 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)) 11:11:12 INFO - Cleaning up... 11:11:12 INFO - Return code: 0 11:11:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:11:12 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')]} 11:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:12 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')]} 11:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:12 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 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:11:12 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 11:11:12 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 11:11:12 INFO - Using env: {'DISPLAY': ':0', 11:11:12 INFO - 'HOME': '/home/cltbld', 11:11:12 INFO - 'LANG': 'en_US.UTF-8', 11:11:12 INFO - 'LANGUAGE': 'en_US:en', 11:11:12 INFO - 'LOGNAME': 'cltbld', 11:11:12 INFO - 'MAIL': '/var/mail/cltbld', 11:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:12 INFO - 'MOZ_NO_REMOTE': '1', 11:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:12 INFO - 'NO_EM_RESTART': '1', 11:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:12 INFO - 'PWD': '/builds/slave/test', 11:11:12 INFO - 'SHELL': '/bin/bash', 11:11:12 INFO - 'SHLVL': '1', 11:11:12 INFO - 'TERM': 'linux', 11:11:12 INFO - 'TMOUT': '86400', 11:11:12 INFO - 'USER': 'cltbld', 11:11:12 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:12 INFO - '_': '/tools/buildbot/bin/python'} 11:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:12 INFO - Downloading/unpacking jsonschema 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:13 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 11:11:13 INFO - Downloading/unpacking functools32 (from jsonschema) 11:11:13 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 11:11:13 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 11:11:13 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 11:11:13 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 11:11:13 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 11:11:13 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 11:11:14 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:14 INFO - warning: no files found matching '*.txt' 11:11:14 INFO - no previously-included directories found matching 'build' 11:11:14 INFO - no previously-included directories found matching 'dist' 11:11:14 INFO - no previously-included directories found matching '.git*' 11:11:14 INFO - Installing collected packages: jsonschema, functools32 11:11:14 INFO - Running setup.py install for functools32 11:11:14 INFO - warning: no files found matching '*.txt' 11:11:14 INFO - no previously-included directories found matching 'build' 11:11:14 INFO - no previously-included directories found matching 'dist' 11:11:14 INFO - no previously-included directories found matching '.git*' 11:11:14 INFO - Successfully installed jsonschema functools32 11:11:14 INFO - Cleaning up... 11:11:14 INFO - Return code: 0 11:11:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff31951df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, '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-1450292908.867734-1953551193', '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 11:11: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', 'flake8'] in /builds/slave/test/build 11:11: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 flake8 11:11:14 INFO - Using env: {'DISPLAY': ':0', 11:11:14 INFO - 'HOME': '/home/cltbld', 11:11:14 INFO - 'LANG': 'en_US.UTF-8', 11:11:14 INFO - 'LANGUAGE': 'en_US:en', 11:11:14 INFO - 'LOGNAME': 'cltbld', 11:11:14 INFO - 'MAIL': '/var/mail/cltbld', 11:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:14 INFO - 'MOZ_NO_REMOTE': '1', 11:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:14 INFO - 'NO_EM_RESTART': '1', 11:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:14 INFO - 'PWD': '/builds/slave/test', 11:11:14 INFO - 'SHELL': '/bin/bash', 11:11:14 INFO - 'SHLVL': '1', 11:11:14 INFO - 'TERM': 'linux', 11:11:14 INFO - 'TMOUT': '86400', 11:11:14 INFO - 'USER': 'cltbld', 11:11:14 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:14 INFO - '_': '/tools/buildbot/bin/python'} 11:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:14 INFO - Downloading/unpacking flake8 11:11:14 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 11:11:14 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 11:11:14 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 11:11:14 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 11:11:14 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 11:11:14 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 11:11:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:11:16 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 11:11:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:11:16 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 11:11:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:16 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 11:11:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:11:16 INFO - no previously-included directories found matching 'docs/_build' 11:11:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:11:17 INFO - Running setup.py install for pep8 11:11:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:11:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:11:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:11:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:11:17 INFO - no previously-included directories found matching 'docs/_build' 11:11:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:11:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:11:17 INFO - Cleaning up... 11:11:17 INFO - Return code: 0 11:11:17 INFO - Running post-action listener: _resource_record_post_action 11:11:17 INFO - Running post-action listener: _start_resource_monitoring 11:11:17 INFO - Starting resource monitoring. 11:11:17 INFO - ##### 11:11:17 INFO - ##### Running install step. 11:11:17 INFO - ##### 11:11:17 INFO - Running pre-action listener: _resource_record_pre_action 11:11:17 INFO - Running main action method: install 11:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:17 INFO - Reading from file tmpfile_stdout 11:11:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:11:17 INFO - Reading from file tmpfile_stdout 11:11:17 INFO - Output received: 11:11:17 INFO - Usage: mozinstall [options] installer 11:11:17 INFO - Options: 11:11:17 INFO - -h, --help show this help message and exit 11:11:17 INFO - -d DEST, --destination=DEST 11:11:17 INFO - Directory to install application into. [default: 11:11:17 INFO - "/builds/slave/test"] 11:11:17 INFO - --app=APP Application being installed. [default: firefox] 11:11:17 INFO - mkdir: /builds/slave/test/build/application 11:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:11:32 INFO - Reading from file tmpfile_stdout 11:11:32 INFO - Output received: 11:11:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:11:32 INFO - Running post-action listener: _resource_record_post_action 11:11:32 INFO - ##### 11:11:32 INFO - ##### Running run-tests step. 11:11:32 INFO - ##### 11:11:32 INFO - Running pre-action listener: _resource_record_pre_action 11:11:32 INFO - Running main action method: run_tests 11:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:11:32 INFO - Python 2.7.3 11:11:32 INFO - Return code: 0 11:11:32 INFO - grabbing minidump binary from tooltool 11:11:32 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')]} 11:11:32 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 0x179b0b0>, '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 0x179bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:11:32 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 11:11:32 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 11:11:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:11:32 INFO - Return code: 0 11:11:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:11:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:11:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:11:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:11:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:11:33 INFO - Return code: 0 11:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test/build 11:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 11:11:33 INFO - Using env: {'DISPLAY': ':0', 11:11:33 INFO - 'HOME': '/home/cltbld', 11:11:33 INFO - 'LANG': 'en_US.UTF-8', 11:11:33 INFO - 'LANGUAGE': 'en_US:en', 11:11:33 INFO - 'LOGNAME': 'cltbld', 11:11:33 INFO - 'MAIL': '/var/mail/cltbld', 11:11:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:11:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:33 INFO - 'MOZ_NO_REMOTE': '1', 11:11:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:33 INFO - 'NO_EM_RESTART': '1', 11:11:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:33 INFO - 'PWD': '/builds/slave/test', 11:11:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:11:33 INFO - 'SHELL': '/bin/bash', 11:11:33 INFO - 'SHLVL': '1', 11:11:33 INFO - 'TERM': 'linux', 11:11:33 INFO - 'TMOUT': '86400', 11:11:33 INFO - 'USER': 'cltbld', 11:11:33 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450292908.867734-1953551193', 11:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:33 INFO - '_': '/tools/buildbot/bin/python'} 11:11:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 11:11:33 INFO - mozversion INFO | application_buildid: 20151216104802 11:11:33 INFO - mozversion INFO | application_changeset: e564d6f8056de7f11e0d7ba1def66635c6cefb8f 11:11:33 INFO - mozversion INFO | application_display_name: Nightly 11:11:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:11:33 INFO - mozversion INFO | application_name: Firefox 11:11:33 INFO - mozversion INFO | application_remotingname: firefox 11:11:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:11:33 INFO - mozversion INFO | application_vendor: Mozilla 11:11:33 INFO - mozversion INFO | application_version: 46.0a1 11:11:33 INFO - mozversion INFO | platform_buildid: 20151216104802 11:11:33 INFO - mozversion INFO | platform_changeset: e564d6f8056de7f11e0d7ba1def66635c6cefb8f 11:11:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:11:33 INFO - mozversion INFO | platform_version: 46.0a1 11:11:33 INFO - 2015-12-16 11:11:33,327 DEBUG : using testdate: 1450293093 11:11:33 INFO - 2015-12-16 11:11:33,327 DEBUG : actual date: 1450293093 11:11:33 INFO - 2015-12-16 11:11:33,342 INFO : starting webserver on 'localhost:57921' 11:11:33 INFO - 2015-12-16 11:11:33,343 INFO : Starting test suite talos-linux64-ix-056.e 11:11:33 INFO - 2015-12-16 11:11:33,343 INFO : Starting test dromaeo_css 11:11:33 INFO - 2015-12-16 11:11:33,343 DEBUG : operating with platform_type : linux_ 11:11:33 INFO - 2015-12-16 11:11:33,344 INFO : Initialising browser for dromaeo_css test... 11:11:33 INFO - 2015-12-16 11:11:33,360 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZxP_JY/profile http://localhost:57921/getInfo.html 11:11:38 INFO - 2015-12-16 11:11:38,606 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:11:38 INFO - 2015-12-16 11:11:38,606 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:11:38 INFO - 2015-12-16 11:11:38,606 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:11:38 INFO - 2015-12-16 11:11:38,606 DEBUG : BROWSER_OUTPUT: __metrics 11:11:38 INFO - 2015-12-16 11:11:38,743 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] 11:11:39 INFO - 2015-12-16 11:11:39,720 INFO : Browser initialized. 11:11:39 INFO - 2015-12-16 11:11:39,721 INFO : Running cycle 1/1 for dromaeo_css test... 11:11:39 INFO - 2015-12-16 11:11:39,721 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZxP_JY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:11:51 INFO - 2015-12-16 11:11:51,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 143396864 11:11:51 INFO - 2015-12-16 11:11:51,796 DEBUG : BROWSER_OUTPUT: 11:12:41 INFO - 2015-12-16 11:12:41,417 DEBUG : BROWSER_OUTPUT: 1450293161409 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] 11:14:53 INFO - 2015-12-16 11:14:53,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57921/tests/dromaeo/cssquery-ext.html) 11:14:54 INFO - 2015-12-16 11:14:54,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 146894848 11:14:54 INFO - 2015-12-16 11:14:54,502 DEBUG : BROWSER_OUTPUT: 11:17:56 INFO - 2015-12-16 11:17:56,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/dromaeo/cssquery-ext.html (next: http://localhost:57921/tests/dromaeo/cssquery-jquery.html) 11:17:57 INFO - 2015-12-16 11:17:57,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 145080320 11:17:57 INFO - 2015-12-16 11:17:57,216 DEBUG : BROWSER_OUTPUT: 11:20:59 INFO - 2015-12-16 11:20:59,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57921/tests/dromaeo/cssquery-mootools.html) 11:20:59 INFO - 2015-12-16 11:20:59,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 147148800 11:20:59 INFO - 2015-12-16 11:20:59,638 DEBUG : BROWSER_OUTPUT: 11:24:01 INFO - 2015-12-16 11:24:01,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57921/tests/dromaeo/cssquery-prototype.html) 11:24:02 INFO - 2015-12-16 11:24:02,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 144781312 11:24:02 INFO - 2015-12-16 11:24:02,043 DEBUG : BROWSER_OUTPUT: 11:27:04 INFO - 2015-12-16 11:27:04,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57921/tests/dromaeo/cssquery-yui.html) 11:27:05 INFO - 2015-12-16 11:27:05,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 144347136 11:27:05 INFO - 2015-12-16 11:27:05,288 DEBUG : BROWSER_OUTPUT: 11:30:07 INFO - 2015-12-16 11:30:07,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/dromaeo/cssquery-yui.html (next: http://localhost:57921/tests/dromaeo/cssquery-dojo.html) 11:30:08 INFO - 2015-12-16 11:30:08,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 147091456 11:30:08 INFO - 2015-12-16 11:30:08,033 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,033 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:30:08 INFO - 2015-12-16 11:30:08,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:30:08 INFO - 2015-12-16 11:30:08,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:30:08 INFO - 2015-12-16 11:30:08,034 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:30:08 INFO - 2015-12-16 11:30:08,034 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.4653069386122;2722.8230165039286;2755.7382048705367;2763.3229858684626;2773.4730401223765;4622.630189584834;4763.476017638066;4774.880627984302;4827.734474603895;4844.830430934918;4698.718076915387;4721.102990431816;4730;4781.426228852542;4781.689190202635;4290.292101803207;4319.935200971988;4433.157700036999;4443.089166720831;4475.239209334405;4236.068065025689;4364.607185353318;4396.274614688573;4400.537943515933;4438.4895736990175;4328.826846926119;4347.78261086946;4353.73877567347;4437.556244375537;4469.82120715171;4347.608715215614;4403.53762854902;4425.424694789689;4432.423784907941;4465.843695470676;4278.4865816102265;4352.434183556149;4353.521112677603;4354.303311470149;4379.693421460499;4620.1221767864;4642.558956899089;4706.3411122442885;4745.905081898342;4749.62003039756;5114;5122.385313762373;5159.432462429129;5162.638615296931;5199;5003.049420610072;5134.4095429025765;5170.302009228782;5190.06578815813;5199.350081239845;4671.626269898434;4682.906341873144;4690.484046754854;4732.503087175797;4798.1123492154065;5252.923150754163;5267.473252674702;5274.973625131926;5279.736013199325;5326.414094449608;4852.51474852519;5057.671251368649;5058.721770302669;5074.695518268915;5083.034223497598;5029.823956161516;5094.4141423736;5135.717535535507;5176.559992400688;5200.401953775364;5065.392152941597;5108.489151084936;5141.511556402136;5146.459621739738;5158.123119069767;4845.830395936126;4984.5513903748115;5104.464031276737;5105.591552675777;5122.129238029544;4188;4213.073123912734;4232.68254880879;4271.615554600101;4272.91454170921;3744.1762812181278;3763.6800871925643;3773.811309434572;3786.6024067473068;3801.7148713846573;4243.702940794176;4314.072474418015;4375.037491751809;4453.755043472575;4491.348754430589;4992.675476094042;5008.1486147355035;5156.458571849977;5165.225216217522;5165.940982098661;4429.49060857999;4443.511213766483;4458.286674132123;4470.24005918988;4495.64034877209;4385.210662080856;4497.6851620386915;4525.959029423251;4551.249043907785;4589.426321709786;4850.442199147002;4855.878603034882;4862.465128835825;4947.18371468718;5002.774875130555;5128.282040514406;5177.4822517749435;5184.403793563638;5191.974040129775;5197.142471492161;4900.950990490192;4915.8033678652455;4931.235658472942;4936.03747269279;4968.8757781055765;4807.302941073455;4908.11653902301;4913.729744863924;5045.621578381562;5083.186690129562;5143.254228136824;5162.612804039787;5167.095758242368;5180.7409629519125;5205.45342739007;4812.927806082982;4948.703077815343;4957.950420495749;4963.78387295115;4985.152524070989;4918.827841025547;4933.1613625683;4959.504049595012;4987.725675087905;5030.949690503048;4852.1508735971765;4859.586935110555;4866.659333846738;4874.561289483963;4894.314795928502;4780.067886762048;4836.758162091952;5021.748912554431;5061.038402703474;5092.898142037065;4866.853994380174;4912.435069966999;4960.950390496193;4964.975175124101;4983.925241121458 11:30:08 INFO - 2015-12-16 11:30:08,034 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.9519790817777;574.7586013874172;577.3995045153041;581.7927799815384;589.4547543522241;34627.48058779117;35586.82206588967;35644.287114257735;35697.82151089247;35839;39470.802645986805;40095.39856902142;40152.39771403424;40286.99282517938;40293.19413611726;7986.600669966508;8077.717279895205;8095.5952202389935;8106.797330066736;8130.75607731766;7855.567943763091;7938.44430889838;7997.080335761404;8008.199180081974;8012.1186669466315;7919.56442395668;7999.680012799481;8023.558704271263;8035.839283214332;8048.59757012147;7986.640601172932;8036.397270204729;8038.316743076845;8061.629522981108;8096.271335579767;7886.487378320448;8000.279974802295;8021.3181879539725;8057.395695322874;8098.190180981914;37255.62744372548;37526.24947501062;37562.24875502502;37639;37648.811755941046;2948.9557656635166;3032.0449058546487;3147.921301967469;3168.714815666601;3327.118313646861;27984.440311193663;28367.43265134686;28509.714902850912;28539.857300713364;28893;3288.490284005983;3320.5849268841393;3329;3441.3633477806684;3452.5339079224236;204046;204797;205333;205554;205612;50375.74812125916;51705.224421633706;53214.73392633012;53451.732741336826;53699;51070.23394649083;51245.487545124815;51588.48411515912;51716.48283517117;51965.48034519682;14537.92731036338;14630.853691463162;14783.70432591342;14800.703985920221;14821.555353339418;11056.778864422666;11135.610253641084;11181.21731478805;11190.776184476264;11197.888021119847;18409.355672551665;18735.906320468584;18751.249950001846;18803.341883034027;18882.81117188838;7378.852422951511;7568.810779730551;7646.655900484491;7671;7709.961450192825;853.2406158518924;892.4065496444791;913.4747520175926;921.7833809054866;1019.6176433837311;25600.48799024009;26444.603330950053;26539.86730066376;26549.86725066362;26788.19635410941;969.4958621516913;976.584951395654;993.3791380387258;999.14073896449;1093.4150229627112;12767.616971490685;13106.410211540504;13182.670433239246;13249.867501325056;13293.734125317633;343313;353360;354116;356407;357592;42976.57023429726;43134;43138.137237255076;43420;43612.56387436085;1210.3222195570333;1233.2970206982113;1243.8507379114565;1244.6017274472083;1249.6376050945305;25037.499250015262;25133.748662513142;25205.49589008173;25336.619950700384;25450.74549254558;36669.63330366769;36837.26325473422;37051.62948370482;37106.628933710315;37179;198984;200849;201374;201451;201940;27781.58327625047;28125;29193.7080629191;29206.7079329204;29248.707512925448;33834.323313534085;34121.317573648885;34123.65876341205;34738;34884.651153489154;29185.85407072951;29698.851505742332;29699.703002969694;29913.252168695086;30129.548056779604;28843.711562884102;29954.85022574873;31488.842555787076;31518.842405787826;32137.196570085936;31954.520682189323;32014.199645009063;32072.839635801673;34092;34473.31053378868;27610.309742256606;28584.285392864513;29894.85052574723;32173;33626.49560256647;23103.422414439774;23209.535809284058;23241.418964526023;23407.53184936326;23484.882575587013 11:30:08 INFO - 2015-12-16 11:30:08,034 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.0874552430297;325.58162760852304;341.13692358333424;341.84446077034954;343.44705024909905;13015.284159371231;15265.847341526582;15637;16095.19524023797;16562.58593535159;10114.190864730823;10187.592496300158;10229.897701022988;10316.535755890984;10331.121854642346;4516.570925762056;4668.789904454291;4672.11229866326;4679.181143299909;4686.203345431268;4715.221988371914;5152.098382783017;5152.227165925104;5154.536091751742;5175.120229560984;4830.541098595628;4970.478099799523;5004.799808007675;5098.643094983353;5109.20807274873;4843.854684359475;4913.508649135076;4970.577500912426;4978.477259887732;4984.451710311862;4974.10466116099;4980.87547811304;4991.900161996776;5005.149124648782;5011.498850114996;10206.846897296546;10291.073803357658;10346;16783.496495105166;17711.380101696377;1455.345094707386;1757.279515398693;1782.27817733818;1832.9470992488366;1895.7630296212974;8438.493690378597;8651.307895368418;8830.55847207637;9247.39891907024;10684.893151068545;1755.9912200439044;1763.4180720362249;1808.3954834801414;1824.3158815444208;1847.1503108570073;56576;57231.85536289292;57834.42165578333;58773.412265877225;59006.40993590052;9853.802923941481;9915;9982.35114717541;10019.849702254473;10085.29402941787;12712.364381780873;12716.618501444971;12719.491220351267;12758.830998730238;12769.936150319374;7204.675789589481;7217.314355136254;7258.564486130849;7329.74345897891;7432.85134297311;6950.339717726808;6983.9650801745665;6990.161180658251;7082.575045497287;7091.822704432328;4192.538820729717;4216.852410165629;4231.836245032579;4232.703710740218;4253.914921701548;1619.651774868409;1644.3997940751779;1776;1777.6890042944121;1785.8839175453554;402.81671839313043;404.69445568595523;409.4820052633421;411.44249541870334;420.8127383314457;9634.662786802428;9834.409935403899;10036.347637403545;10073.69778906634;10109.39343639384;823.1562648285436;842.9494230346199;895.0244233785075;909.5270459361095;949.188443880486;8558.400911936105;9106.681266155652;9383.906160938439;9437.245020398488;9454.196393306509;496636;497809;502610;505987;511129;69544.3045569548;70669.29330706627;74580.62709686416;74731.62634186794;74736;1071.5874388360382;1087.472575800736;1093.5188517052472;1106.1482658353023;1106.391484683421;14553.781693274397;14583.125012499284;14938.77591836145;14962.850371496581;15249.466268680542;33521.49717754187;33603;33621;34534.654653453144;34633.65366346304;44470;44824.55175448334;44847.55152448434;44887;47932;8467.830643386975;8486.61810218554;8489.702860399857;8608.268297194809;8729.170728780755;10171;10181.694549163536;10206.795864082529;10260.589576417158;10289.9485502572;12694;12712.555060573206;13165.473381065034;13735.107218030797;14111.506097286545;2955.891540672248;10680.946595266974;13076.411561479947;13437.395317210554;14069;13482.865171348161;13940.442382305;14109.717805644035;14232.928835355757;14939.775903361675;8446.619902104543;8693.174148455886;8749.781255468664;8807.779805504913;8924.241439477717;9532.237421006164;11253.887461125283;14053.297335132998;14057.297135142997;14119.717605648035 11:30:08 INFO - 2015-12-16 11:30:08,038 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1485.848467437735;1646.1275523972295;1724.491275073853;1741.338291449249;1768.5313391951136;6155.938440615592;6313.747450101991;7226.927730722691;7456.328930396263;7457.850842983144;6974.476914231427;7116.679749411276;7195.568265904049;7243.963780181105;7244.420446364278;2094.685797130431;2128.531723020933;2130.8295336373053;2131.765505794361;2134.4983928776724;2058.5985732782115;2076.948076298097;2078.0648708081426;2088.112552165331;2125.8193053590385;2040.387883634911;2049.6720524716047;2083.322920050982;2084.6768750843644;2094.696269040988;2098.5697931923996;2122.6391513442672;2123.140128248062;2124.7450305963384;2136.0281072112152;2078.5635016646524;2080.9491206940397;2105.620988222119;2106.9157233710635;2115.545157791082;7138.571685698875;7185.928140718631;7195.388391986688;7209.639518024078;7217.8556428871125;4115.8765237042935;4215.91568168638;4217.704760666724;4231.555686652888;4250.53244143144;2732.6720793504905;2751.1883994221753;2838.6451693538306;2839.7870159737895;2853.857307134635;868.0754995929315;879.090141703334;885.2298500304712;887.3078998381272;918.6738707758716;9866.65466708669;9883.505824708807;9885.703428897144;9902;9926.255530835144;3845.3270677631303;3850.8844734658005;3891.377379619304;3939.2515422069714;3951.664108550748;8404.117567655308;8489.193526614961;8504.31965442763;8530.829383412298;8544.31645468361;4264.552222016706;4281.357796330575;4283.400323954649;4296.828126874952;4316.6330861877095;3268.950965735516;3356.580427446569;3821.44589034594;3918.706097042676;3924.136689928211;3478.565179352581;3524.4713293006253;3526.559180102487;3550.804705741209;3563.518924945151;1073.3238060022293;1102.6306187427142;1103.4041617526445;1110.5169251375517;1116.2911551165068;947.507296205969;957.9808403831885;1188.8468185859701;1208.3837243005955;1233.8704436034266;6854.794356169323;6909.30906909305;6925.342092501204;6929.41100006495;6957.686904089328;443.16463466366133;449.03681602961467;449.2161178743114;449.2587231068763;451.7425067711373;5195.3246078009615;5219.373675159005;5237.109691352479;5254.448282930237;5284.947150528523;8670.86993695095;8770.07914169003;8777.824443511221;8839.381243312906;8898.510581918057;8547;8698.13018698125;8716.738497845075;8723.040465548784;8769.824603508021;6804.76183333581;6841.3842754152365;6852.6231057292325;6861.725530978705;6879.380855722909;6448.871022579428;6549.6070235786;6570.507211959218;6605.702743376656;6608.273089960197;7681.884771728317;7762.107357653942;7850.764477065697;7893.210678932061;7938.801529961797;7905.446618736633;7926.326262267772;7995.9200407997505;8003.759887203393;8063.717769878026;5427.945720542902;5507.568032311708;5663.5469162467725;6250.593711408744;6276.403741644536;6854.040434339297;6885.552439091443;6927.896081558882;6954.652267386711;6982.33667801558;6450.7097180627925;6451.580647257913;6545.509086818603;6595.208574971034;6675.866482670416;6172.351903050115;6223.813285601439;6304.054391841077;6508.642024688687;6569.540132190892;6438.903416448663;6571.671416429255;6572.211334639874;6577.408033277028;6579.374959378852;5949;5960.314563825215;5960.642361458153;6028.969855150696;6062.454379105901;6204.348543402878;6216.564840461305;6221.626702397871;6227.1282020516255;6237.064440333805 11:30:08 INFO - 2015-12-16 11:30:08,039 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.3872100914135;307.1354138101245;309.63927025015846;310.84302427274224;311.8066798584877;5514.972425137874;5532.529734972532;5571.888562228758;5691.117876729114;5695.515881150102;5526.171074338851;5614.652483403974;5640.915386269209;5643.68959707216;5644.830655080344;4145.212409642173;4256.4679415073115;4270.039241170727;4273.358996150571;4284.871453856374;4256.2764330063965;4261.637760790337;4263.062126332202;4263.253930562155;4290.249206388885;4231.767252801094;4265.274903266437;4267.466566679165;4272;4286.892827679302;4259.297215959378;4268.125034367947;4277.807498662568;4286.699931004831;4290.313549832012;3614.0964758810296;3719.1445967427644;3734.25314937011;3736.084659258499;3738.981305093457;5222.164453687392;5364.034473794715;5368.8389348319615;5375.43557926416;5382.2464854920345;4859.489753575859;4881.219004959189;4888.780004899788;4889.4377146627885;4892.926606100911;5829.387914268983;5873.1190321451695;5877.79427720032;5883.646981181143;5902.675352855591;3904.668103211202;3997.600239976008;4025.0742329264435;4031.496062992126;4050.8177132028836;6109.175261339707;6178.845528861814;6187.133801267826;6190.133381326663;6210.534209934273;4149.6265336119895;4168.270552653274;4175.874723758231;4177.26897792885;4194.538600753915;4229.936550951738;4238.660907127422;4241.448611680524;4247.66018718508;4253.064325848309;4761.262004389256;4833.9033219335415;4867.513248675175;4877.878053048702;4882.731449770296;5840.182374467578;5846.561507886926;5854.063349864001;5855.912161317584;5861.325947516005;1467.8458761830068;1482.5255918106318;1484.5249520153664;1484.5768955847532;1486.762118061105;986.9605215791288;994.0606127209862;995.9452230127267;997.5261750668375;1015.0103648942222;5126.512981266774;5132.204508301219;5144.6398752087;5147.2279158126585;5149.2791009258735;6062.9996050652035;6090;6111.54163437735;6119.847003824851;6136.693165341804;5057.949420505822;5066.06277838601;5148.099082660519;5148.794048238104;5153.845384638467;3184.2994541200896;3277.7050065493745;3282.7537934654997;3327.085051610826;3332.3501917125927;5583.609147359646;5728.05487094633;5803.665157013826;5815.534757219412;5843.853903652358;6135.509159267248;6308.243010838729;6355.936440635627;6390.520710946697;6391.07329437229;5821.854453638608;5823.388544202882;5826.766929322865;5828.825135245949;5836.824895253149;5929.407059294036;6142.815715528542;6167;6181.96909015452;6182.103594978793;6022.126791615104;6027.849303767265;6036.3058248302;6037.305709843248;6040.607360521552;5828.154917537018;5846.386129456346;5849.064149736022;5854.297484301911;5854.541092741144;4098.3852422136915;4135.29699951003;4138.151678905877;4139.97930010348;4145.958540414678;6040.577159598962;6115.4190351916495;6149.354317796567;6151.231096112986;6167.136600875791;5881.647101173943;5882.823515294548;5884.882302354014;5896.852578685567;5906.822795316148;5899.528037756883;5927.496162826035;5929.377415371497;5933.643981361132;5947.494462970523;5664.716764161858;5789.45000224978;5793.333766616893;5795.681237531976;5822.155787410887;5958.344582096052;5985.700714964148;5991.970040149771;5994.310654274815;5998;5805.82582522525;5835.824925252249;5841.386654401226;5841.50347220491;5850.414958504286 11:30:08 INFO - 2015-12-16 11:30:08,040 DEBUG : BROWSER_OUTPUT: |5;yui.html;774.6862520679124;779.5517577393;787.090909998951;789.3882241263024;790.9841803163937;11573.247738896966;11787.882121178785;11792.46933887975;11851.466683999219;11860.881391186085;11383.203175777699;11548.942255288734;11551.422428878543;11575.189736718434;11634.243774154675;807.0839597057353;825.1171246765963;826.8057006603474;827.3753316246226;827.9130691277419;803.2730379006979;816.5019338203691;816.542736067804;817.235884448043;818.1450384348341;848.3637272045966;861.7673228228375;862.5816479007676;863.7883718488979;863.8920134983127;847.2078606502909;848.7326492154951;853.7566793463833;853.9914600853974;856.2807241916757;629.6568370238231;634.5272771785003;636.6689321552813;636.7325723196269;637.3339859846425;11810.291382517076;11883.58407455735;11946.581869634609;11951.462184201644;11981.46083426248;10839.349639021684;10998.34009959405;11397.430128493543;11432.48553815072;11792.23350482216;9571.61713531465;9630.855537166948;9673.854892176623;9696.70909872705;9794.118529332394;3263.1352691536763;3304.074859039473;3306.6528014558608;3317.950230746541;3399.6940275375086;34671.13322166966;34861.477077843854;37472.43791343132;37734.81132594347;38170.61829381698;8459.407841451039;8832.77918052041;9161.587728552231;9235.12266334697;9512.524373781283;15407.691846163014;15464.14947177916;15509.612259693598;15552.766708499381;15576.221188940508;6272.905906411407;6274.905876411857;6334.334894835976;6426.453751431087;6477;3554.662307080823;3633.6184700606586;3641.7814931104217;3660.7071434285194;3704.2961837250837;2498.9750102499106;2513.698356197268;2521.2814347911126;2525.7726804587674;2526.886290116949;456.51609294148307;460.2980454806447;460.78573463339706;465.48098869759974;470.3203870407297;583.3932709981657;588.6291636269123;608.7108623403936;629.9748010079545;631.1778015958084;7433.219511951275;7690.384769218561;7815.843683126305;7822.256885595859;7855.175206603224;529.5472371122712;560.9943900561024;588.8174665853599;609.6677310865589;624.9562530622812;3487.1979444727854;3715.108373990277;3747.0819649186124;3830.1190726133145;3838.0788610733225;45887.31169032467;46114;46504.5349546507;48984.265236021485;49197.754011229714;38495;38525.80737096297;38790.61209387927;40273.798631006655;42907.35638965418;39176.41235381472;39892.40161397582;43749;43793.78103109464;44084.779576101915;7415.480916335805;7658.310752032344;7757.263060009516;7875.921240787748;7896.960515197387;29507.85246073756;29673.25816854596;31691.84154079215;32487.350252994336;32849.83575082109;34273.31453370969;34591.481127783605;34768.47847282344;35449.93650190499;35804.64195358013;10213.33613315132;10261.435621040615;10308.484575771032;10336.741581460223;10551.630692925712;11052.944735276595;11298.661040168809;11394.544218231178;11587;11716.531338746354;10741.140708743438;10813.729656758644;10971.83542246851;11133.165012624248;11144.2199046066;10691.8930810694;10997.395143267197;11026.283291586022;11401.885981140082;11480.82778758336;10694;10761.30051546647;10870.456477176267;10968.780624387628;11137.164712646421;9065.365424420228;9246.214071803972;9249.768755781159;9519.619215231312;9544.809103818023;8817.470951742916;9108;9140.63437462494;9234.538273086184;9526.285528585522 11:30:08 INFO - 2015-12-16 11:30:08,040 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:30:08 INFO - 2015-12-16 11:30:08,040 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,313 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294208027__endTimestamp 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,041 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4717.96 Median:4852.51 stddev:497.09 (10.2%) stddev-sans-first:472.03 11:30:08 INFO - 2015-12-16 11:30:08,042 DEBUG : BROWSER_OUTPUT: Values: 2673.5 2722.8 2755.7 2763.3 2773.5 4622.6 4763.5 4774.9 4827.7 4844.8 4698.7 4721.1 4730.0 4781.4 4781.7 4290.3 4319.9 4433.2 4443.1 4475.2 4236.1 4364.6 4396.3 4400.5 4438.5 4328.8 4347.8 4353.7 4437.6 4469.8 4347.6 4403.5 4425.4 4432.4 4465.8 4278.5 4352.4 4353.5 4354.3 4379.7 4620.1 4642.6 4706.3 4745.9 4749.6 5114.0 5122.4 5159.4 5162.6 5199.0 5003.0 5134.4 5170.3 5190.1 5199.4 4671.6 4682.9 4690.5 4732.5 4798.1 5252.9 5267.5 5275.0 5279.7 5326.4 4852.5 5057.7 5058.7 5074.7 5083.0 5029.8 5094.4 5135.7 5176.6 5200.4 5065.4 5108.5 5141.5 5146.5 5158.1 4845.8 4984.6 5104.5 5105.6 5122.1 4188.0 4213.1 4232.7 4271.6 4272.9 3744.2 3763.7 3773.8 3786.6 3801.7 4243.7 4314.1 4375.0 4453.8 4491.3 4992.7 5008.1 5156.5 5165.2 5165.9 4429.5 4443.5 4458.3 4470.2 4495.6 4385.2 4497.7 4526.0 4551.2 4589.4 4850.4 4855.9 4862.5 4947.2 5002.8 5128.3 5177.5 5184.4 5192.0 5197.1 4901.0 4915.8 4931.2 4936.0 4968.9 4807.3 4908.1 4913.7 5045.6 5083.2 5143.3 5162.6 5167.1 5180.7 5205.5 4812.9 4948.7 4958.0 4963.8 4985.2 4918.8 4933.2 4959.5 4987.7 5030.9 4852.2 4859.6 4866.7 4874.6 4894.3 4780.1 4836.8 5021.7 5061.0 5092.9 4866.9 4912.4 4961.0 4965.0 4983.9 11:30:08 INFO - 2015-12-16 11:30:08,042 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,042 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40614.10 Median:34122.49 stddev:68984.98 (202.2%) stddev-sans-first:69112.97 11:30:08 INFO - 2015-12-16 11:30:08,043 DEBUG : BROWSER_OUTPUT: Values: 565.0 574.8 577.4 581.8 589.5 34627.5 35586.8 35644.3 35697.8 35839.0 39470.8 40095.4 40152.4 40287.0 40293.2 7986.6 8077.7 8095.6 8106.8 8130.8 7855.6 7938.4 7997.1 8008.2 8012.1 7919.6 7999.7 8023.6 8035.8 8048.6 7986.6 8036.4 8038.3 8061.6 8096.3 7886.5 8000.3 8021.3 8057.4 8098.2 37255.6 37526.2 37562.2 37639.0 37648.8 2949.0 3032.0 3147.9 3168.7 3327.1 27984.4 28367.4 28509.7 28539.9 28893.0 3288.5 3320.6 3329.0 3441.4 3452.5 204046.0 204797.0 205333.0 205554.0 205612.0 50375.7 51705.2 53214.7 53451.7 53699.0 51070.2 51245.5 51588.5 51716.5 51965.5 14537.9 14630.9 14783.7 14800.7 14821.6 11056.8 11135.6 11181.2 11190.8 11197.9 18409.4 18735.9 18751.2 18803.3 18882.8 7378.9 7568.8 7646.7 7671.0 7710.0 853.2 892.4 913.5 921.8 1019.6 25600.5 26444.6 26539.9 26549.9 26788.2 969.5 976.6 993.4 999.1 1093.4 12767.6 13106.4 13182.7 13249.9 13293.7 343313.0 353360.0 354116.0 356407.0 357592.0 42976.6 43134.0 43138.1 43420.0 43612.6 1210.3 1233.3 1243.9 1244.6 1249.6 25037.5 25133.7 25205.5 25336.6 25450.7 36669.6 36837.3 37051.6 37106.6 37179.0 198984.0 200849.0 201374.0 201451.0 201940.0 27781.6 28125.0 29193.7 29206.7 29248.7 33834.3 34121.3 34123.7 34738.0 34884.7 29185.9 29698.9 29699.7 29913.3 30129.5 28843.7 29954.9 31488.8 31518.8 32137.2 31954.5 32014.2 32072.8 34092.0 34473.3 27610.3 28584.3 29894.9 32173.0 33626.5 23103.4 23209.5 23241.4 23407.5 23484.9 11:30:08 INFO - 2015-12-16 11:30:08,043 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,043 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26304.70 Median:2318.83 stddev:82268.33 (3547.8%) stddev-sans-first:82475.98 11:30:08 INFO - 2015-12-16 11:30:08,043 DEBUG : BROWSER_OUTPUT: Values: 323.1 325.6 341.1 341.8 343.4 13015.3 15265.8 15637.0 16095.2 16562.6 10114.2 10187.6 10229.9 10316.5 10331.1 4516.6 4668.8 4672.1 4679.2 4686.2 4715.2 5152.1 5152.2 5154.5 5175.1 4830.5 4970.5 5004.8 5098.6 5109.2 4843.9 4913.5 4970.6 4978.5 4984.5 4974.1 4980.9 4991.9 5005.1 5011.5 10206.8 10291.1 10346.0 16783.5 17711.4 1455.3 1757.3 1782.3 1832.9 1895.8 8438.5 8651.3 8830.6 9247.4 10684.9 1756.0 1763.4 1808.4 1824.3 1847.2 56576.0 57231.9 57834.4 58773.4 59006.4 9853.8 9915.0 9982.4 10019.8 10085.3 12712.4 12716.6 12719.5 12758.8 12769.9 7204.7 7217.3 7258.6 7329.7 7432.9 6950.3 6984.0 6990.2 7082.6 7091.8 4192.5 4216.9 4231.8 4232.7 4253.9 1619.7 1644.4 1776.0 1777.7 1785.9 402.8 404.7 409.5 411.4 420.8 9634.7 9834.4 10036.3 10073.7 10109.4 823.2 842.9 895.0 909.5 949.2 8558.4 9106.7 9383.9 9437.2 9454.2 496636.0 497809.0 502610.0 505987.0 511129.0 69544.3 70669.3 74580.6 74731.6 74736.0 1071.6 1087.5 1093.5 1106.1 1106.4 14553.8 14583.1 14938.8 14962.9 15249.5 33521.5 33603.0 33621.0 34534.7 34633.7 44470.0 44824.6 44847.6 44887.0 47932.0 8467.8 8486.6 8489.7 8608.3 8729.2 10171.0 10181.7 10206.8 10260.6 10289.9 12694.0 12712.6 13165.5 13735.1 14111.5 2955.9 10680.9 13076.4 13437.4 14069.0 13482.9 13940.4 14109.7 14232.9 14939.8 8446.6 8693.2 8749.8 8807.8 8924.2 9532.2 11253.9 14053.3 14057.3 14119.7 11:30:08 INFO - 2015-12-16 11:30:08,044 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,044 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5027.86 Median:6222.72 stddev:2642.86 (42.5%) stddev-sans-first:2636.87 11:30:08 INFO - 2015-12-16 11:30:08,044 DEBUG : BROWSER_OUTPUT: Values: 1485.8 1646.1 1724.5 1741.3 1768.5 6155.9 6313.7 7226.9 7456.3 7457.9 6974.5 7116.7 7195.6 7244.0 7244.4 2094.7 2128.5 2130.8 2131.8 2134.5 2058.6 2076.9 2078.1 2088.1 2125.8 2040.4 2049.7 2083.3 2084.7 2094.7 2098.6 2122.6 2123.1 2124.7 2136.0 2078.6 2080.9 2105.6 2106.9 2115.5 7138.6 7185.9 7195.4 7209.6 7217.9 4115.9 4215.9 4217.7 4231.6 4250.5 2732.7 2751.2 2838.6 2839.8 2853.9 868.1 879.1 885.2 887.3 918.7 9866.7 9883.5 9885.7 9902.0 9926.3 3845.3 3850.9 3891.4 3939.3 3951.7 8404.1 8489.2 8504.3 8530.8 8544.3 4264.6 4281.4 4283.4 4296.8 4316.6 3269.0 3356.6 3821.4 3918.7 3924.1 3478.6 3524.5 3526.6 3550.8 3563.5 1073.3 1102.6 1103.4 1110.5 1116.3 947.5 958.0 1188.8 1208.4 1233.9 6854.8 6909.3 6925.3 6929.4 6957.7 443.2 449.0 449.2 449.3 451.7 5195.3 5219.4 5237.1 5254.4 5284.9 8670.9 8770.1 8777.8 8839.4 8898.5 8547.0 8698.1 8716.7 8723.0 8769.8 6804.8 6841.4 6852.6 6861.7 6879.4 6448.9 6549.6 6570.5 6605.7 6608.3 7681.9 7762.1 7850.8 7893.2 7938.8 7905.4 7926.3 7995.9 8003.8 8063.7 5427.9 5507.6 5663.5 6250.6 6276.4 6854.0 6885.6 6927.9 6954.7 6982.3 6450.7 6451.6 6545.5 6595.2 6675.9 6172.4 6223.8 6304.1 6508.6 6569.5 6438.9 6571.7 6572.2 6577.4 6579.4 5949.0 5960.3 5960.6 6029.0 6062.5 6204.3 6216.6 6221.6 6227.1 6237.1 11:30:08 INFO - 2015-12-16 11:30:08,044 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,044 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4871.07 Median:5599.13 stddev:1456.13 (26.0%) stddev-sans-first:1419.22 11:30:08 INFO - 2015-12-16 11:30:08,045 DEBUG : BROWSER_OUTPUT: Values: 300.4 307.1 309.6 310.8 311.8 5515.0 5532.5 5571.9 5691.1 5695.5 5526.2 5614.7 5640.9 5643.7 5644.8 4145.2 4256.5 4270.0 4273.4 4284.9 4256.3 4261.6 4263.1 4263.3 4290.2 4231.8 4265.3 4267.5 4272.0 4286.9 4259.3 4268.1 4277.8 4286.7 4290.3 3614.1 3719.1 3734.3 3736.1 3739.0 5222.2 5364.0 5368.8 5375.4 5382.2 4859.5 4881.2 4888.8 4889.4 4892.9 5829.4 5873.1 5877.8 5883.6 5902.7 3904.7 3997.6 4025.1 4031.5 4050.8 6109.2 6178.8 6187.1 6190.1 6210.5 4149.6 4168.3 4175.9 4177.3 4194.5 4229.9 4238.7 4241.4 4247.7 4253.1 4761.3 4833.9 4867.5 4877.9 4882.7 5840.2 5846.6 5854.1 5855.9 5861.3 1467.8 1482.5 1484.5 1484.6 1486.8 987.0 994.1 995.9 997.5 1015.0 5126.5 5132.2 5144.6 5147.2 5149.3 6063.0 6090.0 6111.5 6119.8 6136.7 5057.9 5066.1 5148.1 5148.8 5153.8 3184.3 3277.7 3282.8 3327.1 3332.4 5583.6 5728.1 5803.7 5815.5 5843.9 6135.5 6308.2 6355.9 6390.5 6391.1 5821.9 5823.4 5826.8 5828.8 5836.8 5929.4 6142.8 6167.0 6182.0 6182.1 6022.1 6027.8 6036.3 6037.3 6040.6 5828.2 5846.4 5849.1 5854.3 5854.5 4098.4 4135.3 4138.2 4140.0 4146.0 6040.6 6115.4 6149.4 6151.2 6167.1 5881.6 5882.8 5884.9 5896.9 5906.8 5899.5 5927.5 5929.4 5933.6 5947.5 5664.7 5789.5 5793.3 5795.7 5822.2 5958.3 5985.7 5992.0 5994.3 5998.0 5805.8 5835.8 5841.4 5841.5 5850.4 11:30:08 INFO - 2015-12-16 11:30:08,045 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,046 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11873.19 Median:41590.58 stddev:12960.92 (31.2%) stddev-sans-first:12970.48 11:30:08 INFO - 2015-12-16 11:30:08,046 DEBUG : BROWSER_OUTPUT: Values: 774.7 779.6 787.1 789.4 791.0 11573.2 11787.9 11792.5 11851.5 11860.9 11383.2 11548.9 11551.4 11575.2 11634.2 807.1 825.1 826.8 827.4 827.9 803.3 816.5 816.5 817.2 818.1 848.4 861.8 862.6 863.8 863.9 847.2 848.7 853.8 854.0 856.3 629.7 634.5 636.7 636.7 637.3 11810.3 11883.6 11946.6 11951.5 11981.5 10839.3 10998.3 11397.4 11432.5 11792.2 9571.6 9630.9 9673.9 9696.7 9794.1 3263.1 3304.1 3306.7 3318.0 3399.7 34671.1 34861.5 37472.4 37734.8 38170.6 8459.4 8832.8 9161.6 9235.1 9512.5 15407.7 15464.1 15509.6 15552.8 15576.2 6272.9 6274.9 6334.3 6426.5 6477.0 3554.7 3633.6 3641.8 3660.7 3704.3 2499.0 2513.7 2521.3 2525.8 2526.9 456.5 460.3 460.8 465.5 470.3 583.4 588.6 608.7 630.0 631.2 7433.2 7690.4 7815.8 7822.3 7855.2 529.5 561.0 588.8 609.7 625.0 3487.2 3715.1 3747.1 3830.1 3838.1 45887.3 46114.0 46504.5 48984.3 49197.8 38495.0 38525.8 38790.6 40273.8 42907.4 39176.4 39892.4 43749.0 43793.8 44084.8 7415.5 7658.3 7757.3 7875.9 7897.0 29507.9 29673.3 31691.8 32487.4 32849.8 34273.3 34591.5 34768.5 35449.9 35804.6 10213.3 10261.4 10308.5 10336.7 10551.6 11052.9 11298.7 11394.5 11587.0 11716.5 10741.1 10813.7 10971.8 11133.2 11144.2 10691.9 10997.4 11026.3 11401.9 11480.8 10694.0 10761.3 10870.5 10968.8 11137.2 9065.4 9246.2 9249.8 9519.6 9544.8 8817.5 9108.0 9140.6 9234.5 9526.3 11:30:08 INFO - 2015-12-16 11:30:08,046 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:30:08 INFO - 2015-12-16 11:30:08,046 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-12-16 11:30:08,868 INFO : Browser exited with error code: 0 11:30:08 INFO - 2015-12-16 11:30:08,887 INFO : Completed test dromaeo_css (00:18:35) 11:30:08 INFO - 2015-12-16 11:30:08,887 INFO : Starting test kraken 11:30:08 INFO - 2015-12-16 11:30:08,887 DEBUG : operating with platform_type : linux_ 11:30:08 INFO - 2015-12-16 11:30:08,887 INFO : Initialising browser for kraken test... 11:30:08 INFO - 2015-12-16 11:30:08,893 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepbuFg/profile http://localhost:57921/getInfo.html 11:30:14 INFO - 2015-12-16 11:30:14,165 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:30:14 INFO - 2015-12-16 11:30:14,165 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:30:14 INFO - 2015-12-16 11:30:14,165 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:30:14 INFO - 2015-12-16 11:30:14,165 DEBUG : BROWSER_OUTPUT: __metrics 11:30:14 INFO - 2015-12-16 11:30:14,281 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] 11:30:15 INFO - 2015-12-16 11:30:15,244 INFO : Browser initialized. 11:30:15 INFO - 2015-12-16 11:30:15,245 INFO : Running cycle 1/1 for kraken test... 11:30:15 INFO - 2015-12-16 11:30:15,245 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepbuFg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:30:27 INFO - 2015-12-16 11:30:27,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 143990784 11:30:27 INFO - 2015-12-16 11:30:27,326 DEBUG : BROWSER_OUTPUT: 11:30:29 INFO - 2015-12-16 11:30:29,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57921/tests/kraken/driver.html?testName=audio-beat-detection) 11:30:30 INFO - 2015-12-16 11:30:30,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 144216064 11:30:30 INFO - 2015-12-16 11:30:30,539 DEBUG : BROWSER_OUTPUT: 11:30:33 INFO - 2015-12-16 11:30:33,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57921/tests/kraken/driver.html?testName=audio-dft) 11:30:33 INFO - 2015-12-16 11:30:33,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 143343616 11:30:33 INFO - 2015-12-16 11:30:33,910 DEBUG : BROWSER_OUTPUT: 11:30:36 INFO - 2015-12-16 11:30:36,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57921/tests/kraken/driver.html?testName=audio-fft) 11:30:37 INFO - 2015-12-16 11:30:37,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 138039296 11:30:37 INFO - 2015-12-16 11:30:37,433 DEBUG : BROWSER_OUTPUT: 11:30:39 INFO - 2015-12-16 11:30:39,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57921/tests/kraken/driver.html?testName=audio-oscillator) 11:30:40 INFO - 2015-12-16 11:30:40,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 139190272 11:30:40 INFO - 2015-12-16 11:30:40,095 DEBUG : BROWSER_OUTPUT: 11:30:42 INFO - 2015-12-16 11:30:42,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57921/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:30:42 INFO - 2015-12-16 11:30:42,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 139165696 11:30:42 INFO - 2015-12-16 11:30:42,940 DEBUG : BROWSER_OUTPUT: 11:30:46 INFO - 2015-12-16 11:30:46,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57921/tests/kraken/driver.html?testName=imaging-darkroom) 11:30:46 INFO - 2015-12-16 11:30:46,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 140488704 11:30:46 INFO - 2015-12-16 11:30:46,605 DEBUG : BROWSER_OUTPUT: 11:30:50 INFO - 2015-12-16 11:30:50,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57921/tests/kraken/driver.html?testName=imaging-desaturate) 11:30:50 INFO - 2015-12-16 11:30:50,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 137867264 11:30:50 INFO - 2015-12-16 11:30:50,695 DEBUG : BROWSER_OUTPUT: 11:30:53 INFO - 2015-12-16 11:30:53,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57921/tests/kraken/driver.html?testName=json-parse-financial) 11:30:54 INFO - 2015-12-16 11:30:54,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 139591680 11:30:54 INFO - 2015-12-16 11:30:54,180 DEBUG : BROWSER_OUTPUT: 11:30:55 INFO - 2015-12-16 11:30:55,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57921/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:30:56 INFO - 2015-12-16 11:30:56,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 140943360 11:30:56 INFO - 2015-12-16 11:30:56,543 DEBUG : BROWSER_OUTPUT: 11:30:58 INFO - 2015-12-16 11:30:58,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:30:59 INFO - 2015-12-16 11:30:59,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 139898880 11:30:59 INFO - 2015-12-16 11:30:59,052 DEBUG : BROWSER_OUTPUT: 11:31:01 INFO - 2015-12-16 11:31:01,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:01 INFO - 2015-12-16 11:31:01,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 140197888 11:31:01 INFO - 2015-12-16 11:31:01,827 DEBUG : BROWSER_OUTPUT: 11:31:04 INFO - 2015-12-16 11:31:04,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:05 INFO - 2015-12-16 11:31:05,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 140333056 11:31:05 INFO - 2015-12-16 11:31:05,010 DEBUG : BROWSER_OUTPUT: 11:31:07 INFO - 2015-12-16 11:31:07,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:08 INFO - 2015-12-16 11:31:08,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 141045760 11:31:08 INFO - 2015-12-16 11:31:08,301 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57921/tests/kraken/driver.html?testName=ai-astar) 11:31:10 INFO - 2015-12-16 11:31:10,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 139898880 11:31:10 INFO - 2015-12-16 11:31:10,341 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,341 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:31:10 INFO - 2015-12-16 11:31:10,342 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:31:10 INFO - 2015-12-16 11:31:10,342 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:31:10 INFO - 2015-12-16 11:31:10,342 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:31:10 INFO - 2015-12-16 11:31:10,342 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;117;113;115;127;116;115;115;116 11:31:10 INFO - 2015-12-16 11:31:10,342 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;130;155;168;132;155;165;138;183;136 11:31:10 INFO - 2015-12-16 11:31:10,342 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;164;162;166;165;168;165;165;167 11:31:10 INFO - 2015-12-16 11:31:10,342 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;74;76;73;76;143;73;73;72 11:31:10 INFO - 2015-12-16 11:31:10,343 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;145;95;97;95;133;95;97;133 11:31:10 INFO - 2015-12-16 11:31:10,343 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;112;110;110;110;111;110;110;111;110 11:31:10 INFO - 2015-12-16 11:31:10,343 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;149;148;148;147;147;147;147;148 11:31:10 INFO - 2015-12-16 11:31:10,343 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;98;96;95;96;95;96;96 11:31:10 INFO - 2015-12-16 11:31:10,343 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;74;73;77;74;73;73;76;72 11:31:10 INFO - 2015-12-16 11:31:10,343 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;68;69;68;68;69;68 11:31:10 INFO - 2015-12-16 11:31:10,344 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;87;94;90;87;86;86;85;85;86 11:31:10 INFO - 2015-12-16 11:31:10,344 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;122;124;126;123;123;135;136;129;130 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;158;152;155;152;147;152;156;161;142 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;76;73;75;72;70;70;72;71;72;72 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,774 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294270340__endTimestamp 11:31:10 INFO - 2015-12-16 11:31:10,345 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.80 Median:115.50 stddev:4.39 (3.8%) stddev-sans-first:4.61 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 117.0 113.0 115.0 127.0 116.0 115.0 115.0 116.0 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.40 Median:155.00 stddev:17.44 (11.2%) stddev-sans-first:18.49 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: Values: 152.0 130.0 155.0 168.0 132.0 155.0 165.0 138.0 183.0 136.0 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,347 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:1.79 (1.1%) stddev-sans-first:1.76 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 164.0 162.0 166.0 165.0 168.0 165.0 165.0 167.0 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:73.50 stddev:21.93 (29.8%) stddev-sans-first:23.08 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 74.0 76.0 73.0 76.0 143.0 73.0 73.0 72.0 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.10 Median:95.00 stddev:20.22 (21.3%) stddev-sans-first:20.97 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 145.0 95.0 97.0 95.0 133.0 95.0 97.0 133.0 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 110.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 11:31:10 INFO - 2015-12-16 11:31:10,348 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,350 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 11:31:10 INFO - 2015-12-16 11:31:10,350 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 149.0 148.0 148.0 147.0 147.0 147.0 147.0 148.0 11:31:10 INFO - 2015-12-16 11:31:10,350 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,350 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 11:31:10 INFO - 2015-12-16 11:31:10,350 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 98.0 96.0 95.0 96.0 95.0 96.0 96.0 11:31:10 INFO - 2015-12-16 11:31:10,350 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:74.00 stddev:1.52 (2.1%) stddev-sans-first:1.58 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 74.0 73.0 77.0 74.0 73.0 73.0 76.0 72.0 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 68.0 69.0 68.0 68.0 69.0 68.0 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.00 stddev:3.46 (4.0%) stddev-sans-first:2.92 11:31:10 INFO - 2015-12-16 11:31:10,351 DEBUG : BROWSER_OUTPUT: Values: 94.0 87.0 94.0 90.0 87.0 86.0 86.0 85.0 85.0 86.0 11:31:10 INFO - 2015-12-16 11:31:10,352 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,352 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:129.50 stddev:5.03 (3.9%) stddev-sans-first:5.27 11:31:10 INFO - 2015-12-16 11:31:10,352 DEBUG : BROWSER_OUTPUT: Values: 130.0 122.0 124.0 126.0 123.0 123.0 135.0 136.0 129.0 130.0 11:31:10 INFO - 2015-12-16 11:31:10,352 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,352 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.70 Median:153.50 stddev:5.40 (3.5%) stddev-sans-first:5.72 11:31:10 INFO - 2015-12-16 11:31:10,352 DEBUG : BROWSER_OUTPUT: Values: 152.0 158.0 152.0 155.0 152.0 147.0 152.0 156.0 161.0 142.0 11:31:10 INFO - 2015-12-16 11:31:10,353 DEBUG : BROWSER_OUTPUT: 11:31:10 INFO - 2015-12-16 11:31:10,353 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:1.95 (2.7%) stddev-sans-first:1.54 11:31:10 INFO - 2015-12-16 11:31:10,353 DEBUG : BROWSER_OUTPUT: Values: 76.0 73.0 75.0 72.0 70.0 70.0 72.0 71.0 72.0 72.0 11:31:10 INFO - 2015-12-16 11:31:10,353 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:31:10 INFO - 2015-12-16 11:31:10,353 DEBUG : BROWSER_OUTPUT: 11:31:11 INFO - 2015-12-16 11:31:11,336 INFO : Browser exited with error code: 0 11:31:11 INFO - 2015-12-16 11:31:11,390 INFO : Completed test kraken (00:01:02) 11:31:11 INFO - 2015-12-16 11:31:11,391 INFO : Starting test v8_7 11:31:11 INFO - 2015-12-16 11:31:11,391 DEBUG : operating with platform_type : linux_ 11:31:11 INFO - 2015-12-16 11:31:11,391 INFO : Initialising browser for v8_7 test... 11:31:11 INFO - 2015-12-16 11:31:11,397 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJr2_r/profile http://localhost:57921/getInfo.html 11:31:16 INFO - 2015-12-16 11:31:16,845 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:31:16 INFO - 2015-12-16 11:31:16,845 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:31:16 INFO - 2015-12-16 11:31:16,845 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:31:16 INFO - 2015-12-16 11:31:16,845 DEBUG : BROWSER_OUTPUT: __metrics 11:31:17 INFO - 2015-12-16 11:31:17,022 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] 11:31:18 INFO - 2015-12-16 11:31:18,064 INFO : Browser initialized. 11:31:18 INFO - 2015-12-16 11:31:18,065 INFO : Running cycle 1/1 for v8_7 test... 11:31:18 INFO - 2015-12-16 11:31:18,065 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJr2_r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:31:30 INFO - 2015-12-16 11:31:30,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 143425536 11:31:30 INFO - 2015-12-16 11:31:30,118 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57921/tests/v8_7/run.html (next: http://localhost:57921/tests/v8_7/run.html) 11:31:51 INFO - 2015-12-16 11:31:51,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 11:31:51 INFO - 2015-12-16 11:31:51,822 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,823 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:31:51 INFO - 2015-12-16 11:31:51,823 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:31:51 INFO - 2015-12-16 11:31:51,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:31:51 INFO - 2015-12-16 11:31:51,824 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:31:51 INFO - 2015-12-16 11:31:51,824 DEBUG : BROWSER_OUTPUT: |0;Richards;167.64459346186086 11:31:51 INFO - 2015-12-16 11:31:51,824 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.08113137327874 11:31:51 INFO - 2015-12-16 11:31:51,824 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 11:31:51 INFO - 2015-12-16 11:31:51,824 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 11:31:51 INFO - 2015-12-16 11:31:51,824 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1089.3246187363834 11:31:51 INFO - 2015-12-16 11:31:51,825 DEBUG : BROWSER_OUTPUT: |5;Earley;713.7758743754462 11:31:51 INFO - 2015-12-16 11:31:51,825 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 11:31:51 INFO - 2015-12-16 11:31:51,825 DEBUG : BROWSER_OUTPUT: |7;RegExp;26684.21052631579 11:31:51 INFO - 2015-12-16 11:31:51,825 DEBUG : BROWSER_OUTPUT: |8;Splay;596.210775606868 11:31:51 INFO - 2015-12-16 11:31:51,825 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 11:31:51 INFO - 2015-12-16 11:31:51,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:31:51 INFO - 2015-12-16 11:31:51,826 DEBUG : BROWSER_OUTPUT: __startTimestamp1450294311822__endTimestamp 11:31:51 INFO - 2015-12-16 11:31:51,826 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,826 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:31:51 INFO - 2015-12-16 11:31:51,827 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:31:51 INFO - 2015-12-16 11:31:51,827 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: Values: 167.6 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.08 Median:186.08 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: Values: 186.1 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: Values: 277.9 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,828 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: Values: 5202.1 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1089.32 Median:1089.32 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: Values: 1089.3 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: Values: 713.8 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: Values: 12345.7 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26684.21 Median:26684.21 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,829 DEBUG : BROWSER_OUTPUT: Values: 26684.2 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:596.21 Median:596.21 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: Values: 596.2 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: Values: 4850.2 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:31:51 INFO - 2015-12-16 11:31:51,830 DEBUG : BROWSER_OUTPUT: 11:31:52 INFO - 2015-12-16 11:31:52,828 INFO : Browser exited with error code: 0 11:31:52 INFO - 2015-12-16 11:31:52,843 INFO : Completed test v8_7 (00:00:41) 11:31:53 INFO - 2015-12-16 11:31:53,332 INFO : Completed test suite (00:20:19) 11:31:53 INFO - 2015-12-16 11:31:53,332 DEBUG : Working with test: dromaeo_css 11:31:53 INFO - 2015-12-16 11:31:53,332 DEBUG : Generating results file: dromaeo_css 11:31:53 INFO - 2015-12-16 11:31:53,333 DEBUG : Working with test: kraken 11:31:53 INFO - 2015-12-16 11:31:53,334 DEBUG : Generating results file: kraken 11:31:53 INFO - 2015-12-16 11:31:53,334 INFO : javascript benchmark 11:31:53 INFO - 2015-12-16 11:31:53,334 DEBUG : Working with test: v8_7 11:31:53 INFO - 2015-12-16 11:31:53,334 DEBUG : Generating results file: v8_7 11:31:53 INFO - 2015-12-16 11:31:53,334 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:31:53 INFO - 2015-12-16 11:31:53,392 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:31:53 INFO - 2015-12-16 11:31:53,392 DEBUG : process_Request line: dromaeo_css 6284.59 graph.html#tests=[[72,132,43]] 11:31:53 INFO - 2015-12-16 11:31:53,393 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:31:53 INFO - 2015-12-16 11:31:53,542 DEBUG : process_Request line: kraken 1558.20 graph.html#tests=[[232,132,43]] 11:31:53 INFO - 2015-12-16 11:31:53,542 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:31:53 INFO - 2015-12-16 11:31:53,668 DEBUG : process_Request line: v8_7 21239.79 graph.html#tests=[[230,132,43]] 11:31:53 INFO - 2015-12-16 11:31:53,669 INFO : javascript benchmark 11:31:53 INFO - 2015-12-16 11:31:53,673 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2673.4653069386122, 2722.8230165039286, 2755.7382048705367, 2763.3229858684626, 2773.4730401223765, 4622.630189584834, 4763.476017638066, 4774.880627984302, 4827.734474603895, 4844.830430934918, 4698.718076915387, 4721.102990431816, 4730.0, 4781.426228852542, 4781.689190202635, 4290.292101803207, 4319.935200971988, 4433.157700036999, 4443.089166720831, 4475.239209334405, 4236.068065025689, 4364.607185353318, 4396.274614688573, 4400.537943515933, 4438.4895736990175, 4328.826846926119, 4347.78261086946, 4353.73877567347, 4437.556244375537, 4469.82120715171, 4347.608715215614, 4403.53762854902, 4425.424694789689, 4432.423784907941, 4465.843695470676, 4278.4865816102265, 4352.434183556149, 4353.521112677603, 4354.303311470149, 4379.693421460499, 4620.1221767864, 4642.558956899089, 4706.3411122442885, 4745.905081898342, 4749.62003039756, 5114.0, 5122.385313762373, 5159.432462429129, 5162.638615296931, 5199.0, 5003.049420610072, 5134.4095429025765, 5170.302009228782, 5190.06578815813, 5199.350081239845, 4671.626269898434, 4682.906341873144, 4690.484046754854, 4732.503087175797, 4798.1123492154065, 5252.923150754163, 5267.473252674702, 5274.973625131926, 5279.736013199325, 5326.414094449608, 4852.51474852519, 5057.671251368649, 5058.721770302669, 5074.695518268915, 5083.034223497598, 5029.823956161516, 5094.4141423736, 5135.717535535507, 5176.559992400688, 5200.401953775364, 5065.392152941597, 5108.489151084936, 5141.511556402136, 5146.459621739738, 5158.123119069767, 4845.830395936126, 4984.5513903748115, 5104.464031276737, 5105.591552675777, 5122.129238029544, 4188.0, 4213.073123912734, 4232.68254880879, 4271.615554600101, 4272.91454170921, 3744.1762812181278, 3763.6800871925643, 3773.811309434572, 3786.6024067473068, 3801.7148713846573, 4243.702940794176, 4314.072474418015, 4375.037491751809, 4453.755043472575, 4491.348754430589, 4992.675476094042, 5008.1486147355035, 5156.458571849977, 5165.225216217522, 5165.940982098661, 4429.49060857999, 4443.511213766483, 4458.286674132123, 4470.24005918988, 4495.64034877209, 4385.210662080856, 4497.6851620386915, 4525.959029423251, 4551.249043907785, 4589.426321709786, 4850.442199147002, 4855.878603034882, 4862.465128835825, 4947.18371468718, 5002.774875130555, 5128.282040514406, 5177.4822517749435, 5184.403793563638, 5191.974040129775, 5197.142471492161, 4900.950990490192, 4915.8033678652455, 4931.235658472942, 4936.03747269279, 4968.8757781055765, 4807.302941073455, 4908.11653902301, 4913.729744863924, 5045.621578381562, 5083.186690129562, 5143.254228136824, 5162.612804039787, 5167.095758242368, 5180.7409629519125, 5205.45342739007, 4812.927806082982, 4948.703077815343, 4957.950420495749, 4963.78387295115, 4985.152524070989, 4918.827841025547, 4933.1613625683, 4959.504049595012, 4987.725675087905, 5030.949690503048, 4852.1508735971765, 4859.586935110555, 4866.659333846738, 4874.561289483963, 4894.314795928502, 4780.067886762048, 4836.758162091952, 5021.748912554431, 5061.038402703474, 5092.898142037065, 4866.853994380174, 4912.435069966999, 4960.950390496193, 4964.975175124101, 4983.925241121458], "unit": "score", "name": "dojo.html", "value": 4686.951376572048}, {"lowerIsBetter": false, "replicates": [564.9519790817777, 574.7586013874172, 577.3995045153041, 581.7927799815384, 589.4547543522241, 34627.48058779117, 35586.82206588967, 35644.287114257735, 35697.82151089247, 35839.0, 39470.802645986805, 40095.39856902142, 40152.39771403424, 40286.99282517938, 40293.19413611726, 7986.600669966508, 8077.717279895205, 8095.5952202389935, 8106.797330066736, 8130.75607731766, 7855.567943763091, 7938.44430889838, 7997.080335761404, 8008.199180081974, 8012.1186669466315, 7919.56442395668, 7999.680012799481, 8023.558704271263, 8035.839283214332, 8048.59757012147, 7986.640601172932, 8036.397270204729, 8038.316743076845, 8061.629522981108, 8096.271335579767, 7886.487378320448, 8000.279974802295, 8021.3181879539725, 8057.395695322874, 8098.190180981914, 37255.62744372548, 37526.24947501062, 37562.24875502502, 37639.0, 37648.811755941046, 2948.9557656635166, 3032.0449058546487, 3147.921301967469, 3168.714815666601, 3327.118313646861, 27984.440311193663, 28367.43265134686, 28509.714902850912, 28539.857300713364, 28893.0, 3288.490284005983, 3320.5849268841393, 3329.0, 3441.3633477806684, 3452.5339079224236, 204046.0, 204797.0, 205333.0, 205554.0, 205612.0, 50375.74812125916, 51705.224421633706, 53214.73392633012, 53451.732741336826, 53699.0, 51070.23394649083, 51245.487545124815, 51588.48411515912, 51716.48283517117, 51965.48034519682, 14537.92731036338, 14630.853691463162, 14783.70432591342, 14800.703985920221, 14821.555353339418, 11056.778864422666, 11135.610253641084, 11181.21731478805, 11190.776184476264, 11197.888021119847, 18409.355672551665, 18735.906320468584, 18751.249950001846, 18803.341883034027, 18882.81117188838, 7378.852422951511, 7568.810779730551, 7646.655900484491, 7671.0, 7709.961450192825, 853.2406158518924, 892.4065496444791, 913.4747520175926, 921.7833809054866, 1019.6176433837311, 25600.48799024009, 26444.603330950053, 26539.86730066376, 26549.86725066362, 26788.19635410941, 969.4958621516913, 976.584951395654, 993.3791380387258, 999.14073896449, 1093.4150229627112, 12767.616971490685, 13106.410211540504, 13182.670433239246, 13249.867501325056, 13293.734125317633, 343313.0, 353360.0, 354116.0, 356407.0, 357592.0, 42976.57023429726, 43134.0, 43138.137237255076, 43420.0, 43612.56387436085, 1210.3222195570333, 1233.2970206982113, 1243.8507379114565, 1244.6017274472083, 1249.6376050945305, 25037.499250015262, 25133.748662513142, 25205.49589008173, 25336.619950700384, 25450.74549254558, 36669.63330366769, 36837.26325473422, 37051.62948370482, 37106.628933710315, 37179.0, 198984.0, 200849.0, 201374.0, 201451.0, 201940.0, 27781.58327625047, 28125.0, 29193.7080629191, 29206.7079329204, 29248.707512925448, 33834.323313534085, 34121.317573648885, 34123.65876341205, 34738.0, 34884.651153489154, 29185.85407072951, 29698.851505742332, 29699.703002969694, 29913.252168695086, 30129.548056779604, 28843.711562884102, 29954.85022574873, 31488.842555787076, 31518.842405787826, 32137.196570085936, 31954.520682189323, 32014.199645009063, 32072.839635801673, 34092.0, 34473.31053378868, 27610.309742256606, 28584.285392864513, 29894.85052574723, 32173.0, 33626.49560256647, 23103.422414439774, 23209.535809284058, 23241.418964526023, 23407.53184936326, 23484.882575587013], "unit": "score", "name": "ext.html", "value": 16656.481947079043}, {"lowerIsBetter": false, "replicates": [323.0874552430297, 325.58162760852304, 341.13692358333424, 341.84446077034954, 343.44705024909905, 13015.284159371231, 15265.847341526582, 15637.0, 16095.19524023797, 16562.58593535159, 10114.190864730823, 10187.592496300158, 10229.897701022988, 10316.535755890984, 10331.121854642346, 4516.570925762056, 4668.789904454291, 4672.11229866326, 4679.181143299909, 4686.203345431268, 4715.221988371914, 5152.098382783017, 5152.227165925104, 5154.536091751742, 5175.120229560984, 4830.541098595628, 4970.478099799523, 5004.799808007675, 5098.643094983353, 5109.20807274873, 4843.854684359475, 4913.508649135076, 4970.577500912426, 4978.477259887732, 4984.451710311862, 4974.10466116099, 4980.87547811304, 4991.900161996776, 5005.149124648782, 5011.498850114996, 10206.846897296546, 10291.073803357658, 10346.0, 16783.496495105166, 17711.380101696377, 1455.345094707386, 1757.279515398693, 1782.27817733818, 1832.9470992488366, 1895.7630296212974, 8438.493690378597, 8651.307895368418, 8830.55847207637, 9247.39891907024, 10684.893151068545, 1755.9912200439044, 1763.4180720362249, 1808.3954834801414, 1824.3158815444208, 1847.1503108570073, 56576.0, 57231.85536289292, 57834.42165578333, 58773.412265877225, 59006.40993590052, 9853.802923941481, 9915.0, 9982.35114717541, 10019.849702254473, 10085.29402941787, 12712.364381780873, 12716.618501444971, 12719.491220351267, 12758.830998730238, 12769.936150319374, 7204.675789589481, 7217.314355136254, 7258.564486130849, 7329.74345897891, 7432.85134297311, 6950.339717726808, 6983.9650801745665, 6990.161180658251, 7082.575045497287, 7091.822704432328, 4192.538820729717, 4216.852410165629, 4231.836245032579, 4232.703710740218, 4253.914921701548, 1619.651774868409, 1644.3997940751779, 1776.0, 1777.6890042944121, 1785.8839175453554, 402.81671839313043, 404.69445568595523, 409.4820052633421, 411.44249541870334, 420.8127383314457, 9634.662786802428, 9834.409935403899, 10036.347637403545, 10073.69778906634, 10109.39343639384, 823.1562648285436, 842.9494230346199, 895.0244233785075, 909.5270459361095, 949.188443880486, 8558.400911936105, 9106.681266155652, 9383.906160938439, 9437.245020398488, 9454.196393306509, 496636.0, 497809.0, 502610.0, 505987.0, 511129.0, 69544.3045569548, 70669.29330706627, 74580.62709686416, 74731.62634186794, 74736.0, 1071.5874388360382, 1087.472575800736, 1093.5188517052472, 1106.1482658353023, 1106.391484683421, 14553.781693274397, 14583.125012499284, 14938.77591836145, 14962.850371496581, 15249.466268680542, 33521.49717754187, 33603.0, 33621.0, 34534.654653453144, 34633.65366346304, 44470.0, 44824.55175448334, 44847.55152448434, 44887.0, 47932.0, 8467.830643386975, 8486.61810218554, 8489.702860399857, 8608.268297194809, 8729.170728780755, 10171.0, 10181.694549163536, 10206.795864082529, 10260.589576417158, 10289.9485502572, 12694.0, 12712.555060573206, 13165.473381065034, 13735.107218030797, 14111.506097286545, 2955.891540672248, 10680.946595266974, 13076.411561479947, 13437.395317210554, 14069.0, 13482.865171348161, 13940.442382305, 14109.717805644035, 14232.928835355757, 14939.775903361675, 8446.619902104543, 8693.174148455886, 8749.781255468664, 8807.779805504913, 8924.241439477717, 9532.237421006164, 11253.887461125283, 14053.297335132998, 14057.297135142997, 14119.717605648035], "unit": "score", "name": "jquery.html", "value": 7729.474752814518}, {"lowerIsBetter": false, "replicates": [1485.848467437735, 1646.1275523972295, 1724.491275073853, 1741.338291449249, 1768.5313391951136, 6155.938440615592, 6313.747450101991, 7226.927730722691, 7456.328930396263, 7457.850842983144, 6974.476914231427, 7116.679749411276, 7195.568265904049, 7243.963780181105, 7244.420446364278, 2094.685797130431, 2128.531723020933, 2130.8295336373053, 2131.765505794361, 2134.4983928776724, 2058.5985732782115, 2076.948076298097, 2078.0648708081426, 2088.112552165331, 2125.8193053590385, 2040.387883634911, 2049.6720524716047, 2083.322920050982, 2084.6768750843644, 2094.696269040988, 2098.5697931923996, 2122.6391513442672, 2123.140128248062, 2124.7450305963384, 2136.0281072112152, 2078.5635016646524, 2080.9491206940397, 2105.620988222119, 2106.9157233710635, 2115.545157791082, 7138.571685698875, 7185.928140718631, 7195.388391986688, 7209.639518024078, 7217.8556428871125, 4115.8765237042935, 4215.91568168638, 4217.704760666724, 4231.555686652888, 4250.53244143144, 2732.6720793504905, 2751.1883994221753, 2838.6451693538306, 2839.7870159737895, 2853.857307134635, 868.0754995929315, 879.090141703334, 885.2298500304712, 887.3078998381272, 918.6738707758716, 9866.65466708669, 9883.505824708807, 9885.703428897144, 9902.0, 9926.255530835144, 3845.3270677631303, 3850.8844734658005, 3891.377379619304, 3939.2515422069714, 3951.664108550748, 8404.117567655308, 8489.193526614961, 8504.31965442763, 8530.829383412298, 8544.31645468361, 4264.552222016706, 4281.357796330575, 4283.400323954649, 4296.828126874952, 4316.6330861877095, 3268.950965735516, 3356.580427446569, 3821.44589034594, 3918.706097042676, 3924.136689928211, 3478.565179352581, 3524.4713293006253, 3526.559180102487, 3550.804705741209, 3563.518924945151, 1073.3238060022293, 1102.6306187427142, 1103.4041617526445, 1110.5169251375517, 1116.2911551165068, 947.507296205969, 957.9808403831885, 1188.8468185859701, 1208.3837243005955, 1233.8704436034266, 6854.794356169323, 6909.30906909305, 6925.342092501204, 6929.41100006495, 6957.686904089328, 443.16463466366133, 449.03681602961467, 449.2161178743114, 449.2587231068763, 451.7425067711373, 5195.3246078009615, 5219.373675159005, 5237.109691352479, 5254.448282930237, 5284.947150528523, 8670.86993695095, 8770.07914169003, 8777.824443511221, 8839.381243312906, 8898.510581918057, 8547.0, 8698.13018698125, 8716.738497845075, 8723.040465548784, 8769.824603508021, 6804.76183333581, 6841.3842754152365, 6852.6231057292325, 6861.725530978705, 6879.380855722909, 6448.871022579428, 6549.6070235786, 6570.507211959218, 6605.702743376656, 6608.273089960197, 7681.884771728317, 7762.107357653942, 7850.764477065697, 7893.210678932061, 7938.801529961797, 7905.446618736633, 7926.326262267772, 7995.9200407997505, 8003.759887203393, 8063.717769878026, 5427.945720542902, 5507.568032311708, 5663.5469162467725, 6250.593711408744, 6276.403741644536, 6854.040434339297, 6885.552439091443, 6927.896081558882, 6954.652267386711, 6982.33667801558, 6450.7097180627925, 6451.580647257913, 6545.509086818603, 6595.208574971034, 6675.866482670416, 6172.351903050115, 6223.813285601439, 6304.054391841077, 6508.642024688687, 6569.540132190892, 6438.903416448663, 6571.671416429255, 6572.211334639874, 6577.408033277028, 6579.374959378852, 5949.0, 5960.314563825215, 5960.642361458153, 6028.969855150696, 6062.454379105901, 6204.348543402878, 6216.564840461305, 6221.626702397871, 6227.1282020516255, 6237.064440333805], "unit": "score", "name": "mootools.html", "value": 4059.566050705703}, {"lowerIsBetter": false, "replicates": [300.3872100914135, 307.1354138101245, 309.63927025015846, 310.84302427274224, 311.8066798584877, 5514.972425137874, 5532.529734972532, 5571.888562228758, 5691.117876729114, 5695.515881150102, 5526.171074338851, 5614.652483403974, 5640.915386269209, 5643.68959707216, 5644.830655080344, 4145.212409642173, 4256.4679415073115, 4270.039241170727, 4273.358996150571, 4284.871453856374, 4256.2764330063965, 4261.637760790337, 4263.062126332202, 4263.253930562155, 4290.249206388885, 4231.767252801094, 4265.274903266437, 4267.466566679165, 4272.0, 4286.892827679302, 4259.297215959378, 4268.125034367947, 4277.807498662568, 4286.699931004831, 4290.313549832012, 3614.0964758810296, 3719.1445967427644, 3734.25314937011, 3736.084659258499, 3738.981305093457, 5222.164453687392, 5364.034473794715, 5368.8389348319615, 5375.43557926416, 5382.2464854920345, 4859.489753575859, 4881.219004959189, 4888.780004899788, 4889.4377146627885, 4892.926606100911, 5829.387914268983, 5873.1190321451695, 5877.79427720032, 5883.646981181143, 5902.675352855591, 3904.668103211202, 3997.600239976008, 4025.0742329264435, 4031.496062992126, 4050.8177132028836, 6109.175261339707, 6178.845528861814, 6187.133801267826, 6190.133381326663, 6210.534209934273, 4149.6265336119895, 4168.270552653274, 4175.874723758231, 4177.26897792885, 4194.538600753915, 4229.936550951738, 4238.660907127422, 4241.448611680524, 4247.66018718508, 4253.064325848309, 4761.262004389256, 4833.9033219335415, 4867.513248675175, 4877.878053048702, 4882.731449770296, 5840.182374467578, 5846.561507886926, 5854.063349864001, 5855.912161317584, 5861.325947516005, 1467.8458761830068, 1482.5255918106318, 1484.5249520153664, 1484.5768955847532, 1486.762118061105, 986.9605215791288, 994.0606127209862, 995.9452230127267, 997.5261750668375, 1015.0103648942222, 5126.512981266774, 5132.204508301219, 5144.6398752087, 5147.2279158126585, 5149.2791009258735, 6062.9996050652035, 6090.0, 6111.54163437735, 6119.847003824851, 6136.693165341804, 5057.949420505822, 5066.06277838601, 5148.099082660519, 5148.794048238104, 5153.845384638467, 3184.2994541200896, 3277.7050065493745, 3282.7537934654997, 3327.085051610826, 3332.3501917125927, 5583.609147359646, 5728.05487094633, 5803.665157013826, 5815.534757219412, 5843.853903652358, 6135.509159267248, 6308.243010838729, 6355.936440635627, 6390.520710946697, 6391.07329437229, 5821.854453638608, 5823.388544202882, 5826.766929322865, 5828.825135245949, 5836.824895253149, 5929.407059294036, 6142.815715528542, 6167.0, 6181.96909015452, 6182.103594978793, 6022.126791615104, 6027.849303767265, 6036.3058248302, 6037.305709843248, 6040.607360521552, 5828.154917537018, 5846.386129456346, 5849.064149736022, 5854.297484301911, 5854.541092741144, 4098.3852422136915, 4135.29699951003, 4138.151678905877, 4139.97930010348, 4145.958540414678, 6040.577159598962, 6115.4190351916495, 6149.354317796567, 6151.231096112986, 6167.136600875791, 5881.647101173943, 5882.823515294548, 5884.882302354014, 5896.852578685567, 5906.822795316148, 5899.528037756883, 5927.496162826035, 5929.377415371497, 5933.643981361132, 5947.494462970523, 5664.716764161858, 5789.45000224978, 5793.333766616893, 5795.681237531976, 5822.155787410887, 5958.344582096052, 5985.700714964148, 5991.970040149771, 5994.310654274815, 5998.0, 5805.82582522525, 5835.824925252249, 5841.386654401226, 5841.50347220491, 5850.414958504286], "unit": "score", "name": "prototype.html", "value": 4397.838874092849}, {"lowerIsBetter": false, "replicates": [774.6862520679124, 779.5517577393, 787.090909998951, 789.3882241263024, 790.9841803163937, 11573.247738896966, 11787.882121178785, 11792.46933887975, 11851.466683999219, 11860.881391186085, 11383.203175777699, 11548.942255288734, 11551.422428878543, 11575.189736718434, 11634.243774154675, 807.0839597057353, 825.1171246765963, 826.8057006603474, 827.3753316246226, 827.9130691277419, 803.2730379006979, 816.5019338203691, 816.542736067804, 817.235884448043, 818.1450384348341, 848.3637272045966, 861.7673228228375, 862.5816479007676, 863.7883718488979, 863.8920134983127, 847.2078606502909, 848.7326492154951, 853.7566793463833, 853.9914600853974, 856.2807241916757, 629.6568370238231, 634.5272771785003, 636.6689321552813, 636.7325723196269, 637.3339859846425, 11810.291382517076, 11883.58407455735, 11946.581869634609, 11951.462184201644, 11981.46083426248, 10839.349639021684, 10998.34009959405, 11397.430128493543, 11432.48553815072, 11792.23350482216, 9571.61713531465, 9630.855537166948, 9673.854892176623, 9696.70909872705, 9794.118529332394, 3263.1352691536763, 3304.074859039473, 3306.6528014558608, 3317.950230746541, 3399.6940275375086, 34671.13322166966, 34861.477077843854, 37472.43791343132, 37734.81132594347, 38170.61829381698, 8459.407841451039, 8832.77918052041, 9161.587728552231, 9235.12266334697, 9512.524373781283, 15407.691846163014, 15464.14947177916, 15509.612259693598, 15552.766708499381, 15576.221188940508, 6272.905906411407, 6274.905876411857, 6334.334894835976, 6426.453751431087, 6477.0, 3554.662307080823, 3633.6184700606586, 3641.7814931104217, 3660.7071434285194, 3704.2961837250837, 2498.9750102499106, 2513.698356197268, 2521.2814347911126, 2525.7726804587674, 2526.886290116949, 456.51609294148307, 460.2980454806447, 460.78573463339706, 465.48098869759974, 470.3203870407297, 583.3932709981657, 588.6291636269123, 608.7108623403936, 629.9748010079545, 631.1778015958084, 7433.219511951275, 7690.384769218561, 7815.843683126305, 7822.256885595859, 7855.175206603224, 529.5472371122712, 560.9943900561024, 588.8174665853599, 609.6677310865589, 624.9562530622812, 3487.1979444727854, 3715.108373990277, 3747.0819649186124, 3830.1190726133145, 3838.0788610733225, 45887.31169032467, 46114.0, 46504.5349546507, 48984.265236021485, 49197.754011229714, 38495.0, 38525.80737096297, 38790.61209387927, 40273.798631006655, 42907.35638965418, 39176.41235381472, 39892.40161397582, 43749.0, 43793.78103109464, 44084.779576101915, 7415.480916335805, 7658.310752032344, 7757.263060009516, 7875.921240787748, 7896.960515197387, 29507.85246073756, 29673.25816854596, 31691.84154079215, 32487.350252994336, 32849.83575082109, 34273.31453370969, 34591.481127783605, 34768.47847282344, 35449.93650190499, 35804.64195358013, 10213.33613315132, 10261.435621040615, 10308.484575771032, 10336.741581460223, 10551.630692925712, 11052.944735276595, 11298.661040168809, 11394.544218231178, 11587.0, 11716.531338746354, 10741.140708743438, 10813.729656758644, 10971.83542246851, 11133.165012624248, 11144.2199046066, 10691.8930810694, 10997.395143267197, 11026.283291586022, 11401.885981140082, 11480.82778758336, 10694.0, 10761.30051546647, 10870.456477176267, 10968.780624387628, 11137.164712646421, 9065.365424420228, 9246.214071803972, 9249.768755781159, 9519.619215231312, 9544.809103818023, 8817.470951742916, 9108.0, 9140.63437462494, 9234.538273086184, 9526.285528585522], "unit": "score", "name": "yui.html", "value": 5718.438031308708}], "name": "dromaeo_css", "value": 6284.590755733317}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 117.0, 113.0, 115.0, 127.0, 116.0, 115.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.8}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 155.0, 168.0, 132.0, 155.0, 165.0, 138.0, 183.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 164.0, 162.0, 166.0, 165.0, 168.0, 165.0, 165.0, 167.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 76.0, 73.0, 76.0, 143.0, 73.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 145.0, 95.0, 97.0, 95.0, 133.0, 95.0, 97.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 73.0, 77.0, 74.0, 73.0, 73.0, 76.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [94.0, 87.0, 94.0, 90.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [130.0, 122.0, 124.0, 126.0, 123.0, 123.0, 135.0, 136.0, 129.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.8}, {"lowerIsBetter": true, "replicates": [152.0, 158.0, 152.0, 155.0, 152.0, 147.0, 152.0, 156.0, 161.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.7}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 75.0, 72.0, 70.0, 70.0, 72.0, 71.0, 72.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1558.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [186.08113137327874], "unit": "score", "name": "DeltaBlue", "value": 355.31813200000005}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1089.3246187363834], "unit": "score", "name": "RayTrace", "value": 679.3099019999999}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [26684.21052631579], "unit": "score", "name": "RegExp", "value": 34.13947731755427}, {"lowerIsBetter": false, "replicates": [596.210775606868], "unit": "score", "name": "Splay", "value": 136.68152830188674}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21239.785217898843}]} 11:31:53 INFO - RETURN: dromaeo_css: 6284.59 11:31:53 INFO - RETURN: kraken: 1558.20 11:31:53 INFO - RETURN: v8_7: 21239.79 11:31:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21239.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1558.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6284.59"}}} 11:31:53 INFO - Return code: 0 11:31:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:31:53 INFO - # TBPL SUCCESS # 11:31:53 INFO - Running post-action listener: _resource_record_post_action 11:31:53 INFO - Running post-run listener: _resource_record_post_run 11:31:54 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504147968; Read time: 12; Write time: 739648 11:31:54 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 231411712; Read time: 0; Write time: 503292 11:31:54 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271904768; Read time: 12; Write time: 236248 11:31:54 INFO - Running post-run listener: _upload_blobber_files 11:31:54 INFO - Blob upload gear active. 11:31:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:31:54 INFO - Copying logs to upload dir... 11:31:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.045809 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-16 11:31:54.545475) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:31:54.549099) ========= 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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009941 build_url: 'https://queue.taskcluster.net/v1/task/ILEgjNMeTUq03V5Unkbcbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:31:54.606537) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:31:54.607077) ========= 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-1450292908.867734-1953551193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:31:54.659661) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:31:54.660167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:31:54.660714) ========= ========= Total master_lag: 0.24 =========