builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1449665484.58 results: success (0) buildid: 20151209033140 builduid: 8372358f19df4b3f9cb6b9ac44f4562b revision: 886e81173514fc537bff7bb176f277ed7024ff41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.576705) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.577185) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.577553) ========= 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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.632373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.632709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.680292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.680606) ========= 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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.734109) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.734820) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.735744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:24.736409) ========= 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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 04:51:24-- 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% 50.7K=0.2s 2015-12-09 04:51:25 (50.7 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.344693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.102299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.102634) ========= 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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014070 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.155323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.156146) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 886e81173514fc537bff7bb176f277ed7024ff41 --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 886e81173514fc537bff7bb176f277ed7024ff41 --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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 04:51:25,383 truncating revision to first 12 chars 2015-12-09 04:51:25,383 Setting DEBUG logging. 2015-12-09 04:51:25,384 attempt 1/10 2015-12-09 04:51:25,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/886e81173514?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 04:51:25,623 unpacking tar archive at: fx-team-886e81173514/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.681159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.681481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.693608) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.694010) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:51:25.694568) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-09 04:51:25.694986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:51:26 INFO - MultiFileLogger online at 20151209 04:51:26 in /builds/slave/test 04:51:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 04:51:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:26 INFO - {'append_to_log': False, 04:51:26 INFO - 'base_work_dir': '/builds/slave/test', 04:51:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:51:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:26 INFO - 'branch': 'Fx-Team-Non-PGO', 04:51:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:26 INFO - 'config_files': ('talos/linux_config.py',), 04:51:26 INFO - 'default_actions': ('clobber', 04:51:26 INFO - 'read-buildbot-config', 04:51:26 INFO - 'download-and-extract', 04:51:26 INFO - 'populate-webroot', 04:51:26 INFO - 'create-virtualenv', 04:51:26 INFO - 'install', 04:51:26 INFO - 'run-tests'), 04:51:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:26 INFO - 'download_minidump_stackwalk': True, 04:51:26 INFO - 'download_symbols': 'ondemand', 04:51:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:26 INFO - 'installer_path': 'installer.exe', 04:51:26 INFO - 'log_level': 'info', 04:51:26 INFO - 'log_name': 'talos', 04:51:26 INFO - 'log_to_console': True, 04:51:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:51:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:51:26 INFO - 'opt_config_files': (), 04:51:26 INFO - 'pip_index': False, 04:51:26 INFO - 'sps_profile': False, 04:51:26 INFO - 'sps_profile_interval': 0, 04:51:26 INFO - 'suite': 'dromaeojs', 04:51:26 INFO - 'system_bits': '64', 04:51:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:26 INFO - 'title': 'talos-linux64-ix-002', 04:51:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:26 INFO - 'use_talos_json': True, 04:51:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:26 INFO - 'work_dir': 'build'} 04:51:26 INFO - ##### 04:51:26 INFO - ##### Running clobber step. 04:51:26 INFO - ##### 04:51:26 INFO - Running pre-action listener: _resource_record_pre_action 04:51:26 INFO - Running main action method: clobber 04:51:26 INFO - rmtree: /builds/slave/test/build 04:51:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:26 INFO - Running post-action listener: _resource_record_post_action 04:51:26 INFO - ##### 04:51:26 INFO - ##### Running read-buildbot-config step. 04:51:26 INFO - ##### 04:51:26 INFO - Running pre-action listener: _resource_record_pre_action 04:51:26 INFO - Running main action method: read_buildbot_config 04:51:26 INFO - Using buildbot properties: 04:51:26 INFO - { 04:51:26 INFO - "properties": { 04:51:26 INFO - "buildnumber": 1184, 04:51:26 INFO - "product": "firefox", 04:51:26 INFO - "script_repo_revision": "production", 04:51:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:51:26 INFO - "repository": "", 04:51:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:51:26 INFO - "buildid": "20151209033140", 04:51:26 INFO - "slavename": "talos-linux64-ix-002", 04:51:26 INFO - "pgo_build": "False", 04:51:26 INFO - "basedir": "/builds/slave/test", 04:51:26 INFO - "project": "", 04:51:26 INFO - "platform": "ubuntu64_hw", 04:51:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:51:26 INFO - "slavebuilddir": "test", 04:51:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:51:26 INFO - "branch": "fx-team", 04:51:26 INFO - "repo_path": "integration/fx-team", 04:51:26 INFO - "stage_platform": "linux64", 04:51:26 INFO - "builduid": "8372358f19df4b3f9cb6b9ac44f4562b", 04:51:26 INFO - "revision": "886e81173514fc537bff7bb176f277ed7024ff41" 04:51:26 INFO - }, 04:51:26 INFO - "sourcestamp": { 04:51:26 INFO - "repository": "", 04:51:26 INFO - "hasPatch": false, 04:51:26 INFO - "project": "", 04:51:26 INFO - "branch": "fx-team-linux64-talos", 04:51:26 INFO - "changes": [ 04:51:26 INFO - { 04:51:26 INFO - "category": null, 04:51:26 INFO - "files": [ 04:51:26 INFO - { 04:51:26 INFO - "url": null, 04:51:26 INFO - "name": "https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:51:26 INFO - } 04:51:26 INFO - ], 04:51:26 INFO - "repository": "", 04:51:26 INFO - "rev": "886e81173514fc537bff7bb176f277ed7024ff41", 04:51:26 INFO - "who": "cbook@mozilla.com", 04:51:26 INFO - "when": 1449665387, 04:51:26 INFO - "number": 7148242, 04:51:26 INFO - "comments": "Merge mozilla-central to fx-team", 04:51:26 INFO - "project": "", 04:51:26 INFO - "at": "Wed 09 Dec 2015 04:49:47", 04:51:26 INFO - "branch": "fx-team-linux64-talos", 04:51:26 INFO - "revlink": "", 04:51:26 INFO - "properties": [ 04:51:26 INFO - [ 04:51:26 INFO - "buildid", 04:51:26 INFO - "20151209033140", 04:51:26 INFO - "Change" 04:51:26 INFO - ], 04:51:26 INFO - [ 04:51:26 INFO - "builduid", 04:51:26 INFO - "8372358f19df4b3f9cb6b9ac44f4562b", 04:51:26 INFO - "Change" 04:51:26 INFO - ], 04:51:26 INFO - [ 04:51:26 INFO - "pgo_build", 04:51:26 INFO - "False", 04:51:26 INFO - "Change" 04:51:26 INFO - ] 04:51:26 INFO - ], 04:51:26 INFO - "revision": "886e81173514fc537bff7bb176f277ed7024ff41" 04:51:26 INFO - } 04:51:26 INFO - ], 04:51:26 INFO - "revision": "886e81173514fc537bff7bb176f277ed7024ff41" 04:51:26 INFO - } 04:51:26 INFO - } 04:51:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:51:26 INFO - Running post-action listener: _resource_record_post_action 04:51:26 INFO - ##### 04:51:26 INFO - ##### Running download-and-extract step. 04:51:26 INFO - ##### 04:51:26 INFO - Running pre-action listener: _resource_record_pre_action 04:51:26 INFO - Running main action method: download_and_extract 04:51:26 INFO - mkdir: /builds/slave/test/build/tests 04:51:26 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')]} 04:51:26 INFO - https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:51:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/test_packages.json 04:51:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/test_packages.json 04:51:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:51:36 INFO - Downloaded 1302 bytes. 04:51:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:51:36 INFO - Using the following test package requirements: 04:51:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:51:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'jsshell-linux-x86_64.zip'], 04:51:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:51:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:51:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:51:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:51:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:51:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:51:36 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')]} 04:51:36 INFO - https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:51:40 INFO - Downloaded 21860154 bytes. 04:51:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:51:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:51:41 INFO - Return code: 0 04:51:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:51:41 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')]} 04:51:41 INFO - https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:51:43 INFO - Downloaded 21860154 bytes. 04:51:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:51:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:51:44 INFO - Return code: 0 04:51:44 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')]} 04:51:44 INFO - https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:51:45 INFO - Downloaded 11132038 bytes. 04:51:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:51:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:51:45 INFO - Return code: 0 04:51:45 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')]} 04:51:45 INFO - https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:51:47 INFO - Downloaded 57734254 bytes. 04:51:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:47 INFO - mkdir: /builds/slave/test/properties 04:51:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:47 INFO - Contents: 04:51:47 INFO - build_url:https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:47 INFO - Running post-action listener: _resource_record_post_action 04:51:47 INFO - Running post-action listener: set_extra_try_arguments 04:51:47 INFO - ##### 04:51:47 INFO - ##### Running populate-webroot step. 04:51:47 INFO - ##### 04:51:47 INFO - Running pre-action listener: _resource_record_pre_action 04:51:47 INFO - Running main action method: populate_webroot 04:51:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:51:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:51:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:51:47 INFO - '--tppagecycles', 04:51:47 INFO - '7'], 04:51:47 INFO - 'tests': ['tsvgm']}}, 04:51:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:51:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:51:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:51:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:51:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'tests': ['damp', 'tps']}, 04:51:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['damp', 'tps']}, 04:51:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:51:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:47 INFO - 'other': {'tests': ['a11yr', 04:51:47 INFO - 'ts_paint', 04:51:47 INFO - 'tpaint', 04:51:47 INFO - 'sessionrestore', 04:51:47 INFO - 'sessionrestore_no_auto_restore']}, 04:51:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['a11yr', 04:51:47 INFO - 'ts_paint', 04:51:47 INFO - 'tpaint', 04:51:47 INFO - 'sessionrestore', 04:51:47 INFO - 'sessionrestore_no_auto_restore']}, 04:51:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['a11yr', 04:51:47 INFO - 'ts_paint', 04:51:47 INFO - 'tpaint', 04:51:47 INFO - 'sessionrestore', 04:51:47 INFO - 'sessionrestore_no_auto_restore']}, 04:51:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['a11yr', 04:51:47 INFO - 'ts_paint', 04:51:47 INFO - 'tpaint', 04:51:47 INFO - 'sessionrestore', 04:51:47 INFO - 'sessionrestore_no_auto_restore']}, 04:51:47 INFO - 'other_l64': {'tests': ['a11yr', 04:51:47 INFO - 'ts_paint', 04:51:47 INFO - 'tpaint', 04:51:47 INFO - 'sessionrestore', 04:51:47 INFO - 'sessionrestore_no_auto_restore']}, 04:51:47 INFO - 'other_nol64': {'tests': ['a11yr', 04:51:47 INFO - 'ts_paint', 04:51:47 INFO - 'tpaint', 04:51:47 INFO - 'sessionrestore', 04:51:47 INFO - 'sessionrestore_no_auto_restore']}, 04:51:47 INFO - 'svgr': {'tests': ['tsvgx', 04:51:47 INFO - 'tsvgr_opacity', 04:51:47 INFO - 'tart', 04:51:47 INFO - 'tscrollx', 04:51:47 INFO - 'cart']}, 04:51:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['tsvgx', 04:51:47 INFO - 'tsvgr_opacity', 04:51:47 INFO - 'tart', 04:51:47 INFO - 'tscrollx', 04:51:47 INFO - 'cart']}, 04:51:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'tests': ['tp5o']}, 04:51:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'talos_options': ['--e10s'], 04:51:47 INFO - 'tests': ['tp5o']}, 04:51:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'talos_options': ['--xperf_path', 04:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:47 INFO - 'tests': ['tp5n']}, 04:51:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:47 INFO - 'talos_options': ['--e10s', 04:51:47 INFO - '--xperf_path', 04:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:47 INFO - 'tests': ['tp5n']}}, 04:51:47 INFO - 'talos.zip': {'path': '', 04:51:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:51:47 INFO - Running post-action listener: _resource_record_post_action 04:51:47 INFO - ##### 04:51:47 INFO - ##### Running create-virtualenv step. 04:51:47 INFO - ##### 04:51:47 INFO - Running pre-action listener: _resource_record_pre_action 04:51:47 INFO - Running main action method: create_virtualenv 04:51:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:47 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 04:51:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:47 INFO - Using real prefix '/usr' 04:51:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:49 INFO - Installing pip.................done. 04:51:49 INFO - Return code: 0 04:51:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:49 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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:51:49 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 04:51:49 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 04:51:49 INFO - Using env: {'DISPLAY': ':0', 04:51:49 INFO - 'HOME': '/home/cltbld', 04:51:49 INFO - 'LANG': 'en_US.UTF-8', 04:51:49 INFO - 'LANGUAGE': 'en_US:en', 04:51:49 INFO - 'LOGNAME': 'cltbld', 04:51:49 INFO - 'MAIL': '/var/mail/cltbld', 04:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:49 INFO - 'MOZ_NO_REMOTE': '1', 04:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:49 INFO - 'NO_EM_RESTART': '1', 04:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:49 INFO - 'PWD': '/builds/slave/test', 04:51:49 INFO - 'SHELL': '/bin/bash', 04:51:49 INFO - 'SHLVL': '1', 04:51:49 INFO - 'TERM': 'linux', 04:51:49 INFO - 'TMOUT': '86400', 04:51:49 INFO - 'USER': 'cltbld', 04:51:49 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:49 INFO - '_': '/tools/buildbot/bin/python'} 04:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:49 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 04:51:49 INFO - Cleaning up... 04:51:49 INFO - Return code: 0 04:51:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:49 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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:51:49 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 04:51:49 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 04:51:49 INFO - Using env: {'DISPLAY': ':0', 04:51:49 INFO - 'HOME': '/home/cltbld', 04:51:49 INFO - 'LANG': 'en_US.UTF-8', 04:51:49 INFO - 'LANGUAGE': 'en_US:en', 04:51:49 INFO - 'LOGNAME': 'cltbld', 04:51:49 INFO - 'MAIL': '/var/mail/cltbld', 04:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:49 INFO - 'MOZ_NO_REMOTE': '1', 04:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:49 INFO - 'NO_EM_RESTART': '1', 04:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:49 INFO - 'PWD': '/builds/slave/test', 04:51:49 INFO - 'SHELL': '/bin/bash', 04:51:49 INFO - 'SHLVL': '1', 04:51:49 INFO - 'TERM': 'linux', 04:51:49 INFO - 'TMOUT': '86400', 04:51:49 INFO - 'USER': 'cltbld', 04:51:49 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:49 INFO - '_': '/tools/buildbot/bin/python'} 04:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:50 INFO - Downloading/unpacking psutil>=0.7.1 04:51:50 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 04:51:50 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 04:51:50 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 04:51:50 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 04:51:50 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 04:51:50 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 04:51:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:51:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:51:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:51 INFO - Installing collected packages: psutil 04:51:51 INFO - Running setup.py install for psutil 04:51:52 INFO - building 'psutil._psutil_linux' extension 04:51:52 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 04:51:52 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 04:51:52 INFO - building 'psutil._psutil_posix' extension 04:51:52 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 04:51:52 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 04:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:52 INFO - Successfully installed psutil 04:51:52 INFO - Cleaning up... 04:51:52 INFO - Return code: 0 04:51:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:52 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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:51:52 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 04:51:52 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 04:51:52 INFO - Using env: {'DISPLAY': ':0', 04:51:52 INFO - 'HOME': '/home/cltbld', 04:51:52 INFO - 'LANG': 'en_US.UTF-8', 04:51:52 INFO - 'LANGUAGE': 'en_US:en', 04:51:52 INFO - 'LOGNAME': 'cltbld', 04:51:52 INFO - 'MAIL': '/var/mail/cltbld', 04:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:52 INFO - 'MOZ_NO_REMOTE': '1', 04:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:52 INFO - 'NO_EM_RESTART': '1', 04:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:52 INFO - 'PWD': '/builds/slave/test', 04:51:52 INFO - 'SHELL': '/bin/bash', 04:51:52 INFO - 'SHLVL': '1', 04:51:52 INFO - 'TERM': 'linux', 04:51:52 INFO - 'TMOUT': '86400', 04:51:52 INFO - 'USER': 'cltbld', 04:51:52 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:52 INFO - '_': '/tools/buildbot/bin/python'} 04:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:51:52 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 04:51:52 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 04:51:52 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 04:51:52 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 04:51:52 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 04:51:52 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 04:51:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:51:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:51:54 INFO - Installing collected packages: mozsystemmonitor 04:51:54 INFO - Running setup.py install for mozsystemmonitor 04:51:54 INFO - Successfully installed mozsystemmonitor 04:51:54 INFO - Cleaning up... 04:51:54 INFO - Return code: 0 04:51:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:54 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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:51:54 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 04:51:54 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 04:51:54 INFO - Using env: {'DISPLAY': ':0', 04:51:54 INFO - 'HOME': '/home/cltbld', 04:51:54 INFO - 'LANG': 'en_US.UTF-8', 04:51:54 INFO - 'LANGUAGE': 'en_US:en', 04:51:54 INFO - 'LOGNAME': 'cltbld', 04:51:54 INFO - 'MAIL': '/var/mail/cltbld', 04:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:54 INFO - 'MOZ_NO_REMOTE': '1', 04:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:54 INFO - 'NO_EM_RESTART': '1', 04:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:54 INFO - 'PWD': '/builds/slave/test', 04:51:54 INFO - 'SHELL': '/bin/bash', 04:51:54 INFO - 'SHLVL': '1', 04:51:54 INFO - 'TERM': 'linux', 04:51:54 INFO - 'TMOUT': '86400', 04:51:54 INFO - 'USER': 'cltbld', 04:51:54 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:54 INFO - '_': '/tools/buildbot/bin/python'} 04:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:51:54 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 04:51:54 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 04:51:54 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 04:51:54 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 04:51:54 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 04:51:54 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 04:51:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:51:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:51:56 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 04:51:56 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 04:51:56 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 04:51:56 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 04:51:56 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 04:51:56 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 04:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:51:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:51:56 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 04:51:56 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 04:51:56 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 04:51:56 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 04:51:56 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 04:51:56 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 04:51:57 INFO - Downloading docopt-0.6.1.tar.gz 04:51:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:51:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:51:57 INFO - Running setup.py install for blobuploader 04:51:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:51:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:51:57 INFO - Running setup.py install for requests 04:51:57 INFO - Running setup.py install for docopt 04:51:57 INFO - Successfully installed blobuploader requests docopt 04:51:57 INFO - Cleaning up... 04:51:57 INFO - Return code: 0 04:51:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:57 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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:51:57 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 04:51:57 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 04:51:57 INFO - Using env: {'DISPLAY': ':0', 04:51:57 INFO - 'HOME': '/home/cltbld', 04:51:57 INFO - 'LANG': 'en_US.UTF-8', 04:51:57 INFO - 'LANGUAGE': 'en_US:en', 04:51:57 INFO - 'LOGNAME': 'cltbld', 04:51:57 INFO - 'MAIL': '/var/mail/cltbld', 04:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:57 INFO - 'MOZ_NO_REMOTE': '1', 04:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:57 INFO - 'NO_EM_RESTART': '1', 04:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:57 INFO - 'PWD': '/builds/slave/test', 04:51:57 INFO - 'SHELL': '/bin/bash', 04:51:57 INFO - 'SHLVL': '1', 04:51:57 INFO - 'TERM': 'linux', 04:51:57 INFO - 'TMOUT': '86400', 04:51:57 INFO - 'USER': 'cltbld', 04:51:57 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:57 INFO - '_': '/tools/buildbot/bin/python'} 04:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:58 INFO - Running setup.py (path:/tmp/pip-1JLq4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:58 INFO - Running setup.py (path:/tmp/pip-M43xr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:58 INFO - Running setup.py (path:/tmp/pip-90xx7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:58 INFO - Running setup.py (path:/tmp/pip-6BWdoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:58 INFO - Running setup.py (path:/tmp/pip-7HO4ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:58 INFO - Running setup.py (path:/tmp/pip-7LdaVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:58 INFO - Running setup.py (path:/tmp/pip-Hmz0n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:58 INFO - Running setup.py (path:/tmp/pip-5gUi9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:58 INFO - Running setup.py (path:/tmp/pip-Xu4kpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:58 INFO - Running setup.py (path:/tmp/pip-H_gEz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:58 INFO - Running setup.py (path:/tmp/pip-GEZ2S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:58 INFO - Running setup.py (path:/tmp/pip-I0yXtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:58 INFO - Running setup.py (path:/tmp/pip-AvRDmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:58 INFO - Running setup.py (path:/tmp/pip-NE1fP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:59 INFO - Running setup.py (path:/tmp/pip-lZe3Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:59 INFO - Running setup.py (path:/tmp/pip-V1v840-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:59 INFO - Running setup.py (path:/tmp/pip-1jvzwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:51:59 INFO - Running setup.py install for manifestparser 04:51:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:51:59 INFO - Running setup.py install for mozcrash 04:51:59 INFO - Running setup.py install for mozdebug 04:51:59 INFO - Running setup.py install for mozdevice 04:51:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:51:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:51:59 INFO - Running setup.py install for mozfile 04:51:59 INFO - Running setup.py install for mozhttpd 04:51:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:51:59 INFO - Running setup.py install for mozinfo 04:51:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:51:59 INFO - Running setup.py install for mozInstall 04:52:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Running setup.py install for mozleak 04:52:00 INFO - Running setup.py install for mozlog 04:52:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Running setup.py install for moznetwork 04:52:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Running setup.py install for mozprocess 04:52:00 INFO - Running setup.py install for mozprofile 04:52:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Running setup.py install for mozrunner 04:52:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:00 INFO - Running setup.py install for mozscreenshot 04:52:00 INFO - Running setup.py install for moztest 04:52:00 INFO - Running setup.py install for mozversion 04:52:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:01 INFO - Cleaning up... 04:52:01 INFO - Return code: 0 04:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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', '-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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:52:01 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 04:52:01 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 04:52:01 INFO - Using env: {'DISPLAY': ':0', 04:52:01 INFO - 'HOME': '/home/cltbld', 04:52:01 INFO - 'LANG': 'en_US.UTF-8', 04:52:01 INFO - 'LANGUAGE': 'en_US:en', 04:52:01 INFO - 'LOGNAME': 'cltbld', 04:52:01 INFO - 'MAIL': '/var/mail/cltbld', 04:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:01 INFO - 'MOZ_NO_REMOTE': '1', 04:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:01 INFO - 'NO_EM_RESTART': '1', 04:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:01 INFO - 'PWD': '/builds/slave/test', 04:52:01 INFO - 'SHELL': '/bin/bash', 04:52:01 INFO - 'SHLVL': '1', 04:52:01 INFO - 'TERM': 'linux', 04:52:01 INFO - 'TMOUT': '86400', 04:52:01 INFO - 'USER': 'cltbld', 04:52:01 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:01 INFO - '_': '/tools/buildbot/bin/python'} 04:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:01 INFO - Running setup.py (path:/tmp/pip-IPwBCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:01 INFO - Running setup.py (path:/tmp/pip-qcVeOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:01 INFO - Running setup.py (path:/tmp/pip-MIkkXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:01 INFO - Running setup.py (path:/tmp/pip-zGXsuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:01 INFO - Running setup.py (path:/tmp/pip-U49mgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:01 INFO - Running setup.py (path:/tmp/pip-g2zMVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:01 INFO - Running setup.py (path:/tmp/pip-NGWzsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:01 INFO - Running setup.py (path:/tmp/pip-M9bOTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:01 INFO - Running setup.py (path:/tmp/pip-Fd4jJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:01 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)) 04:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:01 INFO - Running setup.py (path:/tmp/pip-oAaPfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:02 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)) 04:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:02 INFO - Running setup.py (path:/tmp/pip-GTFmJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:02 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)) 04:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:02 INFO - Running setup.py (path:/tmp/pip-KnB98X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:02 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)) 04:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:02 INFO - Running setup.py (path:/tmp/pip-vbkGy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:02 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)) 04:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:02 INFO - Running setup.py (path:/tmp/pip-gzJDTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:02 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)) 04:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:02 INFO - Running setup.py (path:/tmp/pip-3MxhmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:02 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)) 04:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:02 INFO - Running setup.py (path:/tmp/pip-R4JIjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:02 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)) 04:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:02 INFO - Running setup.py (path:/tmp/pip-4T6pAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:02 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)) 04:52:02 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)) 04:52:02 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)) 04:52:02 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)) 04:52:02 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)) 04:52:02 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)) 04:52:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:04 INFO - Downloading blessings-1.5.1.tar.gz 04:52:04 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 04:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:04 INFO - Installing collected packages: blessings 04:52:04 INFO - Running setup.py install for blessings 04:52:04 INFO - Successfully installed blessings 04:52:04 INFO - Cleaning up... 04:52:04 INFO - Return code: 0 04:52:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:04 INFO - Reading from file tmpfile_stdout 04:52:04 INFO - Current package versions: 04:52:04 INFO - argparse == 1.2.1 04:52:04 INFO - blessings == 1.5.1 04:52:04 INFO - blobuploader == 1.2.4 04:52:04 INFO - docopt == 0.6.1 04:52:04 INFO - manifestparser == 1.1 04:52:04 INFO - mozInstall == 1.12 04:52:04 INFO - mozcrash == 0.16 04:52:04 INFO - mozdebug == 0.1 04:52:04 INFO - mozdevice == 0.47 04:52:04 INFO - mozfile == 1.2 04:52:04 INFO - mozhttpd == 0.7 04:52:04 INFO - mozinfo == 0.9 04:52:04 INFO - mozleak == 0.1 04:52:04 INFO - mozlog == 3.1 04:52:04 INFO - moznetwork == 0.27 04:52:04 INFO - mozprocess == 0.22 04:52:04 INFO - mozprofile == 0.27 04:52:04 INFO - mozrunner == 6.11 04:52:04 INFO - mozscreenshot == 0.1 04:52:04 INFO - mozsystemmonitor == 0.0 04:52:04 INFO - moztest == 0.7 04:52:04 INFO - mozversion == 1.4 04:52:04 INFO - psutil == 3.1.1 04:52:04 INFO - requests == 1.2.3 04:52:04 INFO - wsgiref == 0.1.2 04:52:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:52:04 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 04:52:04 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 04:52:04 INFO - Using env: {'DISPLAY': ':0', 04:52:04 INFO - 'HOME': '/home/cltbld', 04:52:04 INFO - 'LANG': 'en_US.UTF-8', 04:52:04 INFO - 'LANGUAGE': 'en_US:en', 04:52:04 INFO - 'LOGNAME': 'cltbld', 04:52:04 INFO - 'MAIL': '/var/mail/cltbld', 04:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:04 INFO - 'MOZ_NO_REMOTE': '1', 04:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:04 INFO - 'NO_EM_RESTART': '1', 04:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:04 INFO - 'PWD': '/builds/slave/test', 04:52:04 INFO - 'SHELL': '/bin/bash', 04:52:04 INFO - 'SHLVL': '1', 04:52:04 INFO - 'TERM': 'linux', 04:52:04 INFO - 'TMOUT': '86400', 04:52:04 INFO - 'USER': 'cltbld', 04:52:04 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:04 INFO - '_': '/tools/buildbot/bin/python'} 04:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 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)) 04:52:04 INFO - Cleaning up... 04:52:04 INFO - Return code: 0 04:52:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:52:04 INFO - Using env: {'DISPLAY': ':0', 04:52:04 INFO - 'HOME': '/home/cltbld', 04:52:04 INFO - 'LANG': 'en_US.UTF-8', 04:52:04 INFO - 'LANGUAGE': 'en_US:en', 04:52:04 INFO - 'LOGNAME': 'cltbld', 04:52:04 INFO - 'MAIL': '/var/mail/cltbld', 04:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:04 INFO - 'MOZ_NO_REMOTE': '1', 04:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:04 INFO - 'NO_EM_RESTART': '1', 04:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:04 INFO - 'PWD': '/builds/slave/test', 04:52:04 INFO - 'SHELL': '/bin/bash', 04:52:04 INFO - 'SHLVL': '1', 04:52:04 INFO - 'TERM': 'linux', 04:52:04 INFO - 'TMOUT': '86400', 04:52:04 INFO - 'USER': 'cltbld', 04:52:04 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:04 INFO - '_': '/tools/buildbot/bin/python'} 04:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:05 INFO - Downloading/unpacking jsonschema 04:52:05 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 04:52:05 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 04:52:05 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 04:52:05 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 04:52:05 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 04:52:05 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 04:52:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:06 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 04:52:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:07 INFO - warning: no files found matching '*.txt' 04:52:07 INFO - no previously-included directories found matching 'build' 04:52:07 INFO - no previously-included directories found matching 'dist' 04:52:07 INFO - no previously-included directories found matching '.git*' 04:52:07 INFO - Installing collected packages: jsonschema, functools32 04:52:07 INFO - Running setup.py install for functools32 04:52:07 INFO - warning: no files found matching '*.txt' 04:52:07 INFO - no previously-included directories found matching 'build' 04:52:07 INFO - no previously-included directories found matching 'dist' 04:52:07 INFO - no previously-included directories found matching '.git*' 04:52:07 INFO - Successfully installed jsonschema functools32 04:52:07 INFO - Cleaning up... 04:52:07 INFO - Return code: 0 04:52:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:07 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 0x7f47b6165f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, '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': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', '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 04:52:07 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 04:52:07 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 04:52:07 INFO - Using env: {'DISPLAY': ':0', 04:52:07 INFO - 'HOME': '/home/cltbld', 04:52:07 INFO - 'LANG': 'en_US.UTF-8', 04:52:07 INFO - 'LANGUAGE': 'en_US:en', 04:52:07 INFO - 'LOGNAME': 'cltbld', 04:52:07 INFO - 'MAIL': '/var/mail/cltbld', 04:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:07 INFO - 'MOZ_NO_REMOTE': '1', 04:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:07 INFO - 'NO_EM_RESTART': '1', 04:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:07 INFO - 'PWD': '/builds/slave/test', 04:52:07 INFO - 'SHELL': '/bin/bash', 04:52:07 INFO - 'SHLVL': '1', 04:52:07 INFO - 'TERM': 'linux', 04:52:07 INFO - 'TMOUT': '86400', 04:52:07 INFO - 'USER': 'cltbld', 04:52:07 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:07 INFO - '_': '/tools/buildbot/bin/python'} 04:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:07 INFO - Downloading/unpacking flake8 04:52:07 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 04:52:07 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 04:52:07 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 04:52:07 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 04:52:07 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 04:52:07 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 04:52:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:52:09 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 04:52:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:52:09 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 04:52:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52:09 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 04:52:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:09 INFO - no previously-included directories found matching 'docs/_build' 04:52:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:52:09 INFO - Running setup.py install for pep8 04:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:09 INFO - no previously-included directories found matching 'docs/_build' 04:52:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:52:09 INFO - Cleaning up... 04:52:09 INFO - Return code: 0 04:52:09 INFO - Running post-action listener: _resource_record_post_action 04:52:09 INFO - Running post-action listener: _start_resource_monitoring 04:52:10 INFO - Starting resource monitoring. 04:52:10 INFO - ##### 04:52:10 INFO - ##### Running install step. 04:52:10 INFO - ##### 04:52:10 INFO - Running pre-action listener: _resource_record_pre_action 04:52:10 INFO - Running main action method: install 04:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:10 INFO - Reading from file tmpfile_stdout 04:52:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:10 INFO - Reading from file tmpfile_stdout 04:52:10 INFO - Output received: 04:52:10 INFO - Usage: mozinstall [options] installer 04:52:10 INFO - Options: 04:52:10 INFO - -h, --help show this help message and exit 04:52:10 INFO - -d DEST, --destination=DEST 04:52:10 INFO - Directory to install application into. [default: 04:52:10 INFO - "/builds/slave/test"] 04:52:10 INFO - --app=APP Application being installed. [default: firefox] 04:52:10 INFO - mkdir: /builds/slave/test/build/application 04:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:52:24 INFO - Reading from file tmpfile_stdout 04:52:24 INFO - Output received: 04:52:24 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:24 INFO - Running post-action listener: _resource_record_post_action 04:52:24 INFO - ##### 04:52:24 INFO - ##### Running run-tests step. 04:52:24 INFO - ##### 04:52:24 INFO - Running pre-action listener: _resource_record_pre_action 04:52:24 INFO - Running main action method: run_tests 04:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:24 INFO - Python 2.7.3 04:52:24 INFO - Return code: 0 04:52:24 INFO - grabbing minidump binary from tooltool 04:52:24 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')]} 04:52:24 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 0x1a860b0>, '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 0x1a86fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:24 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 04:52:24 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 04:52:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:24 INFO - Return code: 0 04:52:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:52:25 INFO - Return code: 0 04:52:25 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test/build 04:52:25 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 04:52:25 INFO - Using env: {'DISPLAY': ':0', 04:52:25 INFO - 'HOME': '/home/cltbld', 04:52:25 INFO - 'LANG': 'en_US.UTF-8', 04:52:25 INFO - 'LANGUAGE': 'en_US:en', 04:52:25 INFO - 'LOGNAME': 'cltbld', 04:52:25 INFO - 'MAIL': '/var/mail/cltbld', 04:52:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:25 INFO - 'MOZ_NO_REMOTE': '1', 04:52:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:25 INFO - 'NO_EM_RESTART': '1', 04:52:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:25 INFO - 'PWD': '/builds/slave/test', 04:52:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:25 INFO - 'SHELL': '/bin/bash', 04:52:25 INFO - 'SHLVL': '1', 04:52:25 INFO - 'TERM': 'linux', 04:52:25 INFO - 'TMOUT': '86400', 04:52:25 INFO - 'USER': 'cltbld', 04:52:25 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449664552.967766-372634957', 04:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:25 INFO - '_': '/tools/buildbot/bin/python'} 04:52:25 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 04:52:26 INFO - mozversion INFO | application_buildid: 20151209033140 04:52:26 INFO - mozversion INFO | application_changeset: 886e81173514fc537bff7bb176f277ed7024ff41 04:52:26 INFO - mozversion INFO | application_display_name: Nightly 04:52:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:26 INFO - mozversion INFO | application_name: Firefox 04:52:26 INFO - mozversion INFO | application_remotingname: firefox 04:52:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:52:26 INFO - mozversion INFO | application_vendor: Mozilla 04:52:26 INFO - mozversion INFO | application_version: 45.0a1 04:52:26 INFO - mozversion INFO | platform_buildid: 20151209033140 04:52:26 INFO - mozversion INFO | platform_changeset: 886e81173514fc537bff7bb176f277ed7024ff41 04:52:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:52:26 INFO - mozversion INFO | platform_version: 45.0a1 04:52:26 INFO - 2015-12-09 04:52:26,041 DEBUG : using testdate: 1449665546 04:52:26 INFO - 2015-12-09 04:52:26,041 DEBUG : actual date: 1449665546 04:52:26 INFO - 2015-12-09 04:52:26,089 INFO : starting webserver on 'localhost:39341' 04:52:26 INFO - 2015-12-09 04:52:26,090 INFO : Starting test suite talos-linux64-ix-002 04:52:26 INFO - 2015-12-09 04:52:26,090 INFO : Starting test dromaeo_css 04:52:26 INFO - 2015-12-09 04:52:26,090 DEBUG : operating with platform_type : linux_ 04:52:26 INFO - 2015-12-09 04:52:26,091 INFO : Initialising browser for dromaeo_css test... 04:52:26 INFO - 2015-12-09 04:52:26,105 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppoHroJ/profile http://localhost:39341/getInfo.html 04:52:30 INFO - 2015-12-09 04:52:30,222 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:52:30 INFO - 2015-12-09 04:52:30,222 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:52:30 INFO - 2015-12-09 04:52:30,222 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:52:30 INFO - 2015-12-09 04:52:30,222 DEBUG : BROWSER_OUTPUT: __metrics 04:52:30 INFO - 2015-12-09 04:52:30,306 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:52:30 INFO - 2015-12-09 04:52:30,368 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:31 INFO - 2015-12-09 04:52:31,625 INFO : Browser initialized. 04:52:31 INFO - 2015-12-09 04:52:31,625 INFO : Running cycle 1/1 for dromaeo_css test... 04:52:31 INFO - 2015-12-09 04:52:31,626 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppoHroJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:52:43 INFO - 2015-12-09 04:52:43,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 142618624 04:52:43 INFO - 2015-12-09 04:52:43,717 DEBUG : BROWSER_OUTPUT: 04:53:34 INFO - 2015-12-09 04:53:34,987 DEBUG : BROWSER_OUTPUT: 1449665614983 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] 04:55:47 INFO - 2015-12-09 04:55:47,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39341/tests/dromaeo/cssquery-ext.html) 04:55:48 INFO - 2015-12-09 04:55:48,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 221315072 04:55:48 INFO - 2015-12-09 04:55:48,675 DEBUG : BROWSER_OUTPUT: 04:58:51 INFO - 2015-12-09 04:58:51,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/dromaeo/cssquery-ext.html (next: http://localhost:39341/tests/dromaeo/cssquery-jquery.html) 04:58:51 INFO - 2015-12-09 04:58:51,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 221949952 04:58:51 INFO - 2015-12-09 04:58:51,664 DEBUG : BROWSER_OUTPUT: 05:01:53 INFO - 2015-12-09 05:01:53,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39341/tests/dromaeo/cssquery-mootools.html) 05:01:54 INFO - 2015-12-09 05:01:54,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 215150592 05:01:54 INFO - 2015-12-09 05:01:54,242 DEBUG : BROWSER_OUTPUT: 05:04:56 INFO - 2015-12-09 05:04:56,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39341/tests/dromaeo/cssquery-prototype.html) 05:04:56 INFO - 2015-12-09 05:04:56,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 203100160 05:04:56 INFO - 2015-12-09 05:04:56,842 DEBUG : BROWSER_OUTPUT: 05:07:59 INFO - 2015-12-09 05:07:59,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39341/tests/dromaeo/cssquery-yui.html) 05:08:00 INFO - 2015-12-09 05:08:00,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 209027072 05:08:00 INFO - 2015-12-09 05:08:00,088 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/dromaeo/cssquery-yui.html (next: http://localhost:39341/tests/dromaeo/cssquery-dojo.html) 05:11:02 INFO - 2015-12-09 05:11:02,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 257228800 05:11:02 INFO - 2015-12-09 05:11:02,846 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,846 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:11:02 INFO - 2015-12-09 05:11:02,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:11:02 INFO - 2015-12-09 05:11:02,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:11:02 INFO - 2015-12-09 05:11:02,847 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:11:02 INFO - 2015-12-09 05:11:02,847 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2656.800739944504;2733.166384252802;2738.8219765715226;2744.958825617615;2767.9723202767973;4548.067646132543;4687.8359257426;4775.4985726498735;4781.641376896733;4827.251775974725;4667.883302917428;4687.812487500496;4780.498047704984;4899.706017638935;4902;4352.912941741163;4386.166628340621;4440.533743956895;4453.955460445402;4516.819327226907;4318.114786468766;4358.302671572549;4514.503404625505;4535.115652447774;4536.614387777043;4208.726432781859;4294.141171765628;4494.056248187884;4536.56902594253;4540.9091818163615;4330.696851220416;4357.106793107406;4361.563843615645;4366.126774645084;4367.410399596046;4314.956850431487;4315.611594956469;4315.870523884257;4320.308750599889;4321.719088259285;4554.362389265505;4590.059037897223;4616.169089563878;4629.560191781809;4651.023285110131;5214.973925130388;5252.606054545924;5255.474452554752;5257.5005374489365;5297.735113244323;4999.4250661174065;5106.540411362958;5237.240600112962;5275.050490911634;5276.841694749163;4696.272077827942;4717.858464246078;4744.383230180089;4747.881302967385;4752.7623618818925;5234.214867769865;5262.158054711304;5272.077386457355;5277.656952298165;5281.683099014072;5057.418396884332;5082.618803589746;5169.991851588904;5184.988927159167;5185.507376799198;5282.445343238982;5284.128118860345;5284.180951952453;5284.920726189111;5338.599605029638;4929.16204245272;5048.899022019539;5187.221916712523;5211.322528071327;5220.399654039834;5012.548870601663;5022.573081288058;5031.949680503149;5056.646034777604;5120.231965205249;4381.145676593033;4410.80151393188;4413.624841888475;4413.911721765547;4455.376247325377;3809.2762375149186;3833.4249862520846;3862.4978752761963;3875.4768106305287;3886.5336159660455;4300.6129448349175;4384.47386313638;4414.359917811899;4418.867433976986;4481.305397663367;5183.50756678115;5189.896202075937;5200.7139607321205;5205.609579281569;5248.895022099537;4436.889077773017;4438.245498265303;4440.711353761995;4444.266695995189;4476.7090139140855;4408.801603927831;4531.025829446685;4534.319852022223;4566.452025756864;4684.484706682262;4885.560299572913;4899.265110233494;4908.730019848943;4918.311436398907;4955.207166853286;5188.403333616682;5191.377034755854;5192.792288308426;5200.167973124282;5202.97398513005;4692.765361731968;4796.496367881462;4799.184138696361;4813.181759100891;4919.7540122993;5107.514786095315;5137.023965446553;5138.254953031864;5142.357205349332;5197.194434862602;5206.97396513015;5213.921791173059;5215.348081489814;5215.6609820361555;5259.947400525945;4794.424669039738;4895.6083513318135;4900.093482705711;5004.4495105537635;5128.256402821645;5025.3718285214345;5030.974845125751;5034.44621091687;5040.546350828443;5081.8475445736685;4868.513148685245;4904.901901962012;4917.7971520194915;4919;4931.605471562339;4822.132016237111;4882.511748825089;4948.901021979468;4949.950500494949;4997.625178111729;4955.331030310862;4955.82654607087;4958.305837182869;4963.379577552806;5013.949860501494 05:11:02 INFO - 2015-12-09 05:11:02,847 DEBUG : BROWSER_OUTPUT: |1;ext.html;510.2117228881378;521.1739393061998;522.8353068783335;524.8268071536394;533.7464704265475;26656.4668706626;36214.275714485695;36985;37050.62949370512;37102.44346334807;40007.199856002866;40643.59356406435;40669;40698.18603627933;40705.796471017675;6958.930410695904;7086.85826283474;7843.607819609026;8019.077806052321;8020.077691065544;10247.28269021165;10512;10528.263021588491;10538.36769793811;10540.841887371696;10159.695209143738;10245.12916402103;10249.128824049965;10259.589616415371;10265.38407695537;10116.696499105003;10217.97820217976;10218.33580817252;10222.591096356136;10229.079382855505;9885.406875587487;9987.600495980152;10007.499625018792;10009.39943603379;10011.49942502872;37631.81184094089;38236.04409889747;38255;38257.61742382596;38305.23389532221;2744.3962328287944;2749;2922.8100173488656;3254.804711717281;3387.9491807622903;27002.5949610756;27295.590566141524;27390.452190956268;27497.17508474729;27723.53851649013;3492.6681965213265;3502.5096486491657;3521.3485505181366;3590;3605.0987253186704;211647;213912.9304353484;214396;215622;215949;52306.47693523016;55608.443915560325;56005.43994560084;56012.719936400055;56029;46927.76536117366;66012;67623.66188169028;67705;67900.32099678939;14631;14974.925125374304;14984.47554335593;14986.775198372034;14990.700185996218;8248.422610417214;8563.143685631512;10756.139508839275;11260.549578016951;11384.658460246206;19404.417867464;19469.415917522496;19507.992629849054;19520.453875773503;19528.609427811363;7336.559806411632;7492.100947886289;7569.318761311399;7682.500637458547;7706.922930770733;801.3789313282136;874.8600223964136;929.8419268724333;969.8933117357085;1015.5074788727461;26542.203733888015;26622;26732.727718143786;26743.19770406891;26909.461810764067;912.707933461286;925.9305552083621;928.6842473559022;930.2557953637063;955.0354142316172;13928.51250206238;14709.92645036768;16158.27287772053;16338.591535211477;16521.83478165227;301161;306007;306146;306902;307070;48774.51225487771;49131.263031054565;49398;49428.752856236206;49475.25787113196;1220.8351872497276;1227.79127548317;1229.065909908458;1242.87571242875;1342.5032737887045;27654.44691106207;28359.43281134407;28476.430471390042;28640;28993.565096523147;40664.1867162661;41189.382159267036;41275.793621031706;41326.1734765297;41328.38007429831;240078;247467;247542;304706;313606;27809.58285625677;27875.86062069758;27877.303067423476;27904.16287511378;28244.293892652848;34759.39291602528;35673;35975;36234.09414764652;36308.63691363052;32326.676733233307;32404.35191296208;33293.83353083316;33700.662993369755;34032;33701.831490842385;33796.662033379354;33930.83034584811;33934.66065339315;33965.49051764275;33788.493172602924;33969.66030339665;36113.63886361103;36525.81737091298;36638.267234655694;28140.43719125647;30353.24116897095;30476.851392882454;30569.08292751221;32219.838900805345;24084.27747167588;24273.75726242715;25003;25188.874055629603;25309.493810124062 05:11:02 INFO - 2015-12-09 05:11:02,847 DEBUG : BROWSER_OUTPUT: |2;jquery.html;264.63876808156874;269.3145943573605;271.11616131411597;273.6633940253487;276.7218944960315;10735.974009746345;15367.615809604766;15830.68338633228;15835.762463563056;16025.759613605776;16346.754798678;16642.08468534233;16656.33374665015;16661.583460413465;17179.656406871887;5604.299462567169;5751.281089863767;5785.2189954356045;5786.479216870481;5787.363390027093;5664.716764161796;5707;5709.914351284734;5715.885682286352;5715.9428405716035;4057.573954734755;4132.938005929914;5529.834104976857;5693.202951586781;6396.072569477423;6453.386928241809;6496.740130394778;6505.186851643544;6533.836654083662;6546.44355229806;6078.787242446493;6249.375062493759;6251.12484252205;6257.43683068526;6261.373862613747;20055.49861253466;20433.4891627709;20665.830087840863;20829.16683332665;20898.164073437045;1875.7092650639172;1895.5924476237537;1953.2870502266712;1969.3698016634683;2184.912603495858;13251.204927704368;13377.732445351136;13524.12093213938;13538.323083845768;13874.098183618033;1867.6918308479085;1895.4408449507428;1916.980830191708;1917.9520511987173;1990.2138655231104;56364;60604.939506049486;60705.696471517804;61173;62119.37880621226;14309.57071287863;14929.552113436614;14952.327145278488;14991.625209369635;15018.849811501963;21534.892325538585;21560.784392155878;21590.784092159192;21609.35171944813;21612.89193554022;7980.720674776471;8007.6796928123385;8041.155678653774;8058.597070146587;8072.071711753106;6660.666966651648;6682.866342673216;6693.966530167318;6701.865962680719;6729.730810767613;7407.8148046299275;7495.962520187473;7499.700011999459;7580.658870350848;7584.431167662337;2293.048384920273;2905.4043920996146;2977.7766667500023;3018.4717674406893;3028.757699384044;333.7980521784334;335.9143418428285;340.25144681700357;797.147052653655;915.4736026784625;9274.675386361445;9416.529173541296;9535.140647573795;9756.658516952015;9782.853257201148;826.0679167164221;849.367221420046;895.3195571365809;902.5351943748974;931.2084727981162;8386.329093672492;8418.663253469793;8622.611982460805;8636.136386361313;8784.78038049041;443672;448397;480189;483635;496912;35498.82250588731;59086.704566476896;60676.48308792315;61996.38003619906;64148.358516415174;1047.518141654832;1062.2935747727674;1078.3152698036647;1100.5707773968159;1105.1214284643727;14681.48614798477;14695.485658001919;14746.188959607325;14891.329890154753;15027.549173524812;33870.66129338675;33896.322073558884;34623.82688086543;34780.47829282512;35030;44955;45490;45821.31268030916;46081.30878036899;49512;8318.37612179101;8400;8603.569821508774;8617.181367770052;8765.474071555727;10124.493775311352;10130.08829205375;10157.695269141937;10238.692839214835;13555.86444135546;13854.722905541632;13904.276092934268;14079;14227.715445691236;14472.421103155755;13753.724925501234;13955.232462214675;14006.78989815174;14031.438742450597;14518.128912265298;14458;14487.565373038826;14733.55799326022;14824.851751482778;14854.183019933575;8105.75682729519;8814.33892458081;8814.735557933273;8842.204201621886;8845.69040083594;8984.550772461482;9075.954620226856;12276.508939642314;12951.805722914352;13732.588022359345 05:11:02 INFO - 2015-12-09 05:11:02,848 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1389.472000639758;1574.4332040465433;1654.2225154177531;1655.511624070899;1692.2215780740858;5875.853103672405;7057.153141623006;7238.276172382759;7254.492185547014;7254.637268136598;7120.323569260912;7261.782146535613;7266.854662906739;7269.5638261704335;7274.927250727491;1997.1312479071614;2026.412340421276;2030.8273796727296;2031.5733695923873;2034.806693364128;1889.763779527559;1924.4034349351746;1933.2556965568288;1951.3853136262103;1953.6226959993242;2008.1666108564928;2016.5966806638658;2049.948751281215;2053.743282089739;2054.7739748627637;2017.9899100504476;2038.847086468506;2039.2250944641016;2041.8774873507489;2042.244369583249;1982.3161009451717;1995.461225469115;2004.7494063242095;2007.0867755171362;2015.4961259685078;7110;7164;7174.605396703179;7179.820504487378;7186.425085993108;4183.079722461053;4227.154569086195;4232.25935461293;4250.851220207278;4268.274393353137;2652.151311580295;2684.181324695967;2705.905293314744;2730.84980326082;2750.4636595863813;785.35600807338;809.8056466448069;824.3322908444179;834.4909605140859;835.4402550291319;9810;9810.509474526316;9817.558209880572;9837.55730992107;9847.409155450696;3750.456183853326;3756.380197267475;3792.829322680486;3802.923941521154;3803.8478460861256;8448.366372522085;8468.44955077918;8487.066422693499;8487.278581320657;8488.066312705598;4293.549177336335;4308.612224899774;4320.848770293088;4321.373400856921;4327.02641905575;3230.7576931729745;3292.9176770580925;3783.754055986352;3941.763494190358;3943.2902077626304;3373.1904342957514;3380.4422270325613;3390.4744764561533;3403.9659603404143;3426.194844211608;997.6558087459815;999.14073896449;1003.1222680154865;1013.7820368620781;1014.5434554450527;778.7196609220676;778.7741554949115;779.5595488548952;782.3545574900729;795.5584650518902;6647.634380109141;6736.696848641823;6795.558288711218;6795.694193761194;7017.719291228395;907.4509921497531;921.7972046149837;929.7722058095675;929.990700093004;1028.4703377760459;5188.662736922088;5244.816431424958;5251.159814429673;5254.65844720092;5260.368755749335;7895.407844411692;8024.759257222293;8052.5571093590415;8131.349492040623;8523.872141917876;8394.538300393537;8536.359773017048;8656;8669.046404895456;8669.696560620348;6573.901391479131;6592.30780768022;6815.965920170466;6870;6870.553414028072;6838.521303508706;6887.931120688729;6888.173419189528;6896.103506544117;6898.172219333712;7699.615019249127;7792.181820908723;7801.453898227297;7806.41451891099;7927.048754149539;7917.960410197912;8041.517508949481;8106.716264930699;8110.31062359706;8166.673333066611;5998.580099393001;6020.578559500793;6111.694415279308;6137.35557766446;6149.323574406722;6834.316568343126;6886.931130688829;6904.102466679299;6912.827179320558;6958.652067396712;6404.423601875854;6477.708503117466;6478.902816457851;6505.902411463927;6516.57642253252;6231.4391704746795;6245.8750824982335;6329.272133704683;6408.455281300955;6426.646534440651;5382.892342153056;5454.59090568201;5455.699936503372;6373.5857169283845;6398.5521013528605;5405.810796622257;5672.829815105553;5727.8568035799435;5759.337676167294;5799.188113664006;6124.265088189446;6133.815985520441;6159.6612186330185;6165.5375846810775;6168.35232300602 05:11:02 INFO - 2015-12-09 05:11:02,850 DEBUG : BROWSER_OUTPUT: |4;prototype.html;252.1389455011137;252.91527338341658;254.58248472505096;258.6934482638074;260.33873960141244;5391.460853914607;5407.215953686718;5415.214793854889;5475.972620136894;5509.862253443666;5244.108501554735;5426.050441172799;5437.211604317372;5449.291592093023;5453.64551304165;4065.9796701016453;4082.5100987881347;4095.3856921461797;4098.241825262336;4099.959000409987;3852.4028775539837;4058.4521089652962;4096.406021126935;4098.422107488624;4100.056986893016;3895.357266051098;3907.882763517099;4010.4385386045833;4011.277969965405;4020.718549701522;3997.7801220932984;4023.959760402388;4027.577104404025;4029.2747305485;4030.3349947258666;3226.91932701682;3270.60752709674;3367.51171080192;3437.432823584106;3439.8796042138406;5209;5209.661372010807;5228.816991405321;5238.895222095575;5250.7374631268285;4635.860924172281;4644.047970166108;4649.093426781779;4653.162430762462;4653.371794807692;5706.514946229576;5710.486056254916;5712.028955077647;5712.57155713319;5716.82805024973;3654.798986055766;3757.342465068602;3758.0604848787802;3764.0401697567218;3768.4912536807456;5989.191459153046;6056.5457590680435;6063.514918806529;6068.939310606926;6070.514358851281;3849.9615003850163;3855.248226595787;3858.1897801462005;3858.6141385861188;3861.942070868939;3894.8636797711943;3895.0651843557907;3895.3767397216875;3906.140649057203;3913.25648126855;4502.144592527409;4569.702969306984;4593.655475839326;4598.586127248564;4603.49361570227;5728.226689396962;5731.484166425042;5732.942670573241;5737.569682273846;5749.7700091996685;1360.5578187089236;1381.9654508637364;1384.1003347823794;1384.6815232496583;1386.535510603959;883.9734807955772;889.5107690770051;895;908.4276905549461;909.7589138878203;5033.1695270280725;5042.344495215599;5042.697438153723;5049.368828896388;5049.419316778544;5980.192673989043;5985.820425387245;5988.221531200916;5988.970055149784;5993.520518358521;5032.698038117652;5041.369828771403;5041.470645582161;5043.470435604282;5053.090443720165;3154.6372167200607;3195;3199.0722690419516;3223.935521289561;3229.6931791479774;5475.780968761284;5613.747381367766;5614.578906582023;5628.296462942132;5632.436756324335;6061.878762424815;6192.783252586138;6215.595986260879;6216.067589861557;6216.7824126155365;5686.943130568641;5687.03320435527;5693.117566777156;5694.288213973254;5694.4590263924865;5894.469497745224;6035.668038257938;6036;6037.426444487766;6040.637561746309;5888.411158884249;5890.646561206341;5893.086571581412;5895.852603684943;5897.498712609305;5674.120511320752;5678.77284908599;5687.118496633028;5687.43125687428;5687.744051517774;3826.5025546678753;3827.464155018244;3828.081260497405;3831;3831.348670726039;5868.911966320423;6019.127226552213;6024.849378765566;6043.153958445733;6046.697665116639;5722.399148089391;5803.332616749128;5806.970965145148;5810.854728631818;5810.883782324415;5749.051406517878;5769.94230057694;5784.768609255582;5797.594168408171;5810.912836307543;5470.480304371237;5636.070048441961;5639.182318563868;5645.040343141593;5651.802186923438;5833.300003999547;5833.7666493341485;5838.1826544282985;5844.4155584442915;5845.1232315153065;5612.635178713371;5640.661560306395;5654.886902262014;5658.490735833795;5665.12190610456 05:11:02 INFO - 2015-12-09 05:11:02,851 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.6882902693787;693.6809067828805;697.1320705721378;699.9895001574974;711.7402148215901;11043.889561104386;11293.20947533671;11298.717532061703;11305.604303849366;11306.434678266085;11939.58211462599;12013.399330033486;12022.098342624295;12041.939790301036;12048.57829975951;610.825914614335;617.1236843681983;754.456791110401;774.4540099230029;784.6861255497789;784.654751909161;786.8229648329137;788.4244501513898;790.9367250619965;791.0112359550562;810.222186700768;814.7067055859885;815.1644564321558;816.0819078536646;816.2205094135087;634.1629049654458;642.9839254018664;803.5660743198665;816.8611336072881;818.3289702443998;605.1890466774544;605.5851741557047;606.2876120558326;606.4390438844051;609.3601718195877;11237.662870113909;11319.943400283028;11373.260738052;11383.715407114889;11393.088552915748;10395;11253.437328133643;11431.314121152674;11592.942035289854;11612.303261804318;8513.702020429255;8621.784455388603;8705;8893.333000025024;8902.643894244222;3161.920951976196;3174.1271150433818;3184.1402821238366;3208.871645134192;3248.756343274264;38862.80568597139;38973.61026389728;39037;39161;39769.60230397659;7952.085510166289;8002.599870006593;8027.518348899085;8059.395545334123;8263.95868020656;15470.535883923276;15520.068795872285;15525.378984840705;15545.844541554667;15556.066636001877;6074.271087469444;6191.226096737908;6203.31763506014;6215.751369945242;6244.313125556185;3345.9627515470283;3348.2466445050154;3355.1947532592003;3459.9135021624156;3488.66857648523;2538.695356557225;2581.664383630116;2582.728813474596;2584.870756462207;2586.120718955564;441.9867403977886;442.48450555103585;447.6195234051096;464.4101990472149;466.79694332965266;438.6666133738382;522.9843104706865;531.2482836785905;531.4313684357777;536.3081624704166;6417.101605775195;6580.341965803382;6583.835404114935;6620.668966551653;6665.100211471487;376.4409851370712;445.7971622911632;519.1485963020649;536.3215532351578;555.5278013688413;3269.8201598912287;3351.162209447638;3395.8811441599423;3440.82795860206;3486.442169252958;46849;46934.765326173154;46996.5300346999;47077.529224708;47304;42179.36730949038;42555;42944.35583466251;43389.34915976263;43474;40065;40132.398014029815;40257;40284.1943161141;40872.38691419631;6840.6921688525135;6951.617661028489;6958.373746362851;6979.4765392594745;7184.497085203986;29577.112686619435;31071.912483062984;31104.533431998992;32167.839160804047;32678.183045424055;37974.43038354372;38352;38566.42150367691;38814;39263.60736392599;9285.72142835716;9462.479563624067;9504.95247523758;9980.351277166961;9999.850002249827;10319.122874555747;10578.100861426865;10728.946355268487;10758.946205268923;10766;9193.77015574616;9355.812883742423;9402.529873506433;9471.289653275893;9486.667966621411;10072.597096116366;10080.193584513074;10125.493725313852;10235.393230586431;10471.79056418852;9669.903300967182;9818.558164882455;10268.845967310346;10286.485675716034;10301.175905927357;8961.148690874357;9074.228690561113;9269.953650231706;9414.460436649992;9697.272704547046;8104.351651867719;8287.917120828715;8503.489790612583;8616.439931404439;8708.477491350539 05:11:02 INFO - 2015-12-09 05:11:02,851 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:11:02 INFO - 2015-12-09 05:11:02,851 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:11:02 INFO - 2015-12-09 05:11:02,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 05:11:02 INFO - 2015-12-09 05:11:02,851 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:11:02 INFO - 2015-12-09 05:11:02,851 DEBUG : BROWSER_OUTPUT: __startTimestamp1449666662839__endTimestamp 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4750.98 Median:4895.61 stddev:508.07 (10.4%) stddev-sans-first:482.33 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: Values: 2656.8 2733.2 2738.8 2745.0 2768.0 4548.1 4687.8 4775.5 4781.6 4827.3 4667.9 4687.8 4780.5 4899.7 4902.0 4352.9 4386.2 4440.5 4454.0 4516.8 4318.1 4358.3 4514.5 4535.1 4536.6 4208.7 4294.1 4494.1 4536.6 4540.9 4330.7 4357.1 4361.6 4366.1 4367.4 4315.0 4315.6 4315.9 4320.3 4321.7 4554.4 4590.1 4616.2 4629.6 4651.0 5215.0 5252.6 5255.5 5257.5 5297.7 4999.4 5106.5 5237.2 5275.1 5276.8 4696.3 4717.9 4744.4 4747.9 4752.8 5234.2 5262.2 5272.1 5277.7 5281.7 5057.4 5082.6 5170.0 5185.0 5185.5 5282.4 5284.1 5284.2 5284.9 5338.6 4929.2 5048.9 5187.2 5211.3 5220.4 5012.5 5022.6 5031.9 5056.6 5120.2 4381.1 4410.8 4413.6 4413.9 4455.4 3809.3 3833.4 3862.5 3875.5 3886.5 4300.6 4384.5 4414.4 4418.9 4481.3 5183.5 5189.9 5200.7 5205.6 5248.9 4436.9 4438.2 4440.7 4444.3 4476.7 4408.8 4531.0 4534.3 4566.5 4684.5 4885.6 4899.3 4908.7 4918.3 4955.2 5188.4 5191.4 5192.8 5200.2 5203.0 4692.8 4796.5 4799.2 4813.2 4919.8 5107.5 5137.0 5138.3 5142.4 5197.2 5207.0 5213.9 5215.3 5215.7 5259.9 4794.4 4895.6 4900.1 5004.4 5128.3 5025.4 5031.0 5034.4 5040.5 5081.8 4868.5 4904.9 4917.8 4919.0 4931.6 4822.1 4882.5 4948.9 4950.0 4997.6 4955.3 4955.8 4958.3 4963.4 5013.9 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42853.70 Median:32273.26 stddev:69682.46 (215.9%) stddev-sans-first:69805.41 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: Values: 510.2 521.2 522.8 524.8 533.7 26656.5 36214.3 36985.0 37050.6 37102.4 40007.2 40643.6 40669.0 40698.2 40705.8 6958.9 7086.9 7843.6 8019.1 8020.1 10247.3 10512.0 10528.3 10538.4 10540.8 10159.7 10245.1 10249.1 10259.6 10265.4 10116.7 10218.0 10218.3 10222.6 10229.1 9885.4 9987.6 10007.5 10009.4 10011.5 37631.8 38236.0 38255.0 38257.6 38305.2 2744.4 2749.0 2922.8 3254.8 3387.9 27002.6 27295.6 27390.5 27497.2 27723.5 3492.7 3502.5 3521.3 3590.0 3605.1 211647.0 213912.9 214396.0 215622.0 215949.0 52306.5 55608.4 56005.4 56012.7 56029.0 46927.8 66012.0 67623.7 67705.0 67900.3 14631.0 14974.9 14984.5 14986.8 14990.7 8248.4 8563.1 10756.1 11260.5 11384.7 19404.4 19469.4 19508.0 19520.5 19528.6 7336.6 7492.1 7569.3 7682.5 7706.9 801.4 874.9 929.8 969.9 1015.5 26542.2 26622.0 26732.7 26743.2 26909.5 912.7 925.9 928.7 930.3 955.0 13928.5 14709.9 16158.3 16338.6 16521.8 301161.0 306007.0 306146.0 306902.0 307070.0 48774.5 49131.3 49398.0 49428.8 49475.3 1220.8 1227.8 1229.1 1242.9 1342.5 27654.4 28359.4 28476.4 28640.0 28993.6 40664.2 41189.4 41275.8 41326.2 41328.4 240078.0 247467.0 247542.0 304706.0 313606.0 27809.6 27875.9 27877.3 27904.2 28244.3 34759.4 35673.0 35975.0 36234.1 36308.6 32326.7 32404.4 33293.8 33700.7 34032.0 33701.8 33796.7 33930.8 33934.7 33965.5 33788.5 33969.7 36113.6 36525.8 36638.3 28140.4 30353.2 30476.9 30569.1 32219.8 24084.3 24273.8 25003.0 25188.9 25309.5 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,852 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26281.61 Median:35264.41 stddev:76733.19 (217.6%) stddev-sans-first:76923.57 05:11:02 INFO - 2015-12-09 05:11:02,853 DEBUG : BROWSER_OUTPUT: Values: 264.6 269.3 271.1 273.7 276.7 10736.0 15367.6 15830.7 15835.8 16025.8 16346.8 16642.1 16656.3 16661.6 17179.7 5604.3 5751.3 5785.2 5786.5 5787.4 5664.7 5707.0 5709.9 5715.9 5715.9 4057.6 4132.9 5529.8 5693.2 6396.1 6453.4 6496.7 6505.2 6533.8 6546.4 6078.8 6249.4 6251.1 6257.4 6261.4 20055.5 20433.5 20665.8 20829.2 20898.2 1875.7 1895.6 1953.3 1969.4 2184.9 13251.2 13377.7 13524.1 13538.3 13874.1 1867.7 1895.4 1917.0 1918.0 1990.2 56364.0 60604.9 60705.7 61173.0 62119.4 14309.6 14929.6 14952.3 14991.6 15018.8 21534.9 21560.8 21590.8 21609.4 21612.9 7980.7 8007.7 8041.2 8058.6 8072.1 6660.7 6682.9 6694.0 6701.9 6729.7 7407.8 7496.0 7499.7 7580.7 7584.4 2293.0 2905.4 2977.8 3018.5 3028.8 333.8 335.9 340.3 797.1 915.5 9274.7 9416.5 9535.1 9756.7 9782.9 826.1 849.4 895.3 902.5 931.2 8386.3 8418.7 8622.6 8636.1 8784.8 443672.0 448397.0 480189.0 483635.0 496912.0 35498.8 59086.7 60676.5 61996.4 64148.4 1047.5 1062.3 1078.3 1100.6 1105.1 14681.5 14695.5 14746.2 14891.3 15027.5 33870.7 33896.3 34623.8 34780.5 35030.0 44955.0 45490.0 45821.3 46081.3 49512.0 8318.4 8400.0 8603.6 8617.2 8765.5 10124.5 10130.1 10157.7 10238.7 13555.9 13854.7 13904.3 14079.0 14227.7 14472.4 13753.7 13955.2 14006.8 14031.4 14518.1 14458.0 14487.6 14733.6 14824.9 14854.2 8105.8 8814.3 8814.7 8842.2 8845.7 8984.6 9076.0 12276.5 12951.8 13732.6 05:11:02 INFO - 2015-12-09 05:11:02,853 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,853 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4959.71 Median:6351.43 stddev:2625.74 (41.3%) stddev-sans-first:2619.40 05:11:02 INFO - 2015-12-09 05:11:02,853 DEBUG : BROWSER_OUTPUT: Values: 1389.5 1574.4 1654.2 1655.5 1692.2 5875.9 7057.2 7238.3 7254.5 7254.6 7120.3 7261.8 7266.9 7269.6 7274.9 1997.1 2026.4 2030.8 2031.6 2034.8 1889.8 1924.4 1933.3 1951.4 1953.6 2008.2 2016.6 2049.9 2053.7 2054.8 2018.0 2038.8 2039.2 2041.9 2042.2 1982.3 1995.5 2004.7 2007.1 2015.5 7110.0 7164.0 7174.6 7179.8 7186.4 4183.1 4227.2 4232.3 4250.9 4268.3 2652.2 2684.2 2705.9 2730.8 2750.5 785.4 809.8 824.3 834.5 835.4 9810.0 9810.5 9817.6 9837.6 9847.4 3750.5 3756.4 3792.8 3802.9 3803.8 8448.4 8468.4 8487.1 8487.3 8488.1 4293.5 4308.6 4320.8 4321.4 4327.0 3230.8 3292.9 3783.8 3941.8 3943.3 3373.2 3380.4 3390.5 3404.0 3426.2 997.7 999.1 1003.1 1013.8 1014.5 778.7 778.8 779.6 782.4 795.6 6647.6 6736.7 6795.6 6795.7 7017.7 907.5 921.8 929.8 930.0 1028.5 5188.7 5244.8 5251.2 5254.7 5260.4 7895.4 8024.8 8052.6 8131.3 8523.9 8394.5 8536.4 8656.0 8669.0 8669.7 6573.9 6592.3 6816.0 6870.0 6870.6 6838.5 6887.9 6888.2 6896.1 6898.2 7699.6 7792.2 7801.5 7806.4 7927.0 7918.0 8041.5 8106.7 8110.3 8166.7 5998.6 6020.6 6111.7 6137.4 6149.3 6834.3 6886.9 6904.1 6912.8 6958.7 6404.4 6477.7 6478.9 6505.9 6516.6 6231.4 6245.9 6329.3 6408.5 6426.6 5382.9 5454.6 5455.7 6373.6 6398.6 5405.8 5672.8 5727.9 5759.3 5799.2 6124.3 6133.8 6159.7 6165.5 6168.4 05:11:02 INFO - 2015-12-09 05:11:02,853 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,853 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4697.43 Median:5443.25 stddev:1461.74 (26.9%) stddev-sans-first:1427.26 05:11:02 INFO - 2015-12-09 05:11:02,854 DEBUG : BROWSER_OUTPUT: Values: 252.1 252.9 254.6 258.7 260.3 5391.5 5407.2 5415.2 5476.0 5509.9 5244.1 5426.1 5437.2 5449.3 5453.6 4066.0 4082.5 4095.4 4098.2 4100.0 3852.4 4058.5 4096.4 4098.4 4100.1 3895.4 3907.9 4010.4 4011.3 4020.7 3997.8 4024.0 4027.6 4029.3 4030.3 3226.9 3270.6 3367.5 3437.4 3439.9 5209.0 5209.7 5228.8 5238.9 5250.7 4635.9 4644.0 4649.1 4653.2 4653.4 5706.5 5710.5 5712.0 5712.6 5716.8 3654.8 3757.3 3758.1 3764.0 3768.5 5989.2 6056.5 6063.5 6068.9 6070.5 3850.0 3855.2 3858.2 3858.6 3861.9 3894.9 3895.1 3895.4 3906.1 3913.3 4502.1 4569.7 4593.7 4598.6 4603.5 5728.2 5731.5 5732.9 5737.6 5749.8 1360.6 1382.0 1384.1 1384.7 1386.5 884.0 889.5 895.0 908.4 909.8 5033.2 5042.3 5042.7 5049.4 5049.4 5980.2 5985.8 5988.2 5989.0 5993.5 5032.7 5041.4 5041.5 5043.5 5053.1 3154.6 3195.0 3199.1 3223.9 3229.7 5475.8 5613.7 5614.6 5628.3 5632.4 6061.9 6192.8 6215.6 6216.1 6216.8 5686.9 5687.0 5693.1 5694.3 5694.5 5894.5 6035.7 6036.0 6037.4 6040.6 5888.4 5890.6 5893.1 5895.9 5897.5 5674.1 5678.8 5687.1 5687.4 5687.7 3826.5 3827.5 3828.1 3831.0 3831.3 5868.9 6019.1 6024.8 6043.2 6046.7 5722.4 5803.3 5807.0 5810.9 5810.9 5749.1 5769.9 5784.8 5797.6 5810.9 5470.5 5636.1 5639.2 5645.0 5651.8 5833.3 5833.8 5838.2 5844.4 5845.1 5612.6 5640.7 5654.9 5658.5 5665.1 05:11:02 INFO - 2015-12-09 05:11:02,854 DEBUG : BROWSER_OUTPUT: 05:11:02 INFO - 2015-12-09 05:11:02,854 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11757.66 Median:23657.90 stddev:13420.62 (56.7%) stddev-sans-first:13432.54 05:11:02 INFO - 2015-12-09 05:11:02,855 DEBUG : BROWSER_OUTPUT: Values: 692.7 693.7 697.1 700.0 711.7 11043.9 11293.2 11298.7 11305.6 11306.4 11939.6 12013.4 12022.1 12041.9 12048.6 610.8 617.1 754.5 774.5 784.7 784.7 786.8 788.4 790.9 791.0 810.2 814.7 815.2 816.1 816.2 634.2 643.0 803.6 816.9 818.3 605.2 605.6 606.3 606.4 609.4 11237.7 11319.9 11373.3 11383.7 11393.1 10395.0 11253.4 11431.3 11592.9 11612.3 8513.7 8621.8 8705.0 8893.3 8902.6 3161.9 3174.1 3184.1 3208.9 3248.8 38862.8 38973.6 39037.0 39161.0 39769.6 7952.1 8002.6 8027.5 8059.4 8264.0 15470.5 15520.1 15525.4 15545.8 15556.1 6074.3 6191.2 6203.3 6215.8 6244.3 3346.0 3348.2 3355.2 3459.9 3488.7 2538.7 2581.7 2582.7 2584.9 2586.1 442.0 442.5 447.6 464.4 466.8 438.7 523.0 531.2 531.4 536.3 6417.1 6580.3 6583.8 6620.7 6665.1 376.4 445.8 519.1 536.3 555.5 3269.8 3351.2 3395.9 3440.8 3486.4 46849.0 46934.8 46996.5 47077.5 47304.0 42179.4 42555.0 42944.4 43389.3 43474.0 40065.0 40132.4 40257.0 40284.2 40872.4 6840.7 6951.6 6958.4 6979.5 7184.5 29577.1 31071.9 31104.5 32167.8 32678.2 37974.4 38352.0 38566.4 38814.0 39263.6 9285.7 9462.5 9505.0 9980.4 9999.9 10319.1 10578.1 10728.9 10758.9 10766.0 9193.8 9355.8 9402.5 9471.3 9486.7 10072.6 10080.2 10125.5 10235.4 10471.8 9669.9 9818.6 10268.8 10286.5 10301.2 8961.1 9074.2 9270.0 9414.5 9697.3 8104.4 8287.9 8503.5 8616.4 8708.5 05:11:02 INFO - 2015-12-09 05:11:02,856 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:11:02 INFO - 2015-12-09 05:11:02,856 DEBUG : BROWSER_OUTPUT: 05:11:03 INFO - 2015-12-09 05:11:03,640 INFO : Browser exited with error code: 0 05:11:03 INFO - 2015-12-09 05:11:03,658 INFO : Completed test dromaeo_css (00:18:37) 05:11:03 INFO - 2015-12-09 05:11:03,658 INFO : Starting test kraken 05:11:03 INFO - 2015-12-09 05:11:03,658 DEBUG : operating with platform_type : linux_ 05:11:03 INFO - 2015-12-09 05:11:03,658 INFO : Initialising browser for kraken test... 05:11:03 INFO - 2015-12-09 05:11:03,664 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNfrvty/profile http://localhost:39341/getInfo.html 05:11:07 INFO - 2015-12-09 05:11:07,903 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:07 INFO - 2015-12-09 05:11:07,903 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:07 INFO - 2015-12-09 05:11:07,903 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:11:07 INFO - 2015-12-09 05:11:07,904 DEBUG : BROWSER_OUTPUT: __metrics 05:11:07 INFO - 2015-12-09 05:11:07,980 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] 05:11:08 INFO - 2015-12-09 05:11:08,056 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:08 ERROR - 2015-12-09 05:11:08,063 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:11:08 INFO - 2015-12-09 05:11:08,983 INFO : Browser initialized. 05:11:08 INFO - 2015-12-09 05:11:08,983 INFO : Running cycle 1/1 for kraken test... 05:11:08 INFO - 2015-12-09 05:11:08,984 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNfrvty/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:20 INFO - 2015-12-09 05:11:20,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 143015936 05:11:20 INFO - 2015-12-09 05:11:20,988 DEBUG : BROWSER_OUTPUT: 05:11:23 INFO - 2015-12-09 05:11:23,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39341/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:24 INFO - 2015-12-09 05:11:24,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 176373760 05:11:24 INFO - 2015-12-09 05:11:24,229 DEBUG : BROWSER_OUTPUT: 05:11:27 INFO - 2015-12-09 05:11:27,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39341/tests/kraken/driver.html?testName=audio-dft) 05:11:27 INFO - 2015-12-09 05:11:27,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 166993920 05:11:27 INFO - 2015-12-09 05:11:27,593 DEBUG : BROWSER_OUTPUT: 05:11:30 INFO - 2015-12-09 05:11:30,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39341/tests/kraken/driver.html?testName=audio-fft) 05:11:31 INFO - 2015-12-09 05:11:31,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 153903104 05:11:31 INFO - 2015-12-09 05:11:31,174 DEBUG : BROWSER_OUTPUT: 05:11:33 INFO - 2015-12-09 05:11:33,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39341/tests/kraken/driver.html?testName=audio-oscillator) 05:11:33 INFO - 2015-12-09 05:11:33,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 156188672 05:11:33 INFO - 2015-12-09 05:11:33,794 DEBUG : BROWSER_OUTPUT: 05:11:36 INFO - 2015-12-09 05:11:36,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:36 INFO - 2015-12-09 05:11:36,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 157462528 05:11:36 INFO - 2015-12-09 05:11:36,626 DEBUG : BROWSER_OUTPUT: 05:11:39 INFO - 2015-12-09 05:11:39,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39341/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:40 INFO - 2015-12-09 05:11:40,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 158826496 05:11:40 INFO - 2015-12-09 05:11:40,184 DEBUG : BROWSER_OUTPUT: 05:11:43 INFO - 2015-12-09 05:11:43,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39341/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:44 INFO - 2015-12-09 05:11:44,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 157765632 05:11:44 INFO - 2015-12-09 05:11:44,158 DEBUG : BROWSER_OUTPUT: 05:11:47 INFO - 2015-12-09 05:11:47,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39341/tests/kraken/driver.html?testName=json-parse-financial) 05:11:47 INFO - 2015-12-09 05:11:47,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 158289920 05:11:47 INFO - 2015-12-09 05:11:47,617 DEBUG : BROWSER_OUTPUT: 05:11:49 INFO - 2015-12-09 05:11:49,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:49 INFO - 2015-12-09 05:11:49,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 168230912 05:11:49 INFO - 2015-12-09 05:11:49,964 DEBUG : BROWSER_OUTPUT: 05:11:51 INFO - 2015-12-09 05:11:51,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:11:52 INFO - 2015-12-09 05:11:52,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 168439808 05:11:52 INFO - 2015-12-09 05:11:52,482 DEBUG : BROWSER_OUTPUT: 05:11:54 INFO - 2015-12-09 05:11:54,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:11:55 INFO - 2015-12-09 05:11:55,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 178003968 05:11:55 INFO - 2015-12-09 05:11:55,208 DEBUG : BROWSER_OUTPUT: 05:11:57 INFO - 2015-12-09 05:11:57,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:11:58 INFO - 2015-12-09 05:11:58,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 182775808 05:11:58 INFO - 2015-12-09 05:11:58,318 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-12-09 05:12:00,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:01 INFO - 2015-12-09 05:12:01,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 180883456 05:12:01 INFO - 2015-12-09 05:12:01,521 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39341/tests/kraken/driver.html?testName=ai-astar) 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 239771648 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;108;113;113;113;104;113;114;106 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;140;154;169;131;160;153;132;167;130 05:12:03 INFO - 2015-12-09 05:12:03,555 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;161;161;162;164;162;162;162;161 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;76;91;72;72;73;83;102;72 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;132;94;95;94;132;95;96;130 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;147;147;146;147;146;146;146;146 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;73;72;73;74;72;81;69;70 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;70;70;77;69;70;69;69 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;85;86;86;94;85;88;85 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;116;131;118;117;128;124;119;128;127 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;141;148;136;153;144;158;154;157;136 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;70;69;71;70;69;71;68;71 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:12:03 INFO - 2015-12-09 05:12:03,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,991 05:12:03 INFO - 2015-12-09 05:12:03,557 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:12:03 INFO - 2015-12-09 05:12:03,557 DEBUG : BROWSER_OUTPUT: __startTimestamp1449666723549__endTimestamp 05:12:03 INFO - 2015-12-09 05:12:03,557 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,557 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:12:03 INFO - 2015-12-09 05:12:03,557 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:12:03 INFO - 2015-12-09 05:12:03,557 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,558 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.62 (3.2%) stddev-sans-first:3.82 05:12:03 INFO - 2015-12-09 05:12:03,558 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 108.0 113.0 113.0 113.0 104.0 113.0 114.0 106.0 05:12:03 INFO - 2015-12-09 05:12:03,558 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,558 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.00 stddev:15.58 (9.9%) stddev-sans-first:15.57 05:12:03 INFO - 2015-12-09 05:12:03,558 DEBUG : BROWSER_OUTPUT: Values: 165.0 140.0 154.0 169.0 131.0 160.0 153.0 132.0 167.0 130.0 05:12:03 INFO - 2015-12-09 05:12:03,558 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 161.0 161.0 162.0 164.0 162.0 162.0 162.0 161.0 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.50 Median:73.00 stddev:10.43 (14.3%) stddev-sans-first:10.87 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 76.0 91.0 72.0 72.0 73.0 83.0 102.0 72.0 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:95.00 stddev:17.51 (18.4%) stddev-sans-first:18.19 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 132.0 94.0 95.0 94.0 132.0 95.0 96.0 130.0 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 05:12:03 INFO - 2015-12-09 05:12:03,559 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.50 stddev:3.22 (4.4%) stddev-sans-first:3.41 05:12:03 INFO - 2015-12-09 05:12:03,560 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 73.0 74.0 72.0 81.0 69.0 70.0 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.50 stddev:2.60 (3.7%) stddev-sans-first:2.67 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 70.0 70.0 77.0 69.0 70.0 69.0 69.0 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:2.97 (3.5%) stddev-sans-first:3.05 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 85.0 86.0 86.0 94.0 85.0 88.0 85.0 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:127.50 stddev:5.77 (4.5%) stddev-sans-first:5.67 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: Values: 130.0 116.0 131.0 118.0 117.0 128.0 124.0 119.0 128.0 127.0 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:150.50 stddev:9.02 (6.0%) stddev-sans-first:8.60 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: Values: 135.0 141.0 148.0 136.0 153.0 144.0 158.0 154.0 157.0 136.0 05:12:03 INFO - 2015-12-09 05:12:03,561 DEBUG : BROWSER_OUTPUT: 05:12:03 INFO - 2015-12-09 05:12:03,562 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 05:12:03 INFO - 2015-12-09 05:12:03,562 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 71.0 70.0 69.0 71.0 68.0 71.0 05:12:03 INFO - 2015-12-09 05:12:03,562 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:12:03 INFO - 2015-12-09 05:12:03,562 DEBUG : BROWSER_OUTPUT: 05:12:04 INFO - 2015-12-09 05:12:04,448 INFO : Browser exited with error code: 0 05:12:04 INFO - 2015-12-09 05:12:04,498 INFO : Completed test kraken (00:01:00) 05:12:04 INFO - 2015-12-09 05:12:04,498 INFO : Starting test v8_7 05:12:04 INFO - 2015-12-09 05:12:04,498 DEBUG : operating with platform_type : linux_ 05:12:04 INFO - 2015-12-09 05:12:04,498 INFO : Initialising browser for v8_7 test... 05:12:04 INFO - 2015-12-09 05:12:04,504 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbqxlO/profile http://localhost:39341/getInfo.html 05:12:08 INFO - 2015-12-09 05:12:08,856 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:12:08 INFO - 2015-12-09 05:12:08,856 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:12:08 INFO - 2015-12-09 05:12:08,856 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:12:08 INFO - 2015-12-09 05:12:08,856 DEBUG : BROWSER_OUTPUT: __metrics 05:12:08 INFO - 2015-12-09 05:12:08,957 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] 05:12:09 INFO - 2015-12-09 05:12:09,013 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:09 INFO - 2015-12-09 05:12:09,311 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:12:09 INFO - 2015-12-09 05:12:09,974 INFO : Browser initialized. 05:12:09 INFO - 2015-12-09 05:12:09,975 INFO : Running cycle 1/1 for v8_7 test... 05:12:09 INFO - 2015-12-09 05:12:09,975 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbqxlO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:12:22 INFO - 2015-12-09 05:12:22,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 140546048 05:12:22 INFO - 2015-12-09 05:12:22,048 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39341/tests/v8_7/run.html (next: http://localhost:39341/tests/v8_7/run.html) 05:12:43 INFO - 2015-12-09 05:12:43,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 438808576 05:12:43 INFO - 2015-12-09 05:12:43,682 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,682 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:12:43 INFO - 2015-12-09 05:12:43,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:12:43 INFO - 2015-12-09 05:12:43,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |0;Richards;167.64459346186086 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.97731076808628 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1996.007984031936 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 05:12:43 INFO - 2015-12-09 05:12:43,683 DEBUG : BROWSER_OUTPUT: |8;Splay;613.1207847946046 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: __startTimestamp1449666763675__endTimestamp 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: Values: 167.6 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.98 Median:185.98 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,684 DEBUG : BROWSER_OUTPUT: Values: 186.0 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: Values: 278.2 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: Values: 5122.4 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: Values: 1996.0 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,685 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: Values: 788.0 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: Values: 12207.3 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: Values: 26763.2 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.12 Median:613.12 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: Values: 613.1 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:12:43 INFO - 2015-12-09 05:12:43,686 DEBUG : BROWSER_OUTPUT: 05:12:44 INFO - 2015-12-09 05:12:44,564 INFO : Browser exited with error code: 0 05:12:44 INFO - 2015-12-09 05:12:44,575 INFO : Completed test v8_7 (00:00:40) 05:12:44 INFO - 2015-12-09 05:12:44,732 INFO : Completed test suite (00:20:18) 05:12:44 INFO - 2015-12-09 05:12:44,732 DEBUG : Working with test: dromaeo_css 05:12:44 INFO - 2015-12-09 05:12:44,732 DEBUG : Generating results file: dromaeo_css 05:12:44 INFO - 2015-12-09 05:12:44,734 DEBUG : Working with test: kraken 05:12:44 INFO - 2015-12-09 05:12:44,734 DEBUG : Generating results file: kraken 05:12:44 INFO - 2015-12-09 05:12:44,734 INFO : javascript benchmark 05:12:44 INFO - 2015-12-09 05:12:44,734 DEBUG : Working with test: v8_7 05:12:44 INFO - 2015-12-09 05:12:44,735 DEBUG : Generating results file: v8_7 05:12:44 INFO - 2015-12-09 05:12:44,735 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:44 INFO - 2015-12-09 05:12:44,789 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:12:44 INFO - 2015-12-09 05:12:44,789 DEBUG : process_Request line: dromaeo_css 6362.04 graph.html#tests=[[72,132,35]] 05:12:44 INFO - 2015-12-09 05:12:44,789 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:44 INFO - 2015-12-09 05:12:44,819 DEBUG : process_Request line: kraken 1526.50 graph.html#tests=[[232,132,35]] 05:12:44 INFO - 2015-12-09 05:12:44,819 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:44 INFO - 2015-12-09 05:12:44,847 DEBUG : process_Request line: v8_7 19788.68 graph.html#tests=[[230,132,35]] 05:12:44 INFO - 2015-12-09 05:12:44,848 INFO : javascript benchmark 05:12:44 INFO - 2015-12-09 05:12:44,852 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2656.800739944504, 2733.166384252802, 2738.8219765715226, 2744.958825617615, 2767.9723202767973, 4548.067646132543, 4687.8359257426, 4775.4985726498735, 4781.641376896733, 4827.251775974725, 4667.883302917428, 4687.812487500496, 4780.498047704984, 4899.706017638935, 4902.0, 4352.912941741163, 4386.166628340621, 4440.533743956895, 4453.955460445402, 4516.819327226907, 4318.114786468766, 4358.302671572549, 4514.503404625505, 4535.115652447774, 4536.614387777043, 4208.726432781859, 4294.141171765628, 4494.056248187884, 4536.56902594253, 4540.9091818163615, 4330.696851220416, 4357.106793107406, 4361.563843615645, 4366.126774645084, 4367.410399596046, 4314.956850431487, 4315.611594956469, 4315.870523884257, 4320.308750599889, 4321.719088259285, 4554.362389265505, 4590.059037897223, 4616.169089563878, 4629.560191781809, 4651.023285110131, 5214.973925130388, 5252.606054545924, 5255.474452554752, 5257.5005374489365, 5297.735113244323, 4999.4250661174065, 5106.540411362958, 5237.240600112962, 5275.050490911634, 5276.841694749163, 4696.272077827942, 4717.858464246078, 4744.383230180089, 4747.881302967385, 4752.7623618818925, 5234.214867769865, 5262.158054711304, 5272.077386457355, 5277.656952298165, 5281.683099014072, 5057.418396884332, 5082.618803589746, 5169.991851588904, 5184.988927159167, 5185.507376799198, 5282.445343238982, 5284.128118860345, 5284.180951952453, 5284.920726189111, 5338.599605029638, 4929.16204245272, 5048.899022019539, 5187.221916712523, 5211.322528071327, 5220.399654039834, 5012.548870601663, 5022.573081288058, 5031.949680503149, 5056.646034777604, 5120.231965205249, 4381.145676593033, 4410.80151393188, 4413.624841888475, 4413.911721765547, 4455.376247325377, 3809.2762375149186, 3833.4249862520846, 3862.4978752761963, 3875.4768106305287, 3886.5336159660455, 4300.6129448349175, 4384.47386313638, 4414.359917811899, 4418.867433976986, 4481.305397663367, 5183.50756678115, 5189.896202075937, 5200.7139607321205, 5205.609579281569, 5248.895022099537, 4436.889077773017, 4438.245498265303, 4440.711353761995, 4444.266695995189, 4476.7090139140855, 4408.801603927831, 4531.025829446685, 4534.319852022223, 4566.452025756864, 4684.484706682262, 4885.560299572913, 4899.265110233494, 4908.730019848943, 4918.311436398907, 4955.207166853286, 5188.403333616682, 5191.377034755854, 5192.792288308426, 5200.167973124282, 5202.97398513005, 4692.765361731968, 4796.496367881462, 4799.184138696361, 4813.181759100891, 4919.7540122993, 5107.514786095315, 5137.023965446553, 5138.254953031864, 5142.357205349332, 5197.194434862602, 5206.97396513015, 5213.921791173059, 5215.348081489814, 5215.6609820361555, 5259.947400525945, 4794.424669039738, 4895.6083513318135, 4900.093482705711, 5004.4495105537635, 5128.256402821645, 5025.3718285214345, 5030.974845125751, 5034.44621091687, 5040.546350828443, 5081.8475445736685, 4868.513148685245, 4904.901901962012, 4917.7971520194915, 4919.0, 4931.605471562339, 4822.132016237111, 4882.511748825089, 4948.901021979468, 4949.950500494949, 4997.625178111729, 4955.331030310862, 4955.82654607087, 4958.305837182869, 4963.379577552806, 5013.949860501494], "unit": "ms", "name": "dojo.html", "value": 4718.863517907573}, {"lowerIsBetter": false, "replicates": [510.2117228881378, 521.1739393061998, 522.8353068783335, 524.8268071536394, 533.7464704265475, 26656.4668706626, 36214.275714485695, 36985.0, 37050.62949370512, 37102.44346334807, 40007.199856002866, 40643.59356406435, 40669.0, 40698.18603627933, 40705.796471017675, 6958.930410695904, 7086.85826283474, 7843.607819609026, 8019.077806052321, 8020.077691065544, 10247.28269021165, 10512.0, 10528.263021588491, 10538.36769793811, 10540.841887371696, 10159.695209143738, 10245.12916402103, 10249.128824049965, 10259.589616415371, 10265.38407695537, 10116.696499105003, 10217.97820217976, 10218.33580817252, 10222.591096356136, 10229.079382855505, 9885.406875587487, 9987.600495980152, 10007.499625018792, 10009.39943603379, 10011.49942502872, 37631.81184094089, 38236.04409889747, 38255.0, 38257.61742382596, 38305.23389532221, 2744.3962328287944, 2749.0, 2922.8100173488656, 3254.804711717281, 3387.9491807622903, 27002.5949610756, 27295.590566141524, 27390.452190956268, 27497.17508474729, 27723.53851649013, 3492.6681965213265, 3502.5096486491657, 3521.3485505181366, 3590.0, 3605.0987253186704, 211647.0, 213912.9304353484, 214396.0, 215622.0, 215949.0, 52306.47693523016, 55608.443915560325, 56005.43994560084, 56012.719936400055, 56029.0, 46927.76536117366, 66012.0, 67623.66188169028, 67705.0, 67900.32099678939, 14631.0, 14974.925125374304, 14984.47554335593, 14986.775198372034, 14990.700185996218, 8248.422610417214, 8563.143685631512, 10756.139508839275, 11260.549578016951, 11384.658460246206, 19404.417867464, 19469.415917522496, 19507.992629849054, 19520.453875773503, 19528.609427811363, 7336.559806411632, 7492.100947886289, 7569.318761311399, 7682.500637458547, 7706.922930770733, 801.3789313282136, 874.8600223964136, 929.8419268724333, 969.8933117357085, 1015.5074788727461, 26542.203733888015, 26622.0, 26732.727718143786, 26743.19770406891, 26909.461810764067, 912.707933461286, 925.9305552083621, 928.6842473559022, 930.2557953637063, 955.0354142316172, 13928.51250206238, 14709.92645036768, 16158.27287772053, 16338.591535211477, 16521.83478165227, 301161.0, 306007.0, 306146.0, 306902.0, 307070.0, 48774.51225487771, 49131.263031054565, 49398.0, 49428.752856236206, 49475.25787113196, 1220.8351872497276, 1227.79127548317, 1229.065909908458, 1242.87571242875, 1342.5032737887045, 27654.44691106207, 28359.43281134407, 28476.430471390042, 28640.0, 28993.565096523147, 40664.1867162661, 41189.382159267036, 41275.793621031706, 41326.1734765297, 41328.38007429831, 240078.0, 247467.0, 247542.0, 304706.0, 313606.0, 27809.58285625677, 27875.86062069758, 27877.303067423476, 27904.16287511378, 28244.293892652848, 34759.39291602528, 35673.0, 35975.0, 36234.09414764652, 36308.63691363052, 32326.676733233307, 32404.35191296208, 33293.83353083316, 33700.662993369755, 34032.0, 33701.831490842385, 33796.662033379354, 33930.83034584811, 33934.66065339315, 33965.49051764275, 33788.493172602924, 33969.66030339665, 36113.63886361103, 36525.81737091298, 36638.267234655694, 28140.43719125647, 30353.24116897095, 30476.851392882454, 30569.08292751221, 32219.838900805345, 24084.27747167588, 24273.75726242715, 25003.0, 25188.874055629603, 25309.493810124062], "unit": "ms", "name": "ext.html", "value": 17616.276287106753}, {"lowerIsBetter": false, "replicates": [264.63876808156874, 269.3145943573605, 271.11616131411597, 273.6633940253487, 276.7218944960315, 10735.974009746345, 15367.615809604766, 15830.68338633228, 15835.762463563056, 16025.759613605776, 16346.754798678, 16642.08468534233, 16656.33374665015, 16661.583460413465, 17179.656406871887, 5604.299462567169, 5751.281089863767, 5785.2189954356045, 5786.479216870481, 5787.363390027093, 5664.716764161796, 5707.0, 5709.914351284734, 5715.885682286352, 5715.9428405716035, 4057.573954734755, 4132.938005929914, 5529.834104976857, 5693.202951586781, 6396.072569477423, 6453.386928241809, 6496.740130394778, 6505.186851643544, 6533.836654083662, 6546.44355229806, 6078.787242446493, 6249.375062493759, 6251.12484252205, 6257.43683068526, 6261.373862613747, 20055.49861253466, 20433.4891627709, 20665.830087840863, 20829.16683332665, 20898.164073437045, 1875.7092650639172, 1895.5924476237537, 1953.2870502266712, 1969.3698016634683, 2184.912603495858, 13251.204927704368, 13377.732445351136, 13524.12093213938, 13538.323083845768, 13874.098183618033, 1867.6918308479085, 1895.4408449507428, 1916.980830191708, 1917.9520511987173, 1990.2138655231104, 56364.0, 60604.939506049486, 60705.696471517804, 61173.0, 62119.37880621226, 14309.57071287863, 14929.552113436614, 14952.327145278488, 14991.625209369635, 15018.849811501963, 21534.892325538585, 21560.784392155878, 21590.784092159192, 21609.35171944813, 21612.89193554022, 7980.720674776471, 8007.6796928123385, 8041.155678653774, 8058.597070146587, 8072.071711753106, 6660.666966651648, 6682.866342673216, 6693.966530167318, 6701.865962680719, 6729.730810767613, 7407.8148046299275, 7495.962520187473, 7499.700011999459, 7580.658870350848, 7584.431167662337, 2293.048384920273, 2905.4043920996146, 2977.7766667500023, 3018.4717674406893, 3028.757699384044, 333.7980521784334, 335.9143418428285, 340.25144681700357, 797.147052653655, 915.4736026784625, 9274.675386361445, 9416.529173541296, 9535.140647573795, 9756.658516952015, 9782.853257201148, 826.0679167164221, 849.367221420046, 895.3195571365809, 902.5351943748974, 931.2084727981162, 8386.329093672492, 8418.663253469793, 8622.611982460805, 8636.136386361313, 8784.78038049041, 443672.0, 448397.0, 480189.0, 483635.0, 496912.0, 35498.82250588731, 59086.704566476896, 60676.48308792315, 61996.38003619906, 64148.358516415174, 1047.518141654832, 1062.2935747727674, 1078.3152698036647, 1100.5707773968159, 1105.1214284643727, 14681.48614798477, 14695.485658001919, 14746.188959607325, 14891.329890154753, 15027.549173524812, 33870.66129338675, 33896.322073558884, 34623.82688086543, 34780.47829282512, 35030.0, 44955.0, 45490.0, 45821.31268030916, 46081.30878036899, 49512.0, 8318.37612179101, 8400.0, 8603.569821508774, 8617.181367770052, 8765.474071555727, 10124.493775311352, 10130.08829205375, 10157.695269141937, 10238.692839214835, 13555.86444135546, 13854.722905541632, 13904.276092934268, 14079.0, 14227.715445691236, 14472.421103155755, 13753.724925501234, 13955.232462214675, 14006.78989815174, 14031.438742450597, 14518.128912265298, 14458.0, 14487.565373038826, 14733.55799326022, 14824.851751482778, 14854.183019933575, 8105.75682729519, 8814.33892458081, 8814.735557933273, 8842.204201621886, 8845.69040083594, 8984.550772461482, 9075.954620226856, 12276.508939642314, 12951.805722914352, 13732.588022359345], "unit": "ms", "name": "jquery.html", "value": 8732.639282162758}, {"lowerIsBetter": false, "replicates": [1389.472000639758, 1574.4332040465433, 1654.2225154177531, 1655.511624070899, 1692.2215780740858, 5875.853103672405, 7057.153141623006, 7238.276172382759, 7254.492185547014, 7254.637268136598, 7120.323569260912, 7261.782146535613, 7266.854662906739, 7269.5638261704335, 7274.927250727491, 1997.1312479071614, 2026.412340421276, 2030.8273796727296, 2031.5733695923873, 2034.806693364128, 1889.763779527559, 1924.4034349351746, 1933.2556965568288, 1951.3853136262103, 1953.6226959993242, 2008.1666108564928, 2016.5966806638658, 2049.948751281215, 2053.743282089739, 2054.7739748627637, 2017.9899100504476, 2038.847086468506, 2039.2250944641016, 2041.8774873507489, 2042.244369583249, 1982.3161009451717, 1995.461225469115, 2004.7494063242095, 2007.0867755171362, 2015.4961259685078, 7110.0, 7164.0, 7174.605396703179, 7179.820504487378, 7186.425085993108, 4183.079722461053, 4227.154569086195, 4232.25935461293, 4250.851220207278, 4268.274393353137, 2652.151311580295, 2684.181324695967, 2705.905293314744, 2730.84980326082, 2750.4636595863813, 785.35600807338, 809.8056466448069, 824.3322908444179, 834.4909605140859, 835.4402550291319, 9810.0, 9810.509474526316, 9817.558209880572, 9837.55730992107, 9847.409155450696, 3750.456183853326, 3756.380197267475, 3792.829322680486, 3802.923941521154, 3803.8478460861256, 8448.366372522085, 8468.44955077918, 8487.066422693499, 8487.278581320657, 8488.066312705598, 4293.549177336335, 4308.612224899774, 4320.848770293088, 4321.373400856921, 4327.02641905575, 3230.7576931729745, 3292.9176770580925, 3783.754055986352, 3941.763494190358, 3943.2902077626304, 3373.1904342957514, 3380.4422270325613, 3390.4744764561533, 3403.9659603404143, 3426.194844211608, 997.6558087459815, 999.14073896449, 1003.1222680154865, 1013.7820368620781, 1014.5434554450527, 778.7196609220676, 778.7741554949115, 779.5595488548952, 782.3545574900729, 795.5584650518902, 6647.634380109141, 6736.696848641823, 6795.558288711218, 6795.694193761194, 7017.719291228395, 907.4509921497531, 921.7972046149837, 929.7722058095675, 929.990700093004, 1028.4703377760459, 5188.662736922088, 5244.816431424958, 5251.159814429673, 5254.65844720092, 5260.368755749335, 7895.407844411692, 8024.759257222293, 8052.5571093590415, 8131.349492040623, 8523.872141917876, 8394.538300393537, 8536.359773017048, 8656.0, 8669.046404895456, 8669.696560620348, 6573.901391479131, 6592.30780768022, 6815.965920170466, 6870.0, 6870.553414028072, 6838.521303508706, 6887.931120688729, 6888.173419189528, 6896.103506544117, 6898.172219333712, 7699.615019249127, 7792.181820908723, 7801.453898227297, 7806.41451891099, 7927.048754149539, 7917.960410197912, 8041.517508949481, 8106.716264930699, 8110.31062359706, 8166.673333066611, 5998.580099393001, 6020.578559500793, 6111.694415279308, 6137.35557766446, 6149.323574406722, 6834.316568343126, 6886.931130688829, 6904.102466679299, 6912.827179320558, 6958.652067396712, 6404.423601875854, 6477.708503117466, 6478.902816457851, 6505.902411463927, 6516.57642253252, 6231.4391704746795, 6245.8750824982335, 6329.272133704683, 6408.455281300955, 6426.646534440651, 5382.892342153056, 5454.59090568201, 5455.699936503372, 6373.5857169283845, 6398.5521013528605, 5405.810796622257, 5672.829815105553, 5727.8568035799435, 5759.337676167294, 5799.188113664006, 6124.265088189446, 6133.815985520441, 6159.6612186330185, 6165.5375846810775, 6168.35232300602], "unit": "ms", "name": "mootools.html", "value": 4017.2561299105255}, {"lowerIsBetter": false, "replicates": [252.1389455011137, 252.91527338341658, 254.58248472505096, 258.6934482638074, 260.33873960141244, 5391.460853914607, 5407.215953686718, 5415.214793854889, 5475.972620136894, 5509.862253443666, 5244.108501554735, 5426.050441172799, 5437.211604317372, 5449.291592093023, 5453.64551304165, 4065.9796701016453, 4082.5100987881347, 4095.3856921461797, 4098.241825262336, 4099.959000409987, 3852.4028775539837, 4058.4521089652962, 4096.406021126935, 4098.422107488624, 4100.056986893016, 3895.357266051098, 3907.882763517099, 4010.4385386045833, 4011.277969965405, 4020.718549701522, 3997.7801220932984, 4023.959760402388, 4027.577104404025, 4029.2747305485, 4030.3349947258666, 3226.91932701682, 3270.60752709674, 3367.51171080192, 3437.432823584106, 3439.8796042138406, 5209.0, 5209.661372010807, 5228.816991405321, 5238.895222095575, 5250.7374631268285, 4635.860924172281, 4644.047970166108, 4649.093426781779, 4653.162430762462, 4653.371794807692, 5706.514946229576, 5710.486056254916, 5712.028955077647, 5712.57155713319, 5716.82805024973, 3654.798986055766, 3757.342465068602, 3758.0604848787802, 3764.0401697567218, 3768.4912536807456, 5989.191459153046, 6056.5457590680435, 6063.514918806529, 6068.939310606926, 6070.514358851281, 3849.9615003850163, 3855.248226595787, 3858.1897801462005, 3858.6141385861188, 3861.942070868939, 3894.8636797711943, 3895.0651843557907, 3895.3767397216875, 3906.140649057203, 3913.25648126855, 4502.144592527409, 4569.702969306984, 4593.655475839326, 4598.586127248564, 4603.49361570227, 5728.226689396962, 5731.484166425042, 5732.942670573241, 5737.569682273846, 5749.7700091996685, 1360.5578187089236, 1381.9654508637364, 1384.1003347823794, 1384.6815232496583, 1386.535510603959, 883.9734807955772, 889.5107690770051, 895.0, 908.4276905549461, 909.7589138878203, 5033.1695270280725, 5042.344495215599, 5042.697438153723, 5049.368828896388, 5049.419316778544, 5980.192673989043, 5985.820425387245, 5988.221531200916, 5988.970055149784, 5993.520518358521, 5032.698038117652, 5041.369828771403, 5041.470645582161, 5043.470435604282, 5053.090443720165, 3154.6372167200607, 3195.0, 3199.0722690419516, 3223.935521289561, 3229.6931791479774, 5475.780968761284, 5613.747381367766, 5614.578906582023, 5628.296462942132, 5632.436756324335, 6061.878762424815, 6192.783252586138, 6215.595986260879, 6216.067589861557, 6216.7824126155365, 5686.943130568641, 5687.03320435527, 5693.117566777156, 5694.288213973254, 5694.4590263924865, 5894.469497745224, 6035.668038257938, 6036.0, 6037.426444487766, 6040.637561746309, 5888.411158884249, 5890.646561206341, 5893.086571581412, 5895.852603684943, 5897.498712609305, 5674.120511320752, 5678.77284908599, 5687.118496633028, 5687.43125687428, 5687.744051517774, 3826.5025546678753, 3827.464155018244, 3828.081260497405, 3831.0, 3831.348670726039, 5868.911966320423, 6019.127226552213, 6024.849378765566, 6043.153958445733, 6046.697665116639, 5722.399148089391, 5803.332616749128, 5806.970965145148, 5810.854728631818, 5810.883782324415, 5749.051406517878, 5769.94230057694, 5784.768609255582, 5797.594168408171, 5810.912836307543, 5470.480304371237, 5636.070048441961, 5639.182318563868, 5645.040343141593, 5651.802186923438, 5833.300003999547, 5833.7666493341485, 5838.1826544282985, 5844.4155584442915, 5845.1232315153065, 5612.635178713371, 5640.661560306395, 5654.886902262014, 5658.490735833795, 5665.12190610456], "unit": "ms", "name": "prototype.html", "value": 4202.967116700795}, {"lowerIsBetter": false, "replicates": [692.6882902693787, 693.6809067828805, 697.1320705721378, 699.9895001574974, 711.7402148215901, 11043.889561104386, 11293.20947533671, 11298.717532061703, 11305.604303849366, 11306.434678266085, 11939.58211462599, 12013.399330033486, 12022.098342624295, 12041.939790301036, 12048.57829975951, 610.825914614335, 617.1236843681983, 754.456791110401, 774.4540099230029, 784.6861255497789, 784.654751909161, 786.8229648329137, 788.4244501513898, 790.9367250619965, 791.0112359550562, 810.222186700768, 814.7067055859885, 815.1644564321558, 816.0819078536646, 816.2205094135087, 634.1629049654458, 642.9839254018664, 803.5660743198665, 816.8611336072881, 818.3289702443998, 605.1890466774544, 605.5851741557047, 606.2876120558326, 606.4390438844051, 609.3601718195877, 11237.662870113909, 11319.943400283028, 11373.260738052, 11383.715407114889, 11393.088552915748, 10395.0, 11253.437328133643, 11431.314121152674, 11592.942035289854, 11612.303261804318, 8513.702020429255, 8621.784455388603, 8705.0, 8893.333000025024, 8902.643894244222, 3161.920951976196, 3174.1271150433818, 3184.1402821238366, 3208.871645134192, 3248.756343274264, 38862.80568597139, 38973.61026389728, 39037.0, 39161.0, 39769.60230397659, 7952.085510166289, 8002.599870006593, 8027.518348899085, 8059.395545334123, 8263.95868020656, 15470.535883923276, 15520.068795872285, 15525.378984840705, 15545.844541554667, 15556.066636001877, 6074.271087469444, 6191.226096737908, 6203.31763506014, 6215.751369945242, 6244.313125556185, 3345.9627515470283, 3348.2466445050154, 3355.1947532592003, 3459.9135021624156, 3488.66857648523, 2538.695356557225, 2581.664383630116, 2582.728813474596, 2584.870756462207, 2586.120718955564, 441.9867403977886, 442.48450555103585, 447.6195234051096, 464.4101990472149, 466.79694332965266, 438.6666133738382, 522.9843104706865, 531.2482836785905, 531.4313684357777, 536.3081624704166, 6417.101605775195, 6580.341965803382, 6583.835404114935, 6620.668966551653, 6665.100211471487, 376.4409851370712, 445.7971622911632, 519.1485963020649, 536.3215532351578, 555.5278013688413, 3269.8201598912287, 3351.162209447638, 3395.8811441599423, 3440.82795860206, 3486.442169252958, 46849.0, 46934.765326173154, 46996.5300346999, 47077.529224708, 47304.0, 42179.36730949038, 42555.0, 42944.35583466251, 43389.34915976263, 43474.0, 40065.0, 40132.398014029815, 40257.0, 40284.1943161141, 40872.38691419631, 6840.6921688525135, 6951.617661028489, 6958.373746362851, 6979.4765392594745, 7184.497085203986, 29577.112686619435, 31071.912483062984, 31104.533431998992, 32167.839160804047, 32678.183045424055, 37974.43038354372, 38352.0, 38566.42150367691, 38814.0, 39263.60736392599, 9285.72142835716, 9462.479563624067, 9504.95247523758, 9980.351277166961, 9999.850002249827, 10319.122874555747, 10578.100861426865, 10728.946355268487, 10758.946205268923, 10766.0, 9193.77015574616, 9355.812883742423, 9402.529873506433, 9471.289653275893, 9486.667966621411, 10072.597096116366, 10080.193584513074, 10125.493725313852, 10235.393230586431, 10471.79056418852, 9669.903300967182, 9818.558164882455, 10268.845967310346, 10286.485675716034, 10301.175905927357, 8961.148690874357, 9074.228690561113, 9269.953650231706, 9414.460436649992, 9697.272704547046, 8104.351651867719, 8287.917120828715, 8503.489790612583, 8616.439931404439, 8708.477491350539], "unit": "ms", "name": "yui.html", "value": 5409.373640210255}], "name": "dromaeo_css", "value": 6362.039319054175}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 113.0, 113.0, 113.0, 104.0, 113.0, 114.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [165.0, 140.0, 154.0, 169.0, 131.0, 160.0, 153.0, 132.0, 167.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 164.0, 162.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 76.0, 91.0, 72.0, 72.0, 73.0, 83.0, 102.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 132.0, 94.0, 95.0, 94.0, 132.0, 95.0, 96.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 72.0, 73.0, 74.0, 72.0, 81.0, 69.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 70.0, 70.0, 77.0, 69.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 86.0, 86.0, 94.0, 85.0, 88.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [130.0, 116.0, 131.0, 118.0, 117.0, 128.0, 124.0, 119.0, 128.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [135.0, 141.0, 148.0, 136.0, 153.0, 144.0, 158.0, 154.0, 157.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 71.0, 70.0, 69.0, 71.0, 68.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1526.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [185.97731076808628], "unit": "score", "name": "DeltaBlue", "value": 355.5164860000001}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [613.1207847946046], "unit": "score", "name": "Splay", "value": 132.91182099999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19788.68178036185}]} 05:12:44 INFO - RETURN: dromaeo_css: 6362.04 05:12:44 INFO - RETURN: kraken: 1526.50 05:12:44 INFO - RETURN: v8_7: 19788.68 05:12:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19788.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1526.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6362.04"}}} 05:12:44 INFO - Return code: 0 05:12:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:12:45 ERROR - # TBPL SUCCESS # 05:12:45 INFO - Running post-action listener: _resource_record_post_action 05:12:45 INFO - Running post-run listener: _resource_record_post_run 05:12:46 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507654144; Read time: 12; Write time: 358320 05:12:46 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 230961152; Read time: 0; Write time: 215760 05:12:46 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276258816; Read time: 12; Write time: 142528 05:12:46 INFO - Running post-run listener: _upload_blobber_files 05:12:46 INFO - Blob upload gear active. 05:12:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:12:46 INFO - Copying logs to upload dir... 05:12:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.227869 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-09 05:12:46.034709) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 05:12:46.044382) ========= 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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010042 build_url: 'https://queue.taskcluster.net/v1/task/t-cdkyxoSZGOfqefYwpdtw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.08 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 05:12:46.132276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 05:12:46.135646) ========= 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=dd132779db58144225c4cf24000001c8-1449664552.967766-372634957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 05:12:46.195156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 05:12:46.195481) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 05:12:46.196056) ========= ========= Total master_lag: 0.42 =========