builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1449579011.9 results: success (0) buildid: 20151208030424 builduid: a3f33b83806b4bc18a6d40d1b5cef4e0 revision: 9214b6cd1112bad206619a6ea9052d644eb6c105 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:11.903714) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:11.904158) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:11.904475) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006354 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:11.952901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:11.953176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:11.998636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:11.998910) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.052119) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.052470) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.052829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.053095) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-08 04:50:13-- 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% 222M=0s 2015-12-08 04:50:13 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.244213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.244533) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.295874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.296197) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9214b6cd1112bad206619a6ea9052d644eb6c105 --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 9214b6cd1112bad206619a6ea9052d644eb6c105 --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=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-08 04:50:13,615 truncating revision to first 12 chars 2015-12-08 04:50:13,615 Setting DEBUG logging. 2015-12-08 04:50:13,615 attempt 1/10 2015-12-08 04:50:13,615 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9214b6cd1112?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-08 04:50:13,842 unpacking tar archive at: fx-team-9214b6cd1112/testing/mozharness/ program finished with exit code 0 elapsedTime=0.484541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.796835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.797137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.805236) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.805721) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:12.806395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-12-08 04:50:12.806864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:50:14 INFO - MultiFileLogger online at 20151208 04:50:14 in /builds/slave/test 04:50:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:50:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:14 INFO - {'append_to_log': False, 04:50:14 INFO - 'base_work_dir': '/builds/slave/test', 04:50:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:50:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:14 INFO - 'branch': 'Fx-Team-Non-PGO', 04:50:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:14 INFO - 'config_files': ('talos/linux_config.py',), 04:50:14 INFO - 'default_actions': ('clobber', 04:50:14 INFO - 'read-buildbot-config', 04:50:14 INFO - 'download-and-extract', 04:50:14 INFO - 'populate-webroot', 04:50:14 INFO - 'create-virtualenv', 04:50:14 INFO - 'install', 04:50:14 INFO - 'run-tests'), 04:50:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:14 INFO - 'download_minidump_stackwalk': True, 04:50:14 INFO - 'download_symbols': 'ondemand', 04:50:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:14 INFO - 'installer_path': 'installer.exe', 04:50:14 INFO - 'log_level': 'info', 04:50:14 INFO - 'log_name': 'talos', 04:50:14 INFO - 'log_to_console': True, 04:50:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:50:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:50:14 INFO - 'opt_config_files': (), 04:50:14 INFO - 'pip_index': False, 04:50:14 INFO - 'sps_profile': False, 04:50:14 INFO - 'sps_profile_interval': 0, 04:50:14 INFO - 'suite': 'dromaeojs-e10s', 04:50:14 INFO - 'system_bits': '64', 04:50:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:14 INFO - 'title': 'talos-linux64-ix-007', 04:50:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:14 INFO - 'use_talos_json': True, 04:50:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:14 INFO - 'work_dir': 'build'} 04:50:14 INFO - ##### 04:50:14 INFO - ##### Running clobber step. 04:50:14 INFO - ##### 04:50:14 INFO - Running pre-action listener: _resource_record_pre_action 04:50:14 INFO - Running main action method: clobber 04:50:14 INFO - rmtree: /builds/slave/test/build 04:50:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:15 INFO - Running post-action listener: _resource_record_post_action 04:50:15 INFO - ##### 04:50:15 INFO - ##### Running read-buildbot-config step. 04:50:15 INFO - ##### 04:50:15 INFO - Running pre-action listener: _resource_record_pre_action 04:50:15 INFO - Running main action method: read_buildbot_config 04:50:15 INFO - Using buildbot properties: 04:50:15 INFO - { 04:50:15 INFO - "properties": { 04:50:15 INFO - "buildnumber": 548, 04:50:15 INFO - "product": "firefox", 04:50:15 INFO - "script_repo_revision": "production", 04:50:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:50:15 INFO - "repository": "", 04:50:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:50:15 INFO - "buildid": "20151208030424", 04:50:15 INFO - "slavename": "talos-linux64-ix-007", 04:50:15 INFO - "pgo_build": "False", 04:50:15 INFO - "basedir": "/builds/slave/test", 04:50:15 INFO - "project": "", 04:50:15 INFO - "platform": "ubuntu64_hw", 04:50:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:50:15 INFO - "slavebuilddir": "test", 04:50:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:50:15 INFO - "branch": "fx-team", 04:50:15 INFO - "repo_path": "integration/fx-team", 04:50:15 INFO - "stage_platform": "linux64", 04:50:15 INFO - "builduid": "a3f33b83806b4bc18a6d40d1b5cef4e0", 04:50:15 INFO - "revision": "9214b6cd1112bad206619a6ea9052d644eb6c105" 04:50:15 INFO - }, 04:50:15 INFO - "sourcestamp": { 04:50:15 INFO - "repository": "", 04:50:15 INFO - "hasPatch": false, 04:50:15 INFO - "project": "", 04:50:15 INFO - "branch": "fx-team-linux64-talos", 04:50:15 INFO - "changes": [ 04:50:15 INFO - { 04:50:15 INFO - "category": null, 04:50:15 INFO - "files": [ 04:50:15 INFO - { 04:50:15 INFO - "url": null, 04:50:15 INFO - "name": "https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:50:15 INFO - } 04:50:15 INFO - ], 04:50:15 INFO - "repository": "", 04:50:15 INFO - "rev": "9214b6cd1112bad206619a6ea9052d644eb6c105", 04:50:15 INFO - "who": "cbook@mozilla.com", 04:50:15 INFO - "when": 1449578938, 04:50:15 INFO - "number": 7052267, 04:50:15 INFO - "comments": "Merge mozilla-central to fx-team", 04:50:15 INFO - "project": "", 04:50:15 INFO - "at": "Tue 08 Dec 2015 04:48:58", 04:50:15 INFO - "branch": "fx-team-linux64-talos", 04:50:15 INFO - "revlink": "", 04:50:15 INFO - "properties": [ 04:50:15 INFO - [ 04:50:15 INFO - "buildid", 04:50:15 INFO - "20151208030424", 04:50:15 INFO - "Change" 04:50:15 INFO - ], 04:50:15 INFO - [ 04:50:15 INFO - "builduid", 04:50:15 INFO - "a3f33b83806b4bc18a6d40d1b5cef4e0", 04:50:15 INFO - "Change" 04:50:15 INFO - ], 04:50:15 INFO - [ 04:50:15 INFO - "pgo_build", 04:50:15 INFO - "False", 04:50:15 INFO - "Change" 04:50:15 INFO - ] 04:50:15 INFO - ], 04:50:15 INFO - "revision": "9214b6cd1112bad206619a6ea9052d644eb6c105" 04:50:15 INFO - } 04:50:15 INFO - ], 04:50:15 INFO - "revision": "9214b6cd1112bad206619a6ea9052d644eb6c105" 04:50:15 INFO - } 04:50:15 INFO - } 04:50:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:50:15 INFO - Running post-action listener: _resource_record_post_action 04:50:15 INFO - ##### 04:50:15 INFO - ##### Running download-and-extract step. 04:50:15 INFO - ##### 04:50:15 INFO - Running pre-action listener: _resource_record_pre_action 04:50:15 INFO - Running main action method: download_and_extract 04:50:15 INFO - mkdir: /builds/slave/test/build/tests 04:50:15 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:50:15 INFO - https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:50:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/test_packages.json 04:50:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/test_packages.json 04:50:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:50:19 INFO - Downloaded 1302 bytes. 04:50:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:50:19 INFO - Using the following test package requirements: 04:50:19 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:19 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:50:19 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:19 INFO - u'jsshell-linux-x86_64.zip'], 04:50:19 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:50:19 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:19 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:50:19 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:50:19 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:50:19 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:19 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:50:19 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:50:19 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:50:19 INFO - https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:20 INFO - Downloaded 21860240 bytes. 04:50:20 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:50:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:20 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:50:21 INFO - Return code: 0 04:50:21 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:50:21 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:50:21 INFO - https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:33 INFO - Downloaded 21860240 bytes. 04:50:33 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:50:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:50:33 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:50:35 INFO - Return code: 0 04:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:35 INFO - https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:35 INFO - Downloaded 11132038 bytes. 04:50:35 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:50:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:35 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:50:36 INFO - Return code: 0 04:50: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:50:36 INFO - https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/n2t9IDFvQMS5sSCmokpckQ/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:50:38 INFO - Downloaded 57727986 bytes. 04:50:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:38 INFO - mkdir: /builds/slave/test/properties 04:50:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:50:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:50:38 INFO - Contents: 04:50:38 INFO - build_url:https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:50:38 INFO - Running post-action listener: _resource_record_post_action 04:50:38 INFO - Running post-action listener: set_extra_try_arguments 04:50:38 INFO - ##### 04:50:38 INFO - ##### Running populate-webroot step. 04:50:38 INFO - ##### 04:50:38 INFO - Running pre-action listener: _resource_record_pre_action 04:50:38 INFO - Running main action method: populate_webroot 04:50:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:50:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:50:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:50:38 INFO - '--tppagecycles', 04:50:38 INFO - '7'], 04:50:38 INFO - 'tests': ['tsvgm']}}, 04:50:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:50:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:50:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:50:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:50:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'tests': ['damp', 'tps']}, 04:50:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['damp', 'tps']}, 04:50:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:50:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:50:38 INFO - 'other': {'tests': ['a11yr', 04:50:38 INFO - 'ts_paint', 04:50:38 INFO - 'tpaint', 04:50:38 INFO - 'sessionrestore', 04:50:38 INFO - 'sessionrestore_no_auto_restore']}, 04:50:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['a11yr', 04:50:38 INFO - 'ts_paint', 04:50:38 INFO - 'tpaint', 04:50:38 INFO - 'sessionrestore', 04:50:38 INFO - 'sessionrestore_no_auto_restore']}, 04:50:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['a11yr', 04:50:38 INFO - 'ts_paint', 04:50:38 INFO - 'tpaint', 04:50:38 INFO - 'sessionrestore', 04:50:38 INFO - 'sessionrestore_no_auto_restore']}, 04:50:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['a11yr', 04:50:38 INFO - 'ts_paint', 04:50:38 INFO - 'tpaint', 04:50:38 INFO - 'sessionrestore', 04:50:38 INFO - 'sessionrestore_no_auto_restore']}, 04:50:38 INFO - 'other_l64': {'tests': ['a11yr', 04:50:38 INFO - 'ts_paint', 04:50:38 INFO - 'tpaint', 04:50:38 INFO - 'sessionrestore', 04:50:38 INFO - 'sessionrestore_no_auto_restore']}, 04:50:38 INFO - 'other_nol64': {'tests': ['a11yr', 04:50:38 INFO - 'ts_paint', 04:50:38 INFO - 'tpaint', 04:50:38 INFO - 'sessionrestore', 04:50:38 INFO - 'sessionrestore_no_auto_restore']}, 04:50:38 INFO - 'svgr': {'tests': ['tsvgx', 04:50:38 INFO - 'tsvgr_opacity', 04:50:38 INFO - 'tart', 04:50:38 INFO - 'tscrollx', 04:50:38 INFO - 'cart']}, 04:50:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['tsvgx', 04:50:38 INFO - 'tsvgr_opacity', 04:50:38 INFO - 'tart', 04:50:38 INFO - 'tscrollx', 04:50:38 INFO - 'cart']}, 04:50:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'tests': ['tp5o']}, 04:50:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'talos_options': ['--e10s'], 04:50:38 INFO - 'tests': ['tp5o']}, 04:50:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'talos_options': ['--xperf_path', 04:50:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:38 INFO - 'tests': ['tp5n']}, 04:50:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:38 INFO - 'talos_options': ['--e10s', 04:50:38 INFO - '--xperf_path', 04:50:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:38 INFO - 'tests': ['tp5n']}}, 04:50:38 INFO - 'talos.zip': {'path': '', 04:50:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:50:38 INFO - Running post-action listener: _resource_record_post_action 04:50:38 INFO - ##### 04:50:38 INFO - ##### Running create-virtualenv step. 04:50:38 INFO - ##### 04:50:38 INFO - Running pre-action listener: _resource_record_pre_action 04:50:38 INFO - Running main action method: create_virtualenv 04:50:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:50:38 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:50:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:50:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:50:38 INFO - Using real prefix '/usr' 04:50:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:50:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:50:40 INFO - Installing pip.................done. 04:50:40 INFO - Return code: 0 04:50:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:50:40 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:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:40 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:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:40 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:40 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:50:40 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:50:40 INFO - Using env: {'DISPLAY': ':0', 04:50:40 INFO - 'HOME': '/home/cltbld', 04:50:40 INFO - 'LANG': 'en_US.UTF-8', 04:50:40 INFO - 'LANGUAGE': 'en_US:en', 04:50:40 INFO - 'LOGNAME': 'cltbld', 04:50:40 INFO - 'MAIL': '/var/mail/cltbld', 04:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:40 INFO - 'MOZ_NO_REMOTE': '1', 04:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:40 INFO - 'NO_EM_RESTART': '1', 04:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:40 INFO - 'PWD': '/builds/slave/test', 04:50:40 INFO - 'SHELL': '/bin/bash', 04:50:40 INFO - 'SHLVL': '1', 04:50:40 INFO - 'TERM': 'linux', 04:50:40 INFO - 'TMOUT': '86400', 04:50:40 INFO - 'USER': 'cltbld', 04:50:40 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:40 INFO - '_': '/tools/buildbot/bin/python'} 04:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:40 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:50:40 INFO - Cleaning up... 04:50:40 INFO - Return code: 0 04:50:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:50:40 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:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:40 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:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:40 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:40 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:50:40 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:50:40 INFO - Using env: {'DISPLAY': ':0', 04:50:40 INFO - 'HOME': '/home/cltbld', 04:50:40 INFO - 'LANG': 'en_US.UTF-8', 04:50:40 INFO - 'LANGUAGE': 'en_US:en', 04:50:40 INFO - 'LOGNAME': 'cltbld', 04:50:40 INFO - 'MAIL': '/var/mail/cltbld', 04:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:40 INFO - 'MOZ_NO_REMOTE': '1', 04:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:40 INFO - 'NO_EM_RESTART': '1', 04:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:40 INFO - 'PWD': '/builds/slave/test', 04:50:40 INFO - 'SHELL': '/bin/bash', 04:50:40 INFO - 'SHLVL': '1', 04:50:40 INFO - 'TERM': 'linux', 04:50:40 INFO - 'TMOUT': '86400', 04:50:40 INFO - 'USER': 'cltbld', 04:50:40 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:40 INFO - '_': '/tools/buildbot/bin/python'} 04:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:41 INFO - Downloading/unpacking psutil>=0.7.1 04:50:41 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:50:41 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:50:41 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:50:41 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:50:41 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:50:41 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:50:42 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:50:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:50:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:42 INFO - Installing collected packages: psutil 04:50:42 INFO - Running setup.py install for psutil 04:50:43 INFO - building 'psutil._psutil_linux' extension 04:50:43 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:50:43 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:50:43 INFO - building 'psutil._psutil_posix' extension 04:50:43 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:50:43 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:50:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:43 INFO - Successfully installed psutil 04:50:43 INFO - Cleaning up... 04:50:43 INFO - Return code: 0 04:50:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:43 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:43 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:50:43 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:50:43 INFO - Using env: {'DISPLAY': ':0', 04:50:43 INFO - 'HOME': '/home/cltbld', 04:50:43 INFO - 'LANG': 'en_US.UTF-8', 04:50:43 INFO - 'LANGUAGE': 'en_US:en', 04:50:43 INFO - 'LOGNAME': 'cltbld', 04:50:43 INFO - 'MAIL': '/var/mail/cltbld', 04:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:43 INFO - 'MOZ_NO_REMOTE': '1', 04:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:43 INFO - 'NO_EM_RESTART': '1', 04:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:43 INFO - 'PWD': '/builds/slave/test', 04:50:43 INFO - 'SHELL': '/bin/bash', 04:50:43 INFO - 'SHLVL': '1', 04:50:43 INFO - 'TERM': 'linux', 04:50:43 INFO - 'TMOUT': '86400', 04:50:43 INFO - 'USER': 'cltbld', 04:50:43 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:43 INFO - '_': '/tools/buildbot/bin/python'} 04:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:50:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:50:45 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:50:45 INFO - Installing collected packages: mozsystemmonitor 04:50:45 INFO - Running setup.py install for mozsystemmonitor 04:50:45 INFO - Successfully installed mozsystemmonitor 04:50:45 INFO - Cleaning up... 04:50:45 INFO - Return code: 0 04:50:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:50: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:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:45 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:45 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:50:45 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:50:45 INFO - Using env: {'DISPLAY': ':0', 04:50:45 INFO - 'HOME': '/home/cltbld', 04:50:45 INFO - 'LANG': 'en_US.UTF-8', 04:50:45 INFO - 'LANGUAGE': 'en_US:en', 04:50:45 INFO - 'LOGNAME': 'cltbld', 04:50:45 INFO - 'MAIL': '/var/mail/cltbld', 04:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:45 INFO - 'MOZ_NO_REMOTE': '1', 04:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:45 INFO - 'NO_EM_RESTART': '1', 04:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:45 INFO - 'PWD': '/builds/slave/test', 04:50:45 INFO - 'SHELL': '/bin/bash', 04:50:45 INFO - 'SHLVL': '1', 04:50:45 INFO - 'TERM': 'linux', 04:50:45 INFO - 'TMOUT': '86400', 04:50:45 INFO - 'USER': 'cltbld', 04:50:45 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:45 INFO - '_': '/tools/buildbot/bin/python'} 04:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:50:45 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:50:45 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:50:45 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:50:45 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:50:45 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:50:45 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:50:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:50:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:50:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:50:47 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:50:47 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:50:47 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:50:47 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:50:47 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:50:47 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:50:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:50:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:50:47 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:50:47 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:50:47 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:50:47 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:50:47 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:50:47 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:50:48 INFO - Downloading docopt-0.6.1.tar.gz 04:50:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:50:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:50:48 INFO - Running setup.py install for blobuploader 04:50:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:50:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:50:48 INFO - Running setup.py install for requests 04:50:48 INFO - Running setup.py install for docopt 04:50:48 INFO - Successfully installed blobuploader requests docopt 04:50:48 INFO - Cleaning up... 04:50:48 INFO - Return code: 0 04:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:48 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:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:48 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:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:48 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:48 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:50:48 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:50:48 INFO - Using env: {'DISPLAY': ':0', 04:50:48 INFO - 'HOME': '/home/cltbld', 04:50:48 INFO - 'LANG': 'en_US.UTF-8', 04:50:48 INFO - 'LANGUAGE': 'en_US:en', 04:50:48 INFO - 'LOGNAME': 'cltbld', 04:50:48 INFO - 'MAIL': '/var/mail/cltbld', 04:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:48 INFO - 'MOZ_NO_REMOTE': '1', 04:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:48 INFO - 'NO_EM_RESTART': '1', 04:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:48 INFO - 'PWD': '/builds/slave/test', 04:50:48 INFO - 'SHELL': '/bin/bash', 04:50:48 INFO - 'SHLVL': '1', 04:50:48 INFO - 'TERM': 'linux', 04:50:48 INFO - 'TMOUT': '86400', 04:50:48 INFO - 'USER': 'cltbld', 04:50:48 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:48 INFO - '_': '/tools/buildbot/bin/python'} 04:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:49 INFO - Running setup.py (path:/tmp/pip-1o1KHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:49 INFO - Running setup.py (path:/tmp/pip-kxWyeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:49 INFO - Running setup.py (path:/tmp/pip-88lkCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:49 INFO - Running setup.py (path:/tmp/pip-qhwRX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:49 INFO - Running setup.py (path:/tmp/pip-iuXTyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:49 INFO - Running setup.py (path:/tmp/pip-AmjdEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:49 INFO - Running setup.py (path:/tmp/pip-IzBBkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:49 INFO - Running setup.py (path:/tmp/pip-_QenqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:49 INFO - Running setup.py (path:/tmp/pip-LMArHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:49 INFO - Running setup.py (path:/tmp/pip-kwKZvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:49 INFO - Running setup.py (path:/tmp/pip-58BrEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:49 INFO - Running setup.py (path:/tmp/pip-ghEE8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:49 INFO - Running setup.py (path:/tmp/pip-jhQj5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:49 INFO - Running setup.py (path:/tmp/pip-jWUwbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:50 INFO - Running setup.py (path:/tmp/pip-HHBDPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:50 INFO - Running setup.py (path:/tmp/pip-Ea1Fot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:50 INFO - Running setup.py (path:/tmp/pip-PF38Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:50 INFO - Running setup.py install for manifestparser 04:50:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:50:50 INFO - Running setup.py install for mozcrash 04:50:50 INFO - Running setup.py install for mozdebug 04:50:50 INFO - Running setup.py install for mozdevice 04:50:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:50:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:50:50 INFO - Running setup.py install for mozfile 04:50:50 INFO - Running setup.py install for mozhttpd 04:50:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:50:50 INFO - Running setup.py install for mozinfo 04:50:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:50:50 INFO - Running setup.py install for mozInstall 04:50:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Running setup.py install for mozleak 04:50:51 INFO - Running setup.py install for mozlog 04:50:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Running setup.py install for moznetwork 04:50:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Running setup.py install for mozprocess 04:50:51 INFO - Running setup.py install for mozprofile 04:50:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Running setup.py install for mozrunner 04:50:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:50:51 INFO - Running setup.py install for mozscreenshot 04:50:51 INFO - Running setup.py install for moztest 04:50:51 INFO - Running setup.py install for mozversion 04:50:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:50:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:52 INFO - Cleaning up... 04:50:52 INFO - Return code: 0 04:50:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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', '-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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:52 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:50:52 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:50:52 INFO - Using env: {'DISPLAY': ':0', 04:50:52 INFO - 'HOME': '/home/cltbld', 04:50:52 INFO - 'LANG': 'en_US.UTF-8', 04:50:52 INFO - 'LANGUAGE': 'en_US:en', 04:50:52 INFO - 'LOGNAME': 'cltbld', 04:50:52 INFO - 'MAIL': '/var/mail/cltbld', 04:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:52 INFO - 'MOZ_NO_REMOTE': '1', 04:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:52 INFO - 'NO_EM_RESTART': '1', 04:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:52 INFO - 'PWD': '/builds/slave/test', 04:50:52 INFO - 'SHELL': '/bin/bash', 04:50:52 INFO - 'SHLVL': '1', 04:50:52 INFO - 'TERM': 'linux', 04:50:52 INFO - 'TMOUT': '86400', 04:50:52 INFO - 'USER': 'cltbld', 04:50:52 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:52 INFO - '_': '/tools/buildbot/bin/python'} 04:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:52 INFO - Running setup.py (path:/tmp/pip-2nZFtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:52 INFO - Running setup.py (path:/tmp/pip-k8SUGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:52 INFO - Running setup.py (path:/tmp/pip-RA20ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:52 INFO - Running setup.py (path:/tmp/pip-ntrqt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:52 INFO - Running setup.py (path:/tmp/pip-Jv5ih_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:52 INFO - Running setup.py (path:/tmp/pip-OBhJVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:52 INFO - Running setup.py (path:/tmp/pip-l56Ap5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:52 INFO - Running setup.py (path:/tmp/pip-e2I8Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:52 INFO - Running setup.py (path:/tmp/pip-BEIdVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:52 INFO - Running setup.py (path:/tmp/pip-ImnLnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:52 INFO - Running setup.py (path:/tmp/pip-iJSYC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:53 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:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:53 INFO - Running setup.py (path:/tmp/pip-MfSWaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:53 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:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:53 INFO - Running setup.py (path:/tmp/pip-zHPu2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:53 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:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:53 INFO - Running setup.py (path:/tmp/pip-AsGaaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:53 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:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:53 INFO - Running setup.py (path:/tmp/pip-ibNpFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:53 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:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:53 INFO - Running setup.py (path:/tmp/pip-h20rxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:53 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:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:53 INFO - Running setup.py (path:/tmp/pip-D2VZVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:53 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:50:53 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:50:53 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:50:53 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:50:53 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:50:53 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:50:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:53 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:50:53 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:50:53 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:50:53 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:50:53 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:50:53 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:50:55 INFO - Downloading blessings-1.5.1.tar.gz 04:50:55 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:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:55 INFO - Installing collected packages: blessings 04:50:55 INFO - Running setup.py install for blessings 04:50:55 INFO - Successfully installed blessings 04:50:55 INFO - Cleaning up... 04:50:55 INFO - Return code: 0 04:50:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:55 INFO - Reading from file tmpfile_stdout 04:50:55 INFO - Current package versions: 04:50:55 INFO - argparse == 1.2.1 04:50:55 INFO - blessings == 1.5.1 04:50:55 INFO - blobuploader == 1.2.4 04:50:55 INFO - docopt == 0.6.1 04:50:55 INFO - manifestparser == 1.1 04:50:55 INFO - mozInstall == 1.12 04:50:55 INFO - mozcrash == 0.16 04:50:55 INFO - mozdebug == 0.1 04:50:55 INFO - mozdevice == 0.47 04:50:55 INFO - mozfile == 1.2 04:50:55 INFO - mozhttpd == 0.7 04:50:55 INFO - mozinfo == 0.9 04:50:55 INFO - mozleak == 0.1 04:50:55 INFO - mozlog == 3.1 04:50:55 INFO - moznetwork == 0.27 04:50:55 INFO - mozprocess == 0.22 04:50:55 INFO - mozprofile == 0.27 04:50:55 INFO - mozrunner == 6.11 04:50:55 INFO - mozscreenshot == 0.1 04:50:55 INFO - mozsystemmonitor == 0.0 04:50:55 INFO - moztest == 0.7 04:50:55 INFO - mozversion == 1.4 04:50:55 INFO - psutil == 3.1.1 04:50:55 INFO - requests == 1.2.3 04:50:55 INFO - wsgiref == 0.1.2 04:50:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:55 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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:55 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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:55 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:55 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:50:55 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:50:55 INFO - Using env: {'DISPLAY': ':0', 04:50:55 INFO - 'HOME': '/home/cltbld', 04:50:55 INFO - 'LANG': 'en_US.UTF-8', 04:50:55 INFO - 'LANGUAGE': 'en_US:en', 04:50:55 INFO - 'LOGNAME': 'cltbld', 04:50:55 INFO - 'MAIL': '/var/mail/cltbld', 04:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:55 INFO - 'MOZ_NO_REMOTE': '1', 04:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:55 INFO - 'NO_EM_RESTART': '1', 04:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:55 INFO - 'PWD': '/builds/slave/test', 04:50:55 INFO - 'SHELL': '/bin/bash', 04:50:55 INFO - 'SHLVL': '1', 04:50:55 INFO - 'TERM': 'linux', 04:50:55 INFO - 'TMOUT': '86400', 04:50:55 INFO - 'USER': 'cltbld', 04:50:55 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:55 INFO - '_': '/tools/buildbot/bin/python'} 04:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 INFO - Cleaning up... 04:50:55 INFO - Return code: 0 04:50:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:50:55 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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:55 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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:55 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:55 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:50:55 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:50:55 INFO - Using env: {'DISPLAY': ':0', 04:50:55 INFO - 'HOME': '/home/cltbld', 04:50:55 INFO - 'LANG': 'en_US.UTF-8', 04:50:55 INFO - 'LANGUAGE': 'en_US:en', 04:50:55 INFO - 'LOGNAME': 'cltbld', 04:50:55 INFO - 'MAIL': '/var/mail/cltbld', 04:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:55 INFO - 'MOZ_NO_REMOTE': '1', 04:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:55 INFO - 'NO_EM_RESTART': '1', 04:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:55 INFO - 'PWD': '/builds/slave/test', 04:50:55 INFO - 'SHELL': '/bin/bash', 04:50:55 INFO - 'SHLVL': '1', 04:50:55 INFO - 'TERM': 'linux', 04:50:55 INFO - 'TMOUT': '86400', 04:50:55 INFO - 'USER': 'cltbld', 04:50:55 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:55 INFO - '_': '/tools/buildbot/bin/python'} 04:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:56 INFO - Downloading/unpacking jsonschema 04:50: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:50: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:50: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:50: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:50: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:50: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:50:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:50:57 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:50:57 INFO - Downloading/unpacking functools32 (from jsonschema) 04:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:50:57 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:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:50:57 INFO - warning: no files found matching '*.txt' 04:50:57 INFO - no previously-included directories found matching 'build' 04:50:57 INFO - no previously-included directories found matching 'dist' 04:50:57 INFO - no previously-included directories found matching '.git*' 04:50:57 INFO - Installing collected packages: jsonschema, functools32 04:50:58 INFO - Running setup.py install for functools32 04:50:58 INFO - warning: no files found matching '*.txt' 04:50:58 INFO - no previously-included directories found matching 'build' 04:50:58 INFO - no previously-included directories found matching 'dist' 04:50:58 INFO - no previously-included directories found matching '.git*' 04:50:58 INFO - Successfully installed jsonschema functools32 04:50:58 INFO - Cleaning up... 04:50:58 INFO - Return code: 0 04:50:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:50:58 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:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:58 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:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:58 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 0x7f111ea8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11de240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', '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:50:58 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:50:58 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:50:58 INFO - Using env: {'DISPLAY': ':0', 04:50:58 INFO - 'HOME': '/home/cltbld', 04:50:58 INFO - 'LANG': 'en_US.UTF-8', 04:50:58 INFO - 'LANGUAGE': 'en_US:en', 04:50:58 INFO - 'LOGNAME': 'cltbld', 04:50:58 INFO - 'MAIL': '/var/mail/cltbld', 04:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:58 INFO - 'MOZ_NO_REMOTE': '1', 04:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:58 INFO - 'NO_EM_RESTART': '1', 04:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:58 INFO - 'PWD': '/builds/slave/test', 04:50:58 INFO - 'SHELL': '/bin/bash', 04:50:58 INFO - 'SHLVL': '1', 04:50:58 INFO - 'TERM': 'linux', 04:50:58 INFO - 'TMOUT': '86400', 04:50:58 INFO - 'USER': 'cltbld', 04:50:58 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:58 INFO - '_': '/tools/buildbot/bin/python'} 04:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:58 INFO - Downloading/unpacking flake8 04:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:51:00 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:51:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:51:00 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:51:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:00 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:51:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:51:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:51:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:51:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:51:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:51:00 INFO - no previously-included directories found matching 'docs/_build' 04:51:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:51:00 INFO - Running setup.py install for pep8 04:51:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:51:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:51:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:51:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:51:00 INFO - no previously-included directories found matching 'docs/_build' 04:51:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:51:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:51:00 INFO - Cleaning up... 04:51:00 INFO - Return code: 0 04:51:00 INFO - Running post-action listener: _resource_record_post_action 04:51:00 INFO - Running post-action listener: _start_resource_monitoring 04:51:00 INFO - Starting resource monitoring. 04:51:00 INFO - ##### 04:51:00 INFO - ##### Running install step. 04:51:00 INFO - ##### 04:51:00 INFO - Running pre-action listener: _resource_record_pre_action 04:51:00 INFO - Running main action method: install 04:51:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:01 INFO - Reading from file tmpfile_stdout 04:51:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:51:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:51:01 INFO - Reading from file tmpfile_stdout 04:51:01 INFO - Output received: 04:51:01 INFO - Usage: mozinstall [options] installer 04:51:01 INFO - Options: 04:51:01 INFO - -h, --help show this help message and exit 04:51:01 INFO - -d DEST, --destination=DEST 04:51:01 INFO - Directory to install application into. [default: 04:51:01 INFO - "/builds/slave/test"] 04:51:01 INFO - --app=APP Application being installed. [default: firefox] 04:51:01 INFO - mkdir: /builds/slave/test/build/application 04:51:01 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:51:01 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:51:15 INFO - Reading from file tmpfile_stdout 04:51:15 INFO - Output received: 04:51:15 INFO - /builds/slave/test/build/application/firefox/firefox 04:51:15 INFO - Running post-action listener: _resource_record_post_action 04:51:15 INFO - ##### 04:51:15 INFO - ##### Running run-tests step. 04:51:15 INFO - ##### 04:51:15 INFO - Running pre-action listener: _resource_record_pre_action 04:51:15 INFO - Running main action method: run_tests 04:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:51:15 INFO - Python 2.7.3 04:51:15 INFO - Return code: 0 04:51:15 INFO - grabbing minidump binary from tooltool 04:51:15 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:15 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 0x126d0b0>, '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 0x126dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126e440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:51:15 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:51:15 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:51:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:51:15 INFO - Return code: 0 04:51:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:51:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:51:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:51:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:51:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:51:16 INFO - Return code: 0 04:51:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test/build 04:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 04:51:16 INFO - Using env: {'DISPLAY': ':0', 04:51:16 INFO - 'HOME': '/home/cltbld', 04:51:16 INFO - 'LANG': 'en_US.UTF-8', 04:51:16 INFO - 'LANGUAGE': 'en_US:en', 04:51:16 INFO - 'LOGNAME': 'cltbld', 04:51:16 INFO - 'MAIL': '/var/mail/cltbld', 04:51:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:51:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:16 INFO - 'MOZ_NO_REMOTE': '1', 04:51:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:16 INFO - 'NO_EM_RESTART': '1', 04:51:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:16 INFO - 'PWD': '/builds/slave/test', 04:51:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:51:16 INFO - 'SHELL': '/bin/bash', 04:51:16 INFO - 'SHLVL': '1', 04:51:16 INFO - 'TERM': 'linux', 04:51:16 INFO - 'TMOUT': '86400', 04:51:16 INFO - 'USER': 'cltbld', 04:51:16 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908', 04:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:16 INFO - '_': '/tools/buildbot/bin/python'} 04:51:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 04:51:17 INFO - mozversion INFO | application_buildid: 20151208030424 04:51:17 INFO - mozversion INFO | application_changeset: 9214b6cd1112bad206619a6ea9052d644eb6c105 04:51:17 INFO - mozversion INFO | application_display_name: Nightly 04:51:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:51:17 INFO - mozversion INFO | application_name: Firefox 04:51:17 INFO - mozversion INFO | application_remotingname: firefox 04:51:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:51:17 INFO - mozversion INFO | application_vendor: Mozilla 04:51:17 INFO - mozversion INFO | application_version: 45.0a1 04:51:17 INFO - mozversion INFO | platform_buildid: 20151208030424 04:51:17 INFO - mozversion INFO | platform_changeset: 9214b6cd1112bad206619a6ea9052d644eb6c105 04:51:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:51:17 INFO - mozversion INFO | platform_version: 45.0a1 04:51:17 INFO - 2015-12-08 04:51:17,036 DEBUG : using testdate: 1449579077 04:51:17 INFO - 2015-12-08 04:51:17,036 DEBUG : actual date: 1449579077 04:51:17 INFO - 2015-12-08 04:51:17,047 INFO : starting webserver on 'localhost:58687' 04:51:17 INFO - 2015-12-08 04:51:17,048 INFO : Starting test suite talos-linux64-ix-007.e 04:51:17 INFO - 2015-12-08 04:51:17,048 INFO : Starting test dromaeo_css 04:51:17 INFO - 2015-12-08 04:51:17,048 DEBUG : operating with platform_type : linux_ 04:51:17 INFO - 2015-12-08 04:51:17,049 INFO : Initialising browser for dromaeo_css test... 04:51:17 INFO - 2015-12-08 04:51:17,061 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7L6U0z/profile http://localhost:58687/getInfo.html 04:51:21 INFO - 2015-12-08 04:51:21,849 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:51:21 INFO - 2015-12-08 04:51:21,850 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:51:21 INFO - 2015-12-08 04:51:21,850 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:51:21 INFO - 2015-12-08 04:51:21,850 DEBUG : BROWSER_OUTPUT: __metrics 04:51:21 INFO - 2015-12-08 04:51:21,952 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:51:22 INFO - 2015-12-08 04:51:22,898 INFO : Browser initialized. 04:51:22 INFO - 2015-12-08 04:51:22,898 INFO : Running cycle 1/1 for dromaeo_css test... 04:51:22 INFO - 2015-12-08 04:51:22,899 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7L6U0z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:51:34 INFO - 2015-12-08 04:51:34,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 142766080 04:51:34 INFO - 2015-12-08 04:51:34,899 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-12-08 04:52:24,557 DEBUG : BROWSER_OUTPUT: 1449579144556 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:54:35 INFO - 2015-12-08 04:54:35,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58687/tests/dromaeo/cssquery-ext.html) 04:54:36 INFO - 2015-12-08 04:54:36,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 147533824 04:54:36 INFO - 2015-12-08 04:54:36,390 DEBUG : BROWSER_OUTPUT: 04:57:38 INFO - 2015-12-08 04:57:38,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/dromaeo/cssquery-ext.html (next: http://localhost:58687/tests/dromaeo/cssquery-jquery.html) 04:57:39 INFO - 2015-12-08 04:57:39,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 144330752 04:57:39 INFO - 2015-12-08 04:57:39,064 DEBUG : BROWSER_OUTPUT: 05:00:40 INFO - 2015-12-08 05:00:40,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58687/tests/dromaeo/cssquery-mootools.html) 05:00:41 INFO - 2015-12-08 05:00:41,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 145489920 05:00:41 INFO - 2015-12-08 05:00:41,538 DEBUG : BROWSER_OUTPUT: 05:03:43 INFO - 2015-12-08 05:03:43,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58687/tests/dromaeo/cssquery-prototype.html) 05:03:43 INFO - 2015-12-08 05:03:43,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 144097280 05:03:43 INFO - 2015-12-08 05:03:43,929 DEBUG : BROWSER_OUTPUT: 05:06:46 INFO - 2015-12-08 05:06:46,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58687/tests/dromaeo/cssquery-yui.html) 05:06:47 INFO - 2015-12-08 05:06:47,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 143519744 05:06:47 INFO - 2015-12-08 05:06:47,090 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/dromaeo/cssquery-yui.html (next: http://localhost:58687/tests/dromaeo/cssquery-dojo.html) 05:09:49 INFO - 2015-12-08 05:09:49,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 147144704 05:09:49 INFO - 2015-12-08 05:09:49,637 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,637 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:09:49 INFO - 2015-12-08 05:09:49,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:09:49 INFO - 2015-12-08 05:09:49,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:09:49 INFO - 2015-12-08 05:09:49,637 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:09:49 INFO - 2015-12-08 05:09:49,637 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2681.7184195659456;2710.905118320859;2729.904453344132;2743.547314693076;2759.3929335546186;4596.080783843228;4702.15361234978;4748.026654535821;4754.049190161969;4758.072175925691;4602.1255961367315;4643.628509719223;4714.175019371613;4727.409073865767;4889.511048895118;4330.956690433102;4424.159409712144;4474.172278128557;4474.306482495218;4479.148961697283;117.7301822965133;4348.97825510872;4367.475902891658;4378.824847006116;4434.512203657611;4393.692441529094;4406.69153159279;4410.360497727827;4420.6242469390145;4448.911021779562;4210.052738133926;4420.027593929331;4444.266695995157;4451.087527056978;4485.641148708096;4234.06850492891;4315.719478233905;4335.718178318431;4408;4410.933835992462;4672.252439609646;4678.391809064834;4733.526647335273;4739.573438390561;4789.137955168068;4826.8793280168275;4987.725675087869;5149.562287205592;5155.974220128913;5184.507471790174;4929.950700493021;5036.21938599514;5043.672161309503;5087.109755792759;5170.482951704799;4719.244920812654;4768.094062128184;4776.761161941889;4778.37881075458;4801.5438533339275;4910.631702622318;5034.823781167642;5233.241180028875;5251.448597897166;5302.70835104073;4943.209086546135;4997.0505603935135;5028.874278143003;5032.220005899091;5067.97466012675;5131.2559678846355;5168;5175.611829112756;5193.2989046479;5221.399539053057;4792.95207047932;4920.212765957501;4947.455779864212;5114.616403769732;5132.897342053138;5027.346444962204;5049.772760225798;5062.265971434122;5072;5084.084864724385;4239.51245606753;4249.660027197817;4261.232978063978;4283.22901877665;4285.61429471349;3593.568771747407;3667.3765459871884;3698.7965661888857;3721.8511259549855;3731.1231860512758;4354.586314300136;4363.956360436355;4374.540673229329;4375.293635482164;4419.359192917009;5096.566791822736;5125.4874512549195;5126.897462050738;5131.666441681279;5176.559992400688;4170.603792639695;4225.19721252961;4275.1663425631705;4343.826246950087;4387.627051700578;4513.887152821206;4516.683832131785;4517.977410112929;4524.909501809945;4566.74882881438;4770.737609431445;4804.375431193923;4822.71063736177;4823.662343635911;4861.416630004422;4798.160321943716;4905.77923993414;4957.950420495749;5053.29253904461;5078.822241221539;4808.495108013608;4841.588464980516;4847;4852.417709874838;4889.046635905964;4738.644601654821;5039.5968322534845;5054.241863720471;5060.418051924076;5088.058709138673;4962.106820772151;5015.799368025238;5065.924011139762;5096.159133742891;5151.613628977917;4947.1589829729755;4974.825881094289;4985.152524070989;4989.201727723692;5046.268291097696;4677.579017888406;4788.976055119702;4979.626528010342;4985.4266759323145;5032.798688052437;4726.8109275628585;4738;4767.475577686521;4810.63920205993;4846.733429661403;5000.5999520037585;5004.899902002013;5005.749712514433;5009.4489606144025;5010.69935803853;4637.976810115928;4709.458412282632;4750.334953106637;4925.088858561177;4950.45544990058 05:09:49 INFO - 2015-12-08 05:09:49,641 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.9235960785686;540.9891802163957;542.452123355411;546.6255614903789;558.9133684278936;32177.356452870958;32885.67114328856;32900.5064924026;32904.83547582262;33139.171520711934;38718.22563548727;39057;39435;39490;39568;7791.493552919056;8005.079415867162;8006.359491240687;8008.919910800905;8037.196280371974;7766.06807183136;7827.060752709683;7884.487508311941;7903.130655627876;7910.288074073333;7850;7860.213978602152;7952.4830885992515;7970.561619110947;7988.920110798876;7836.882446763303;7917.129115797286;7928.6035698214855;7949;7956.801079973018;7787.53274803508;7883.881741773878;7906.209379062106;7917.36661067119;7940.563269020202;36847.26305473875;37145.25709485822;37228.44157337642;37233.62766372356;37421.43867841984;2261.434641339665;2721.1700431368427;2843.1470558832266;2893.8408387538675;2959.7928145029855;26089.869550652125;26131.477370452674;26183.34541636455;26238;26405;3346.5147553604834;3384.3569721752788;3430.7255419566377;3460.2214501737158;3535.3636345457808;211088;213710;214250;215347;215848.99999999843;51342;52371.73814130981;54477.09706126468;54519.72740136274;62382.37617623856;53848.73075634597;54073.72963135159;54336.45663543393;54388.552515136915;54533.72733136388;12235.816462752888;12248.326342051094;12263.202891812181;12318.199317044364;12348.073894457952;10501.107405870587;10578.418186999788;10608.310459820086;10611.787764244671;10649.148068154529;19163.72665615087;19380.127894244793;19397.32109376165;19458.513537161685;19632;7697.23027697237;7893.22402459442;7897.723579674684;7926.326262267657;7963.641636126388;753.4349238071446;906.2478143141177;944.244604316544;1032.055669062799;1051.574112484445;25306.873465632554;25416.618750718753;25810.612840807404;26093.73906260951;26254.212373628823;873.7990262239721;905.7780843693338;918.9494577798285;939.5349302095507;1037.901399367059;15943.123128227828;16129.354825806837;16326.428574999818;16347.264373103239;16532.173391330387;306162;310964;315396;316244;317065;47500.5249947503;47958.76020619875;48203.5179648206;48210.5178948206;48218;1241.0940013789984;1263.0527104671496;1268.6701457621084;1279.6672865054966;1280.6542233596876;27511.724882751718;28176.577351340155;28299.858500707363;30429.695703042686;30662.693373066875;42389.36415953701;43037.56962430335;43263.56736432595;43387.783061085756;43417.56582434135;247220;249280;249451;249489;249711;38667.613323866404;41919.7904010478;41992.79003604963;42155.789221053696;42685.57314426816;37092.62907371;37720.43419348657;37979.43030854484;38453;38587.6141238584;32614.184645383106;33393.83303083469;33543.32913341768;33560.66439335576;33737.15657108592;32136.83931580327;32256.677433226305;32296.35407291888;32482.512762309056;32540.18649533686;32413.513797292588;32931.83534082314;33142.66857331396;33348;33460.330793384484;28251.717482824908;29733.10800675983;29991.850040749658;33943;35135.47296790499;22445.663315050613;22454.550908982055;22513.549729005656;22573.792207143168;22663.320100396355 05:09:49 INFO - 2015-12-08 05:09:49,641 DEBUG : BROWSER_OUTPUT: |2;jquery.html;279.1819967495238;281.73798367518214;282.1155676952753;283.1618409507857;288.0494368583674;12958.222506649585;12984.870151298484;14825.406983720652;15291.847081529182;15296.388144474235;9189.310801689866;9197.0802919708;10700.571977120926;13375.665608359795;13668.453261869538;4498.347739577751;4605.884852878688;4610.561996610317;4612.97693511532;4614.584687378136;3350.8827191048317;4507.57178068083;5096.082705113078;5232.476752324776;5242.056429842627;5197.558207552363;5228.92156617651;5229.8954020919555;5237.764300606463;5254.975279820436;5040.949590504085;5224.686518808883;5227.111391063529;5230.869228269324;5247;5073;5109.846704598868;5128.461511541272;5129.384473863161;5136.768845401966;12579.874201258053;17690.646187076316;18102.4569262921;18204.544886377815;18337;1699.4391850689367;1734.6617409605133;1744.6336269383444;1785.446511581414;1790.436012656009;8669.566521673954;8777.42946708462;10294.845577316271;11588.594399196072;12391.318477483735;1711.5464401933498;1733.367320927865;1781.0649409060218;1784.3933062758595;1822.7994920558729;52862.47137528614;54394.184087238726;54641.453585464034;55252.723736381464;55942.160867587016;9331.113544213289;9554.952225238969;9735.075167859042;9739.56171972263;9781.559829807677;11941.880581194251;11997.700057498632;12026.699332516582;12051.698707532207;12076.51693932233;6678.4991125665765;6741.764038258638;6753.763618273337;6764.188297404343;6813.318668133147;6437.227532696106;6437.806865794034;6478.416942475105;6483.3516648335735;6484.546081774325;4048.7975601219823;4059.2287465382074;4072.185562887375;4104.384342348671;4126.071633882352;1627.8209396966324;1678.4628918745884;1692.8391802778717;1712.3236321653126;1715.296728341374;350.46728971962983;354.97160227181763;356.21810126771487;826.946248493858;863.0592654007037;9240.168384845396;9348.252139828797;9497.620095196253;9570.33007689469;9635.019012545275;354.63472623198146;359.0986623574846;359.2294528236917;368.41789971844423;380.90858194033785;4761.833335833298;5330.280412144389;5373.785048598091;5453.263809385682;5469.453054694578;466152;476504;482439;495905;496806;69761;71191.28808711951;73282;73812.52374952471;74328.25671743322;394.8677193140273;395.3378091696397;395.43057996485544;396.6331143692073;397.8130278768974;8620.61207245663;9002.684906028258;9002.954985225031;13759.862401376258;14256.42974281017;30011.549826753053;30121.84939075378;31049.379012419173;31527.36945261036;31813.5227971576;36161.81919090493;40936.59063409447;41483.37774933439;41521.584784151775;49556;8364;8740.34447416459;8746.256568191775;8794.032656407662;8877.467351958903;12324.630261092181;12489.750204995667;16117.355305788105;16420.42528511544;16611.91694041522;12536.247825130156;12835.614931552069;12979.026573006873;13035.934820325838;13212.339383031001;12483.93758031204;12877.977951597137;12915.741685166431;13310.933445332712;13574.79637805414;12335;12680.873191268338;12828.807567886675;12902.96776257916;13497.392617332047;7962.442629015914;8269.586520674062;8310.418270720991;8352.540610266493;8890.688825891062;12372.56142203264;12471.750564988832;12625.431855566338;12903.290319032543;12977.416016279101 05:09:49 INFO - 2015-12-08 05:09:49,643 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.397441023591;1633.6242664187237;1651.5953591370117;1688.9662206755866;1717.227247738518;5919.141724449953;5988.820335389934;7063.223045465001;7166.749163779269;7201.31587499188;6477.902831457532;6660;6687.69905354259;6687.69905354259;6716.529842910998;2022.342738609954;2052.3945436096387;2062.360668192865;2066.349100033492;2069.5860827834417;2051.6101940631233;2087.405089549479;2088.4361222469925;2101.1070295124587;2119.79861913118;1957.6084783043377;2024.129624261567;2047.2220556188627;2048.9077991490344;2058.9588208235828;2025.0684685044896;2051.8974051297523;2054.0243384392443;2056.8354531637433;2057.6913462980524;2035.2266138867283;2046.2531176120758;2056.228914157191;2061.0416156487154;2079.7088407622796;7069.151701795766;7134.892976605355;7206.387457066156;7208.279172082802;7219.808731559287;4103.4870641169855;4181.0592616661315;4193.874183774492;4197.706160568731;4199.2441360555085;2716.076533978437;2765.834049957009;2779.374640705845;2790.2187387531526;2805.2145399288233;842.9199226073574;846.4413487098547;850.4684572142411;851.221132663612;870.6734974384606;9519.524023798782;9521.761955951088;9566.760830979212;9576.281778866543;9625.71122866315;3756.73702840804;3799.8100094995693;3843.7693738375788;3857.633524815138;3872.5546562145714;8139.348852091818;8151.266386025286;8171.387145964077;8188.058373287148;8205;4151.12826306473;4157.10622216225;4175.352820312856;4187.099773548702;4194.035371864488;3155.353152603711;3217.951730724041;3658.689011434058;3766.2655782122224;3776.169242766587;3348.983255083709;3386.0857568456377;3401.5407919930494;3418.6068602110577;3423.9828800856335;1046.6807623674852;1060.0777323728405;1060.5545670818274;1062.9627963021258;1074.9408782517037;785.2265518464308;849.1635738797403;1165.9883401166048;1174.7063234191453;1180.138498895811;6320.778772743024;6360.618362898241;6365.8859699552395;6367.108604795332;6368.140301059298;1006.7080546641392;1016.339379403379;1024.2420608749471;1032.9173666106694;1041.6822869024868;5046.34397528319;5050.3434553507805;5078.289039534468;5084.3644544431945;5098.46466121052;8233.79415514605;8324.500529968222;8396.370272229608;8426.957865210634;8602.139786021347;8254.628541715638;8320.8335833283;8387.790305242417;8396.412251142483;8536.44513106646;6533.673316334164;6533.673316334164;6674;6720.798376048726;6729.831754206184;6363.809085727436;6367.172267605181;6384;6388.041793730978;6407.038944158414;7377.815554610963;7526.360259378014;7564.924350756422;7595.886061708969;7651.196624354363;7724.227577242231;7756;7782;7805.14143444232;7905.604719763874;5093;5233.764480598306;5734.311882573951;5930.822075337746;5961.791337303347;6479.773207937699;6498.480121590356;6518.315576864551;6551.050097735706;6570.080188773671;6118.20463339763;6160.568760186744;6265;6272.2159730033745;6281.811545653638;6023.909641355471;6253.499720022478;6257.499400047895;6342.619442833445;6348.968255158695;5930.169776231245;5958.195643588234;5961.046232602763;5962.867055259487;5988.970055149696;5686.175504551899;5706.258186435737;5718.3423906249645;5719.113537401709;5733.885322293614;5684.317881854204;5812.709364531841;5841.4450627190345;5848.53211743051;5904.261967254093 05:09:49 INFO - 2015-12-08 05:09:49,646 DEBUG : BROWSER_OUTPUT: |4;prototype.html;257.28603126324447;259.39560823281755;262.2264320255246;262.76220020881107;264.1586546848288;5425.728713564321;5477.315335583052;5538.335399752031;5549.139883318082;5626.184203290521;5395.568354531638;5481.862953426166;5518.33779946406;5525.4474552544725;5564.248826408434;4181.64456021237;4190.9580904191025;4194.0563373241;4197.4753155855515;4217.304144816102;4202;4204.5585213552595;4211.199872024321;4213.536510983789;4221.936670949938;3955.4462375267485;4058.8782336529803;4168.936921085119;4180.498340199165;4181.414601955728;4045.6763458923365;4047.959520404788;4049.1091959768805;4054.108096218827;4095.9385609215888;3470.687638112582;3472.791632502058;3480.286541259036;3480.3735327641016;3484.9825750871337;5351.411344752074;5366.034113859504;5368.033753924292;5372.623916325859;5375.489328513824;4569.611583015448;4695.7886895089805;4699.600533954618;4699.647526435531;4702.388689470347;5639.774409023634;5750.539956803445;5807.709614519257;5811;5824.417558244184;3745.8501659933568;3767.981160094182;3769.754965927206;3777.867774627875;3782.867599634;6039.698015099228;6147.969260153715;6148.631082135086;6148.754049838001;6150.323464418911;3811.8284677189595;3888.1640447303967;3893.182431689377;3903.5706072332023;3906.7265291429894;3952.4071389291835;3953.9802300988313;3954.7429417087797;3956.8812935611977;3957.5250969883223;4675.509071547506;4680.695754775928;4689.343491911135;4689.742064186435;4691.53084691535;5834.095715164156;5848.61983971049;5860.150278209636;5867.413258674099;5874.295084589877;1353.5127354152498;1388.4515616331491;1398.454602704946;1398.6083896508994;1402.0956483068364;894.3962825093037;916.3631276262934;927.8144371125667;950.1875896108866;961.783598690303;4963.602911767122;4967.577755890789;4974.104661160954;4976.576990955809;4978.377702787152;6005.189299444606;6016.398360163948;6033.456988871023;6051.546134039964;6065.5450841187085;5003.524665156877;5025.045241404122;5035.7985680572365;5046.823361182414;5047.116754567936;3195.2171717929255;3203.935921281608;3233.3694929488524;3266.738660907122;3303.636599974001;5646.463585959327;5715.9997000524745;5782.653040817564;5783.88432231353;5801.767929282782;6292.811215663446;6336.112944187817;6342.778002769973;6345.270293916259;6356.77751278703;5664.291963504562;5784.913226301609;5789.6526208426785;5794.304683438015;5803.332616749043;6158.692065396623;6160.199174107337;6165.722542485689;6168.784092556739;6173.259208894961;5989.490893274121;6004.459598635969;6007.879842403215;6014.789482368096;6032.849178770566;5752.568557358131;5761;5765.913511297418;5768.394318596487;5786.884262314814;3754.4556039374684;3841.635044670752;3887.261420330128;3888.902777430587;3902.200048990007;6021.397860213943;6056.333803281724;6074;6077.756889724362;6087.269527656709;5824.912626310694;5845.795397161079;5849.824505264849;5868.706564671664;5877.118432235199;5717.828465146053;5850.9175802476675;5854.209681693087;5858.297004359334;5860.619059761102;5733.942660573341;5735.483806457439;5736.483716465371;5743.942560574341;5756;5877.206577112035;5879.882402352015;5884.882302354014;5889.440503152194;5891.970540147272;5601.943980560142;5749.338826034892;5749.511291540266;5754.813170994995;5761.193432919478 05:09:49 INFO - 2015-12-08 05:09:49,648 DEBUG : BROWSER_OUTPUT: |5;yui.html;611.6758118197356;631.8262477818596;719.7984564321988;788.4953629677008;791.2680770287486;11331.320120792749;11534.134939879512;11656.941715291432;11668.47491862866;11697.532098716063;13071;13326.333683315845;13350.1989880607;13360.933195334033;13368.465261389558;783.0759703549809;788.6214616983851;793.1513280789528;794.9602519874012;799.9880001799978;793.1552896165565;797.4378063465272;797.972070977516;800.3917023062485;802.3781569283823;815.6451943404609;822.5147163173726;825.694493037577;825.859603867344;825.9174082591753;809.4900212865887;812.2080971053235;812.7683610171102;814.6049166154411;814.6578437056421;602.6534742523023;603.9516838652897;605.7758629307141;609.0225188572322;611.0284647410639;11924.22492537991;11986.880131198664;11994.220375675553;12005.159638825286;12060.698482537919;10662.147028237723;10959.232853700245;11047.558097676083;11080.168987325902;11285.661430157108;8772.736817895473;9213;9377.578008989612;9595.952020239854;9666.226701863905;3029.72732454078;3077.199928018731;3078.0919628709585;3119.407312610597;3135.822429813264;39947.40078898819;40599.59400406017;40725.59274407248;40886.1822763546;41073.794631026954;8541.86227898911;8591;8694.30445564366;8729.956350218208;8884.200421961925;15783.210839457981;15971.281292341873;15976.281067351996;15981.12103834277;15994.600134996717;5877.676727779927;5913.467787899023;6006.489448396847;6058.27300723916;6115.785947491817;3596.496490491333;3621.257642183346;3675.3568125577917;3696.075981004749;3716.0338312039066;2560.06557606476;2580.4065065035147;2601.8829152688177;2606.153000274918;2607.5697509911033;445.20753059553397;450.6552487347182;451.14282862561396;452.9456465224194;459.37983721975064;481.30211193769173;593.0984902947496;597.2593983460478;601.4526780629606;610.4627927423838;7215.819604509824;7240.601766902871;7458.393668299882;7511.474196806281;7578.204288549733;514.1003244322436;552.4227182594118;613.4172536090732;616.1466369078857;636.4462917262011;3561.679448849616;3585.8744943926836;3645.052286405554;3873.825677844504;3904.9609503905167;45440.77279613581;46820.5317946823;47221.527784721715;47541.5245847544;47822.28266576004;43539.346909796375;43881.56118438839;44292.778536107755;44316.778416107714;44496.55503444989;38407.80796096002;39091;39331.6066839328;39507.40738888976;39508.20983580312;7458.888116678146;7574.204708505527;7599.696012159673;7645.617719114133;7698.153203147761;29065.709342907146;29663;30161.396772064876;30281.091567253017;30474.84762576173;36289.63710362863;37128.44307335338;37767.62232377641;37806.24387512289;37819.62180378161;9905.306628535933;10184.592616295266;10223.744406389602;10229.43738094412;10337.793244135226;11337.138542396458;11415.200935934405;11553.364564949008;11643.184977051525;12122.757544848877;10003.499825008575;10372.585096596353;10544.525496352837;10909.18181136402;11228.606998755004;10294.536745846304;10322.2258330624;10414.189357981513;10422.166226701996;10688.25182237236;9301.395409298373;9481.146696797321;9482.620695172116;9553.90446095558;9653;8975.461472311683;9052.64617334804;9087.227585655293;9181.678641247792;9211.539423028687;8977.91022089797;8986.640534378814;8998.370114092213;9011.369204155646;9109.407888487227 05:09:49 INFO - 2015-12-08 05:09:49,648 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:09:49 INFO - 2015-12-08 05:09:49,648 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:09:49 INFO - 2015-12-08 05:09:49,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,338 05:09:49 INFO - 2015-12-08 05:09:49,648 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:09:49 INFO - 2015-12-08 05:09:49,649 DEBUG : BROWSER_OUTPUT: __startTimestamp1449580189636__endTimestamp 05:09:49 INFO - 2015-12-08 05:09:49,649 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,649 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:09:49 INFO - 2015-12-08 05:09:49,649 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:09:49 INFO - 2015-12-08 05:09:49,650 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,650 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4656.48 Median:4789.14 stddev:603.12 (12.6%) stddev-sans-first:584.73 05:09:49 INFO - 2015-12-08 05:09:49,650 DEBUG : BROWSER_OUTPUT: Values: 2681.7 2710.9 2729.9 2743.5 2759.4 4596.1 4702.2 4748.0 4754.0 4758.1 4602.1 4643.6 4714.2 4727.4 4889.5 4331.0 4424.2 4474.2 4474.3 4479.1 117.7 4349.0 4367.5 4378.8 4434.5 4393.7 4406.7 4410.4 4420.6 4448.9 4210.1 4420.0 4444.3 4451.1 4485.6 4234.1 4315.7 4335.7 4408.0 4410.9 4672.3 4678.4 4733.5 4739.6 4789.1 4826.9 4987.7 5149.6 5156.0 5184.5 4930.0 5036.2 5043.7 5087.1 5170.5 4719.2 4768.1 4776.8 4778.4 4801.5 4910.6 5034.8 5233.2 5251.4 5302.7 4943.2 4997.1 5028.9 5032.2 5068.0 5131.3 5168.0 5175.6 5193.3 5221.4 4793.0 4920.2 4947.5 5114.6 5132.9 5027.3 5049.8 5062.3 5072.0 5084.1 4239.5 4249.7 4261.2 4283.2 4285.6 3593.6 3667.4 3698.8 3721.9 3731.1 4354.6 4364.0 4374.5 4375.3 4419.4 5096.6 5125.5 5126.9 5131.7 5176.6 4170.6 4225.2 4275.2 4343.8 4387.6 4513.9 4516.7 4518.0 4524.9 4566.7 4770.7 4804.4 4822.7 4823.7 4861.4 4798.2 4905.8 4958.0 5053.3 5078.8 4808.5 4841.6 4847.0 4852.4 4889.0 4738.6 5039.6 5054.2 5060.4 5088.1 4962.1 5015.8 5065.9 5096.2 5151.6 4947.2 4974.8 4985.2 4989.2 5046.3 4677.6 4789.0 4979.6 4985.4 5032.8 4726.8 4738.0 4767.5 4810.6 4846.7 5000.6 5004.9 5005.7 5009.4 5010.7 4638.0 4709.5 4750.3 4925.1 4950.5 05:09:49 INFO - 2015-12-08 05:09:49,650 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,650 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42078.63 Median:33648.91 stddev:68451.85 (203.4%) stddev-sans-first:68572.77 05:09:49 INFO - 2015-12-08 05:09:49,650 DEBUG : BROWSER_OUTPUT: Values: 526.9 541.0 542.5 546.6 558.9 32177.4 32885.7 32900.5 32904.8 33139.2 38718.2 39057.0 39435.0 39490.0 39568.0 7791.5 8005.1 8006.4 8008.9 8037.2 7766.1 7827.1 7884.5 7903.1 7910.3 7850.0 7860.2 7952.5 7970.6 7988.9 7836.9 7917.1 7928.6 7949.0 7956.8 7787.5 7883.9 7906.2 7917.4 7940.6 36847.3 37145.3 37228.4 37233.6 37421.4 2261.4 2721.2 2843.1 2893.8 2959.8 26089.9 26131.5 26183.3 26238.0 26405.0 3346.5 3384.4 3430.7 3460.2 3535.4 211088.0 213710.0 214250.0 215347.0 215849.0 51342.0 52371.7 54477.1 54519.7 62382.4 53848.7 54073.7 54336.5 54388.6 54533.7 12235.8 12248.3 12263.2 12318.2 12348.1 10501.1 10578.4 10608.3 10611.8 10649.1 19163.7 19380.1 19397.3 19458.5 19632.0 7697.2 7893.2 7897.7 7926.3 7963.6 753.4 906.2 944.2 1032.1 1051.6 25306.9 25416.6 25810.6 26093.7 26254.2 873.8 905.8 918.9 939.5 1037.9 15943.1 16129.4 16326.4 16347.3 16532.2 306162.0 310964.0 315396.0 316244.0 317065.0 47500.5 47958.8 48203.5 48210.5 48218.0 1241.1 1263.1 1268.7 1279.7 1280.7 27511.7 28176.6 28299.9 30429.7 30662.7 42389.4 43037.6 43263.6 43387.8 43417.6 247220.0 249280.0 249451.0 249489.0 249711.0 38667.6 41919.8 41992.8 42155.8 42685.6 37092.6 37720.4 37979.4 38453.0 38587.6 32614.2 33393.8 33543.3 33560.7 33737.2 32136.8 32256.7 32296.4 32482.5 32540.2 32413.5 32931.8 33142.7 33348.0 33460.3 28251.7 29733.1 29991.9 33943.0 35135.5 22445.7 22454.6 22513.5 22573.8 22663.3 05:09:49 INFO - 2015-12-08 05:09:49,650 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,652 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25440.59 Median:22504.39 stddev:79123.46 (351.6%) stddev-sans-first:79322.86 05:09:49 INFO - 2015-12-08 05:09:49,652 DEBUG : BROWSER_OUTPUT: Values: 279.2 281.7 282.1 283.2 288.0 12958.2 12984.9 14825.4 15291.8 15296.4 9189.3 9197.1 10700.6 13375.7 13668.5 4498.3 4605.9 4610.6 4613.0 4614.6 3350.9 4507.6 5096.1 5232.5 5242.1 5197.6 5228.9 5229.9 5237.8 5255.0 5040.9 5224.7 5227.1 5230.9 5247.0 5073.0 5109.8 5128.5 5129.4 5136.8 12579.9 17690.6 18102.5 18204.5 18337.0 1699.4 1734.7 1744.6 1785.4 1790.4 8669.6 8777.4 10294.8 11588.6 12391.3 1711.5 1733.4 1781.1 1784.4 1822.8 52862.5 54394.2 54641.5 55252.7 55942.2 9331.1 9555.0 9735.1 9739.6 9781.6 11941.9 11997.7 12026.7 12051.7 12076.5 6678.5 6741.8 6753.8 6764.2 6813.3 6437.2 6437.8 6478.4 6483.4 6484.5 4048.8 4059.2 4072.2 4104.4 4126.1 1627.8 1678.5 1692.8 1712.3 1715.3 350.5 355.0 356.2 826.9 863.1 9240.2 9348.3 9497.6 9570.3 9635.0 354.6 359.1 359.2 368.4 380.9 4761.8 5330.3 5373.8 5453.3 5469.5 466152.0 476504.0 482439.0 495905.0 496806.0 69761.0 71191.3 73282.0 73812.5 74328.3 394.9 395.3 395.4 396.6 397.8 8620.6 9002.7 9003.0 13759.9 14256.4 30011.5 30121.8 31049.4 31527.4 31813.5 36161.8 40936.6 41483.4 41521.6 49556.0 8364.0 8740.3 8746.3 8794.0 8877.5 12324.6 12489.8 16117.4 16420.4 16611.9 12536.2 12835.6 12979.0 13035.9 13212.3 12483.9 12878.0 12915.7 13310.9 13574.8 12335.0 12680.9 12828.8 12903.0 13497.4 7962.4 8269.6 8310.4 8352.5 8890.7 12372.6 12471.8 12625.4 12903.3 12977.4 05:09:49 INFO - 2015-12-08 05:09:49,652 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,652 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4849.67 Median:5911.70 stddev:2500.36 (42.3%) stddev-sans-first:2494.75 05:09:49 INFO - 2015-12-08 05:09:49,652 DEBUG : BROWSER_OUTPUT: Values: 1506.4 1633.6 1651.6 1689.0 1717.2 5919.1 5988.8 7063.2 7166.7 7201.3 6477.9 6660.0 6687.7 6687.7 6716.5 2022.3 2052.4 2062.4 2066.3 2069.6 2051.6 2087.4 2088.4 2101.1 2119.8 1957.6 2024.1 2047.2 2048.9 2059.0 2025.1 2051.9 2054.0 2056.8 2057.7 2035.2 2046.3 2056.2 2061.0 2079.7 7069.2 7134.9 7206.4 7208.3 7219.8 4103.5 4181.1 4193.9 4197.7 4199.2 2716.1 2765.8 2779.4 2790.2 2805.2 842.9 846.4 850.5 851.2 870.7 9519.5 9521.8 9566.8 9576.3 9625.7 3756.7 3799.8 3843.8 3857.6 3872.6 8139.3 8151.3 8171.4 8188.1 8205.0 4151.1 4157.1 4175.4 4187.1 4194.0 3155.4 3218.0 3658.7 3766.3 3776.2 3349.0 3386.1 3401.5 3418.6 3424.0 1046.7 1060.1 1060.6 1063.0 1074.9 785.2 849.2 1166.0 1174.7 1180.1 6320.8 6360.6 6365.9 6367.1 6368.1 1006.7 1016.3 1024.2 1032.9 1041.7 5046.3 5050.3 5078.3 5084.4 5098.5 8233.8 8324.5 8396.4 8427.0 8602.1 8254.6 8320.8 8387.8 8396.4 8536.4 6533.7 6533.7 6674.0 6720.8 6729.8 6363.8 6367.2 6384.0 6388.0 6407.0 7377.8 7526.4 7564.9 7595.9 7651.2 7724.2 7756.0 7782.0 7805.1 7905.6 5093.0 5233.8 5734.3 5930.8 5961.8 6479.8 6498.5 6518.3 6551.1 6570.1 6118.2 6160.6 6265.0 6272.2 6281.8 6023.9 6253.5 6257.5 6342.6 6349.0 5930.2 5958.2 5961.0 5962.9 5989.0 5686.2 5706.3 5718.3 5719.1 5733.9 5684.3 5812.7 5841.4 5848.5 5904.3 05:09:49 INFO - 2015-12-08 05:09:49,652 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,652 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4770.87 Median:5531.89 stddev:1481.50 (26.8%) stddev-sans-first:1446.41 05:09:49 INFO - 2015-12-08 05:09:49,653 DEBUG : BROWSER_OUTPUT: Values: 257.3 259.4 262.2 262.8 264.2 5425.7 5477.3 5538.3 5549.1 5626.2 5395.6 5481.9 5518.3 5525.4 5564.2 4181.6 4191.0 4194.1 4197.5 4217.3 4202.0 4204.6 4211.2 4213.5 4221.9 3955.4 4058.9 4168.9 4180.5 4181.4 4045.7 4048.0 4049.1 4054.1 4095.9 3470.7 3472.8 3480.3 3480.4 3485.0 5351.4 5366.0 5368.0 5372.6 5375.5 4569.6 4695.8 4699.6 4699.6 4702.4 5639.8 5750.5 5807.7 5811.0 5824.4 3745.9 3768.0 3769.8 3777.9 3782.9 6039.7 6148.0 6148.6 6148.8 6150.3 3811.8 3888.2 3893.2 3903.6 3906.7 3952.4 3954.0 3954.7 3956.9 3957.5 4675.5 4680.7 4689.3 4689.7 4691.5 5834.1 5848.6 5860.2 5867.4 5874.3 1353.5 1388.5 1398.5 1398.6 1402.1 894.4 916.4 927.8 950.2 961.8 4963.6 4967.6 4974.1 4976.6 4978.4 6005.2 6016.4 6033.5 6051.5 6065.5 5003.5 5025.0 5035.8 5046.8 5047.1 3195.2 3203.9 3233.4 3266.7 3303.6 5646.5 5716.0 5782.7 5783.9 5801.8 6292.8 6336.1 6342.8 6345.3 6356.8 5664.3 5784.9 5789.7 5794.3 5803.3 6158.7 6160.2 6165.7 6168.8 6173.3 5989.5 6004.5 6007.9 6014.8 6032.8 5752.6 5761.0 5765.9 5768.4 5786.9 3754.5 3841.6 3887.3 3888.9 3902.2 6021.4 6056.3 6074.0 6077.8 6087.3 5824.9 5845.8 5849.8 5868.7 5877.1 5717.8 5850.9 5854.2 5858.3 5860.6 5733.9 5735.5 5736.5 5743.9 5756.0 5877.2 5879.9 5884.9 5889.4 5892.0 5601.9 5749.3 5749.5 5754.8 5761.2 05:09:49 INFO - 2015-12-08 05:09:49,653 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-12-08 05:09:49,653 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11962.66 Median:450.90 stddev:13352.44 (2961.3%) stddev-sans-first:13362.69 05:09:49 INFO - 2015-12-08 05:09:49,654 DEBUG : BROWSER_OUTPUT: Values: 611.7 631.8 719.8 788.5 791.3 11331.3 11534.1 11656.9 11668.5 11697.5 13071.0 13326.3 13350.2 13360.9 13368.5 783.1 788.6 793.2 795.0 800.0 793.2 797.4 798.0 800.4 802.4 815.6 822.5 825.7 825.9 825.9 809.5 812.2 812.8 814.6 814.7 602.7 604.0 605.8 609.0 611.0 11924.2 11986.9 11994.2 12005.2 12060.7 10662.1 10959.2 11047.6 11080.2 11285.7 8772.7 9213.0 9377.6 9596.0 9666.2 3029.7 3077.2 3078.1 3119.4 3135.8 39947.4 40599.6 40725.6 40886.2 41073.8 8541.9 8591.0 8694.3 8730.0 8884.2 15783.2 15971.3 15976.3 15981.1 15994.6 5877.7 5913.5 6006.5 6058.3 6115.8 3596.5 3621.3 3675.4 3696.1 3716.0 2560.1 2580.4 2601.9 2606.2 2607.6 445.2 450.7 451.1 452.9 459.4 481.3 593.1 597.3 601.5 610.5 7215.8 7240.6 7458.4 7511.5 7578.2 514.1 552.4 613.4 616.1 636.4 3561.7 3585.9 3645.1 3873.8 3905.0 45440.8 46820.5 47221.5 47541.5 47822.3 43539.3 43881.6 44292.8 44316.8 44496.6 38407.8 39091.0 39331.6 39507.4 39508.2 7458.9 7574.2 7599.7 7645.6 7698.2 29065.7 29663.0 30161.4 30281.1 30474.8 36289.6 37128.4 37767.6 37806.2 37819.6 9905.3 10184.6 10223.7 10229.4 10337.8 11337.1 11415.2 11553.4 11643.2 12122.8 10003.5 10372.6 10544.5 10909.2 11228.6 10294.5 10322.2 10414.2 10422.2 10688.3 9301.4 9481.1 9482.6 9553.9 9653.0 8975.5 9052.6 9087.2 9181.7 9211.5 8977.9 8986.6 8998.4 9011.4 9109.4 05:09:49 INFO - 2015-12-08 05:09:49,655 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:09:49 INFO - 2015-12-08 05:09:49,655 DEBUG : BROWSER_OUTPUT: 05:09:50 INFO - 2015-12-08 05:09:50,426 INFO : Browser exited with error code: 0 05:09:50 INFO - 2015-12-08 05:09:50,447 INFO : Completed test dromaeo_css (00:18:33) 05:09:50 INFO - 2015-12-08 05:09:50,447 INFO : Starting test kraken 05:09:50 INFO - 2015-12-08 05:09:50,447 DEBUG : operating with platform_type : linux_ 05:09:50 INFO - 2015-12-08 05:09:50,447 INFO : Initialising browser for kraken test... 05:09:50 INFO - 2015-12-08 05:09:50,454 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWxjE0B/profile http://localhost:58687/getInfo.html 05:09:55 INFO - 2015-12-08 05:09:55,297 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:55 INFO - 2015-12-08 05:09:55,298 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:55 INFO - 2015-12-08 05:09:55,298 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:09:55 INFO - 2015-12-08 05:09:55,298 DEBUG : BROWSER_OUTPUT: __metrics 05:09:55 INFO - 2015-12-08 05:09:55,399 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:09:56 INFO - 2015-12-08 05:09:56,374 INFO : Browser initialized. 05:09:56 INFO - 2015-12-08 05:09:56,374 INFO : Running cycle 1/1 for kraken test... 05:09:56 INFO - 2015-12-08 05:09:56,375 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWxjE0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:10:08 INFO - 2015-12-08 05:10:08,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 143364096 05:10:08 INFO - 2015-12-08 05:10:08,397 DEBUG : BROWSER_OUTPUT: 05:10:10 INFO - 2015-12-08 05:10:10,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58687/tests/kraken/driver.html?testName=audio-beat-detection) 05:10:11 INFO - 2015-12-08 05:10:11,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 144240640 05:10:11 INFO - 2015-12-08 05:10:11,607 DEBUG : BROWSER_OUTPUT: 05:10:14 INFO - 2015-12-08 05:10:14,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58687/tests/kraken/driver.html?testName=audio-dft) 05:10:14 INFO - 2015-12-08 05:10:14,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 144867328 05:10:14 INFO - 2015-12-08 05:10:14,977 DEBUG : BROWSER_OUTPUT: 05:10:17 INFO - 2015-12-08 05:10:17,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58687/tests/kraken/driver.html?testName=audio-fft) 05:10:18 INFO - 2015-12-08 05:10:18,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 138620928 05:10:18 INFO - 2015-12-08 05:10:18,470 DEBUG : BROWSER_OUTPUT: 05:10:20 INFO - 2015-12-08 05:10:20,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58687/tests/kraken/driver.html?testName=audio-oscillator) 05:10:21 INFO - 2015-12-08 05:10:21,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 139042816 05:10:21 INFO - 2015-12-08 05:10:21,166 DEBUG : BROWSER_OUTPUT: 05:10:23 INFO - 2015-12-08 05:10:23,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:10:24 INFO - 2015-12-08 05:10:24,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 141258752 05:10:24 INFO - 2015-12-08 05:10:24,001 DEBUG : BROWSER_OUTPUT: 05:10:27 INFO - 2015-12-08 05:10:27,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58687/tests/kraken/driver.html?testName=imaging-darkroom) 05:10:27 INFO - 2015-12-08 05:10:27,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 139694080 05:10:27 INFO - 2015-12-08 05:10:27,714 DEBUG : BROWSER_OUTPUT: 05:10:31 INFO - 2015-12-08 05:10:31,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58687/tests/kraken/driver.html?testName=imaging-desaturate) 05:10:31 INFO - 2015-12-08 05:10:31,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 138784768 05:10:31 INFO - 2015-12-08 05:10:31,790 DEBUG : BROWSER_OUTPUT: 05:10:34 INFO - 2015-12-08 05:10:34,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58687/tests/kraken/driver.html?testName=json-parse-financial) 05:10:35 INFO - 2015-12-08 05:10:35,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 138104832 05:10:35 INFO - 2015-12-08 05:10:35,297 DEBUG : BROWSER_OUTPUT: 05:10:37 INFO - 2015-12-08 05:10:37,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:37 INFO - 2015-12-08 05:10:37,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 141225984 05:10:37 INFO - 2015-12-08 05:10:37,701 DEBUG : BROWSER_OUTPUT: 05:10:39 INFO - 2015-12-08 05:10:39,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:40 INFO - 2015-12-08 05:10:40,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 141819904 05:10:40 INFO - 2015-12-08 05:10:40,232 DEBUG : BROWSER_OUTPUT: 05:10:42 INFO - 2015-12-08 05:10:42,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:43 INFO - 2015-12-08 05:10:43,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 141803520 05:10:43 INFO - 2015-12-08 05:10:43,039 DEBUG : BROWSER_OUTPUT: 05:10:45 INFO - 2015-12-08 05:10:45,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:46 INFO - 2015-12-08 05:10:46,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 139874304 05:10:46 INFO - 2015-12-08 05:10:46,256 DEBUG : BROWSER_OUTPUT: 05:10:48 INFO - 2015-12-08 05:10:48,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:49 INFO - 2015-12-08 05:10:49,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 141152256 05:10:49 INFO - 2015-12-08 05:10:49,461 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58687/tests/kraken/driver.html?testName=ai-astar) 05:10:51 INFO - 2015-12-08 05:10:51,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 141856768 05:10:51 INFO - 2015-12-08 05:10:51,515 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,515 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:10:51 INFO - 2015-12-08 05:10:51,515 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;110;117;114;116;124;120;112;114;114 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;133;151;169;136;154;155;140;166;137 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;167;163;162;162;165;166;164;165;163 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;72;148;72;78;72;72;143 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;127;94;96;95;136;95;95;131 05:10:51 INFO - 2015-12-08 05:10:51,516 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;111;110;111;110;110;110 05:10:51 INFO - 2015-12-08 05:10:51,517 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;148;149;149;149;147;147;148 05:10:51 INFO - 2015-12-08 05:10:51,517 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;96;96;96;96;95;96;97;97;96 05:10:51 INFO - 2015-12-08 05:10:51,517 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;83;74;75;76;75;75;76;74;75;73 05:10:51 INFO - 2015-12-08 05:10:51,517 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;69;71;70;69;69;70;68;68 05:10:51 INFO - 2015-12-08 05:10:51,517 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;86;86;85;86;86;85;97;102 05:10:51 INFO - 2015-12-08 05:10:51,517 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;127;137;125;134;143;128;128;122;123 05:10:51 INFO - 2015-12-08 05:10:51,518 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;146;159;146;155;136;148;145;149;149 05:10:51 INFO - 2015-12-08 05:10:51,518 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;73;72;74;74;70;75;70;69;71 05:10:51 INFO - 2015-12-08 05:10:51,518 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:10:51 INFO - 2015-12-08 05:10:51,518 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:10:51 INFO - 2015-12-08 05:10:51,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,792 05:10:51 INFO - 2015-12-08 05:10:51,518 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:10:51 INFO - 2015-12-08 05:10:51,518 DEBUG : BROWSER_OUTPUT: __startTimestamp1449580251509__endTimestamp 05:10:51 INFO - 2015-12-08 05:10:51,519 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,520 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:10:51 INFO - 2015-12-08 05:10:51,520 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:10:51 INFO - 2015-12-08 05:10:51,520 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,520 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:4.09 (3.6%) stddev-sans-first:4.24 05:10:51 INFO - 2015-12-08 05:10:51,521 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 117.0 114.0 116.0 124.0 120.0 112.0 114.0 114.0 05:10:51 INFO - 2015-12-08 05:10:51,521 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,521 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.90 Median:154.50 stddev:12.81 (8.3%) stddev-sans-first:13.25 05:10:51 INFO - 2015-12-08 05:10:51,521 DEBUG : BROWSER_OUTPUT: Values: 158.0 133.0 151.0 169.0 136.0 154.0 155.0 140.0 166.0 137.0 05:10:51 INFO - 2015-12-08 05:10:51,521 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,521 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:1.66 (1.0%) stddev-sans-first:1.76 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: Values: 164.0 167.0 163.0 162.0 162.0 165.0 166.0 164.0 165.0 163.0 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.70 Median:72.50 stddev:30.54 (42.1%) stddev-sans-first:31.93 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 72.0 148.0 72.0 78.0 72.0 72.0 143.0 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.55 (18.5%) stddev-sans-first:18.23 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 127.0 94.0 96.0 95.0 136.0 95.0 95.0 131.0 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:10:51 INFO - 2015-12-08 05:10:51,522 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 111.0 110.0 111.0 110.0 110.0 110.0 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 148.0 149.0 149.0 149.0 147.0 147.0 148.0 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:0.60 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: Values: 100.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 97.0 96.0 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.60 Median:75.00 stddev:2.76 (3.7%) stddev-sans-first:0.97 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: Values: 83.0 74.0 75.0 76.0 75.0 75.0 76.0 74.0 75.0 73.0 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 05:10:51 INFO - 2015-12-08 05:10:51,523 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 69.0 71.0 70.0 69.0 69.0 70.0 68.0 68.0 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:86.00 stddev:6.25 (7.3%) stddev-sans-first:6.37 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 86.0 86.0 85.0 86.0 86.0 85.0 97.0 102.0 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:128.00 stddev:6.67 (5.2%) stddev-sans-first:6.96 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: Values: 126.0 127.0 137.0 125.0 134.0 143.0 128.0 128.0 122.0 123.0 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:148.50 stddev:6.87 (4.6%) stddev-sans-first:6.45 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: Values: 138.0 146.0 159.0 146.0 155.0 136.0 148.0 145.0 149.0 149.0 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.50 stddev:2.10 (2.9%) stddev-sans-first:2.12 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 72.0 74.0 74.0 70.0 75.0 70.0 69.0 71.0 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:10:51 INFO - 2015-12-08 05:10:51,524 DEBUG : BROWSER_OUTPUT: 05:10:52 INFO - 2015-12-08 05:10:52,434 INFO : Browser exited with error code: 0 05:10:52 INFO - 2015-12-08 05:10:52,486 INFO : Completed test kraken (00:01:02) 05:10:52 INFO - 2015-12-08 05:10:52,486 INFO : Starting test v8_7 05:10:52 INFO - 2015-12-08 05:10:52,487 DEBUG : operating with platform_type : linux_ 05:10:52 INFO - 2015-12-08 05:10:52,487 INFO : Initialising browser for v8_7 test... 05:10:52 INFO - 2015-12-08 05:10:52,493 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT3uQH/profile http://localhost:58687/getInfo.html 05:10:57 INFO - 2015-12-08 05:10:57,234 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:10:57 INFO - 2015-12-08 05:10:57,234 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:10:57 INFO - 2015-12-08 05:10:57,234 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:10:57 INFO - 2015-12-08 05:10:57,234 DEBUG : BROWSER_OUTPUT: __metrics 05:10:57 INFO - 2015-12-08 05:10:57,371 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:10:58 INFO - 2015-12-08 05:10:58,350 INFO : Browser initialized. 05:10:58 INFO - 2015-12-08 05:10:58,350 INFO : Running cycle 1/1 for v8_7 test... 05:10:58 INFO - 2015-12-08 05:10:58,351 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT3uQH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:10 INFO - 2015-12-08 05:11:10,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 143339520 05:11:10 INFO - 2015-12-08 05:11:10,421 DEBUG : BROWSER_OUTPUT: 05:11:31 INFO - 2015-12-08 05:11:31,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58687/tests/v8_7/run.html (next: http://localhost:58687/tests/v8_7/run.html) 05:11:32 INFO - 2015-12-08 05:11:32,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 05:11:32 INFO - 2015-12-08 05:11:32,128 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,128 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:11:32 INFO - 2015-12-08 05:11:32,128 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:11:32 INFO - 2015-12-08 05:11:32,128 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:11:32 INFO - 2015-12-08 05:11:32,128 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:11:32 INFO - 2015-12-08 05:11:32,128 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6451880072884 05:11:32 INFO - 2015-12-08 05:11:32,129 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.11662347278786 05:11:32 INFO - 2015-12-08 05:11:32,129 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 05:11:32 INFO - 2015-12-08 05:11:32,129 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 05:11:32 INFO - 2015-12-08 05:11:32,129 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1049.3179433368311 05:11:32 INFO - 2015-12-08 05:11:32,129 DEBUG : BROWSER_OUTPUT: |5;Earley;718.3908045977012 05:11:32 INFO - 2015-12-08 05:11:32,129 DEBUG : BROWSER_OUTPUT: |6;Boyer;12395.061728395061 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: |7;RegExp;26578.947368421053 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: |8;Splay;622.66500622665 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: __startTimestamp1449580292127__endTimestamp 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,130 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.65 Median:165.65 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: Values: 165.6 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.12 Median:185.12 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: Values: 185.1 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: Values: 278.8 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: Values: 5186.5 05:11:32 INFO - 2015-12-08 05:11:32,131 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1049.32 Median:1049.32 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: Values: 1049.3 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:718.39 Median:718.39 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: Values: 718.4 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: Values: 12395.1 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26578.95 Median:26578.95 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: Values: 26578.9 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,133 DEBUG : BROWSER_OUTPUT: Values: 622.7 05:11:32 INFO - 2015-12-08 05:11:32,134 DEBUG : BROWSER_OUTPUT: 05:11:32 INFO - 2015-12-08 05:11:32,134 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 05:11:32 INFO - 2015-12-08 05:11:32,134 DEBUG : BROWSER_OUTPUT: Values: 4850.2 05:11:32 INFO - 2015-12-08 05:11:32,134 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:11:32 INFO - 2015-12-08 05:11:32,134 DEBUG : BROWSER_OUTPUT: 05:11:33 INFO - 2015-12-08 05:11:33,030 INFO : Browser exited with error code: 0 05:11:33 INFO - 2015-12-08 05:11:33,044 INFO : Completed test v8_7 (00:00:40) 05:11:33 INFO - 2015-12-08 05:11:33,167 INFO : Completed test suite (00:20:16) 05:11:33 INFO - 2015-12-08 05:11:33,167 DEBUG : Working with test: dromaeo_css 05:11:33 INFO - 2015-12-08 05:11:33,167 DEBUG : Generating results file: dromaeo_css 05:11:33 INFO - 2015-12-08 05:11:33,168 DEBUG : Working with test: kraken 05:11:33 INFO - 2015-12-08 05:11:33,168 DEBUG : Generating results file: kraken 05:11:33 INFO - 2015-12-08 05:11:33,169 INFO : javascript benchmark 05:11:33 INFO - 2015-12-08 05:11:33,169 DEBUG : Working with test: v8_7 05:11:33 INFO - 2015-12-08 05:11:33,169 DEBUG : Generating results file: v8_7 05:11:33 INFO - 2015-12-08 05:11:33,169 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:33 INFO - 2015-12-08 05:11:33,303 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 05:11:33 INFO - 2015-12-08 05:11:33,304 DEBUG : process_Request line: dromaeo_css 6162.97 graph.html#tests=[[72,132,43]] 05:11:33 INFO - 2015-12-08 05:11:33,304 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:33 INFO - 2015-12-08 05:11:33,409 DEBUG : process_Request line: kraken 1559.10 graph.html#tests=[[232,132,43]] 05:11:33 INFO - 2015-12-08 05:11:33,409 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:11:33 INFO - 2015-12-08 05:11:33,519 DEBUG : process_Request line: v8_7 21249.34 graph.html#tests=[[230,132,43]] 05:11:33 INFO - 2015-12-08 05:11:33,520 INFO : javascript benchmark 05:11:33 INFO - 2015-12-08 05:11:33,522 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2681.7184195659456, 2710.905118320859, 2729.904453344132, 2743.547314693076, 2759.3929335546186, 4596.080783843228, 4702.15361234978, 4748.026654535821, 4754.049190161969, 4758.072175925691, 4602.1255961367315, 4643.628509719223, 4714.175019371613, 4727.409073865767, 4889.511048895118, 4330.956690433102, 4424.159409712144, 4474.172278128557, 4474.306482495218, 4479.148961697283, 117.7301822965133, 4348.97825510872, 4367.475902891658, 4378.824847006116, 4434.512203657611, 4393.692441529094, 4406.69153159279, 4410.360497727827, 4420.6242469390145, 4448.911021779562, 4210.052738133926, 4420.027593929331, 4444.266695995157, 4451.087527056978, 4485.641148708096, 4234.06850492891, 4315.719478233905, 4335.718178318431, 4408.0, 4410.933835992462, 4672.252439609646, 4678.391809064834, 4733.526647335273, 4739.573438390561, 4789.137955168068, 4826.8793280168275, 4987.725675087869, 5149.562287205592, 5155.974220128913, 5184.507471790174, 4929.950700493021, 5036.21938599514, 5043.672161309503, 5087.109755792759, 5170.482951704799, 4719.244920812654, 4768.094062128184, 4776.761161941889, 4778.37881075458, 4801.5438533339275, 4910.631702622318, 5034.823781167642, 5233.241180028875, 5251.448597897166, 5302.70835104073, 4943.209086546135, 4997.0505603935135, 5028.874278143003, 5032.220005899091, 5067.97466012675, 5131.2559678846355, 5168.0, 5175.611829112756, 5193.2989046479, 5221.399539053057, 4792.95207047932, 4920.212765957501, 4947.455779864212, 5114.616403769732, 5132.897342053138, 5027.346444962204, 5049.772760225798, 5062.265971434122, 5072.0, 5084.084864724385, 4239.51245606753, 4249.660027197817, 4261.232978063978, 4283.22901877665, 4285.61429471349, 3593.568771747407, 3667.3765459871884, 3698.7965661888857, 3721.8511259549855, 3731.1231860512758, 4354.586314300136, 4363.956360436355, 4374.540673229329, 4375.293635482164, 4419.359192917009, 5096.566791822736, 5125.4874512549195, 5126.897462050738, 5131.666441681279, 5176.559992400688, 4170.603792639695, 4225.19721252961, 4275.1663425631705, 4343.826246950087, 4387.627051700578, 4513.887152821206, 4516.683832131785, 4517.977410112929, 4524.909501809945, 4566.74882881438, 4770.737609431445, 4804.375431193923, 4822.71063736177, 4823.662343635911, 4861.416630004422, 4798.160321943716, 4905.77923993414, 4957.950420495749, 5053.29253904461, 5078.822241221539, 4808.495108013608, 4841.588464980516, 4847.0, 4852.417709874838, 4889.046635905964, 4738.644601654821, 5039.5968322534845, 5054.241863720471, 5060.418051924076, 5088.058709138673, 4962.106820772151, 5015.799368025238, 5065.924011139762, 5096.159133742891, 5151.613628977917, 4947.1589829729755, 4974.825881094289, 4985.152524070989, 4989.201727723692, 5046.268291097696, 4677.579017888406, 4788.976055119702, 4979.626528010342, 4985.4266759323145, 5032.798688052437, 4726.8109275628585, 4738.0, 4767.475577686521, 4810.63920205993, 4846.733429661403, 5000.5999520037585, 5004.899902002013, 5005.749712514433, 5009.4489606144025, 5010.69935803853, 4637.976810115928, 4709.458412282632, 4750.334953106637, 4925.088858561177, 4950.45544990058], "unit": "ms", "name": "dojo.html", "value": 4621.879362340426}, {"lowerIsBetter": false, "replicates": [526.9235960785686, 540.9891802163957, 542.452123355411, 546.6255614903789, 558.9133684278936, 32177.356452870958, 32885.67114328856, 32900.5064924026, 32904.83547582262, 33139.171520711934, 38718.22563548727, 39057.0, 39435.0, 39490.0, 39568.0, 7791.493552919056, 8005.079415867162, 8006.359491240687, 8008.919910800905, 8037.196280371974, 7766.06807183136, 7827.060752709683, 7884.487508311941, 7903.130655627876, 7910.288074073333, 7850.0, 7860.213978602152, 7952.4830885992515, 7970.561619110947, 7988.920110798876, 7836.882446763303, 7917.129115797286, 7928.6035698214855, 7949.0, 7956.801079973018, 7787.53274803508, 7883.881741773878, 7906.209379062106, 7917.36661067119, 7940.563269020202, 36847.26305473875, 37145.25709485822, 37228.44157337642, 37233.62766372356, 37421.43867841984, 2261.434641339665, 2721.1700431368427, 2843.1470558832266, 2893.8408387538675, 2959.7928145029855, 26089.869550652125, 26131.477370452674, 26183.34541636455, 26238.0, 26405.0, 3346.5147553604834, 3384.3569721752788, 3430.7255419566377, 3460.2214501737158, 3535.3636345457808, 211088.0, 213710.0, 214250.0, 215347.0, 215848.99999999843, 51342.0, 52371.73814130981, 54477.09706126468, 54519.72740136274, 62382.37617623856, 53848.73075634597, 54073.72963135159, 54336.45663543393, 54388.552515136915, 54533.72733136388, 12235.816462752888, 12248.326342051094, 12263.202891812181, 12318.199317044364, 12348.073894457952, 10501.107405870587, 10578.418186999788, 10608.310459820086, 10611.787764244671, 10649.148068154529, 19163.72665615087, 19380.127894244793, 19397.32109376165, 19458.513537161685, 19632.0, 7697.23027697237, 7893.22402459442, 7897.723579674684, 7926.326262267657, 7963.641636126388, 753.4349238071446, 906.2478143141177, 944.244604316544, 1032.055669062799, 1051.574112484445, 25306.873465632554, 25416.618750718753, 25810.612840807404, 26093.73906260951, 26254.212373628823, 873.7990262239721, 905.7780843693338, 918.9494577798285, 939.5349302095507, 1037.901399367059, 15943.123128227828, 16129.354825806837, 16326.428574999818, 16347.264373103239, 16532.173391330387, 306162.0, 310964.0, 315396.0, 316244.0, 317065.0, 47500.5249947503, 47958.76020619875, 48203.5179648206, 48210.5178948206, 48218.0, 1241.0940013789984, 1263.0527104671496, 1268.6701457621084, 1279.6672865054966, 1280.6542233596876, 27511.724882751718, 28176.577351340155, 28299.858500707363, 30429.695703042686, 30662.693373066875, 42389.36415953701, 43037.56962430335, 43263.56736432595, 43387.783061085756, 43417.56582434135, 247220.0, 249280.0, 249451.0, 249489.0, 249711.0, 38667.613323866404, 41919.7904010478, 41992.79003604963, 42155.789221053696, 42685.57314426816, 37092.62907371, 37720.43419348657, 37979.43030854484, 38453.0, 38587.6141238584, 32614.184645383106, 33393.83303083469, 33543.32913341768, 33560.66439335576, 33737.15657108592, 32136.83931580327, 32256.677433226305, 32296.35407291888, 32482.512762309056, 32540.18649533686, 32413.513797292588, 32931.83534082314, 33142.66857331396, 33348.0, 33460.330793384484, 28251.717482824908, 29733.10800675983, 29991.850040749658, 33943.0, 35135.47296790499, 22445.663315050613, 22454.550908982055, 22513.549729005656, 22573.792207143168, 22663.320100396355], "unit": "ms", "name": "ext.html", "value": 17048.75994323098}, {"lowerIsBetter": false, "replicates": [279.1819967495238, 281.73798367518214, 282.1155676952753, 283.1618409507857, 288.0494368583674, 12958.222506649585, 12984.870151298484, 14825.406983720652, 15291.847081529182, 15296.388144474235, 9189.310801689866, 9197.0802919708, 10700.571977120926, 13375.665608359795, 13668.453261869538, 4498.347739577751, 4605.884852878688, 4610.561996610317, 4612.97693511532, 4614.584687378136, 3350.8827191048317, 4507.57178068083, 5096.082705113078, 5232.476752324776, 5242.056429842627, 5197.558207552363, 5228.92156617651, 5229.8954020919555, 5237.764300606463, 5254.975279820436, 5040.949590504085, 5224.686518808883, 5227.111391063529, 5230.869228269324, 5247.0, 5073.0, 5109.846704598868, 5128.461511541272, 5129.384473863161, 5136.768845401966, 12579.874201258053, 17690.646187076316, 18102.4569262921, 18204.544886377815, 18337.0, 1699.4391850689367, 1734.6617409605133, 1744.6336269383444, 1785.446511581414, 1790.436012656009, 8669.566521673954, 8777.42946708462, 10294.845577316271, 11588.594399196072, 12391.318477483735, 1711.5464401933498, 1733.367320927865, 1781.0649409060218, 1784.3933062758595, 1822.7994920558729, 52862.47137528614, 54394.184087238726, 54641.453585464034, 55252.723736381464, 55942.160867587016, 9331.113544213289, 9554.952225238969, 9735.075167859042, 9739.56171972263, 9781.559829807677, 11941.880581194251, 11997.700057498632, 12026.699332516582, 12051.698707532207, 12076.51693932233, 6678.4991125665765, 6741.764038258638, 6753.763618273337, 6764.188297404343, 6813.318668133147, 6437.227532696106, 6437.806865794034, 6478.416942475105, 6483.3516648335735, 6484.546081774325, 4048.7975601219823, 4059.2287465382074, 4072.185562887375, 4104.384342348671, 4126.071633882352, 1627.8209396966324, 1678.4628918745884, 1692.8391802778717, 1712.3236321653126, 1715.296728341374, 350.46728971962983, 354.97160227181763, 356.21810126771487, 826.946248493858, 863.0592654007037, 9240.168384845396, 9348.252139828797, 9497.620095196253, 9570.33007689469, 9635.019012545275, 354.63472623198146, 359.0986623574846, 359.2294528236917, 368.41789971844423, 380.90858194033785, 4761.833335833298, 5330.280412144389, 5373.785048598091, 5453.263809385682, 5469.453054694578, 466152.0, 476504.0, 482439.0, 495905.0, 496806.0, 69761.0, 71191.28808711951, 73282.0, 73812.52374952471, 74328.25671743322, 394.8677193140273, 395.3378091696397, 395.43057996485544, 396.6331143692073, 397.8130278768974, 8620.61207245663, 9002.684906028258, 9002.954985225031, 13759.862401376258, 14256.42974281017, 30011.549826753053, 30121.84939075378, 31049.379012419173, 31527.36945261036, 31813.5227971576, 36161.81919090493, 40936.59063409447, 41483.37774933439, 41521.584784151775, 49556.0, 8364.0, 8740.34447416459, 8746.256568191775, 8794.032656407662, 8877.467351958903, 12324.630261092181, 12489.750204995667, 16117.355305788105, 16420.42528511544, 16611.91694041522, 12536.247825130156, 12835.614931552069, 12979.026573006873, 13035.934820325838, 13212.339383031001, 12483.93758031204, 12877.977951597137, 12915.741685166431, 13310.933445332712, 13574.79637805414, 12335.0, 12680.873191268338, 12828.807567886675, 12902.96776257916, 13497.392617332047, 7962.442629015914, 8269.586520674062, 8310.418270720991, 8352.540610266493, 8890.688825891062, 12372.56142203264, 12471.750564988832, 12625.431855566338, 12903.290319032543, 12977.416016279101], "unit": "ms", "name": "jquery.html", "value": 7222.738299665932}, {"lowerIsBetter": false, "replicates": [1506.397441023591, 1633.6242664187237, 1651.5953591370117, 1688.9662206755866, 1717.227247738518, 5919.141724449953, 5988.820335389934, 7063.223045465001, 7166.749163779269, 7201.31587499188, 6477.902831457532, 6660.0, 6687.69905354259, 6687.69905354259, 6716.529842910998, 2022.342738609954, 2052.3945436096387, 2062.360668192865, 2066.349100033492, 2069.5860827834417, 2051.6101940631233, 2087.405089549479, 2088.4361222469925, 2101.1070295124587, 2119.79861913118, 1957.6084783043377, 2024.129624261567, 2047.2220556188627, 2048.9077991490344, 2058.9588208235828, 2025.0684685044896, 2051.8974051297523, 2054.0243384392443, 2056.8354531637433, 2057.6913462980524, 2035.2266138867283, 2046.2531176120758, 2056.228914157191, 2061.0416156487154, 2079.7088407622796, 7069.151701795766, 7134.892976605355, 7206.387457066156, 7208.279172082802, 7219.808731559287, 4103.4870641169855, 4181.0592616661315, 4193.874183774492, 4197.706160568731, 4199.2441360555085, 2716.076533978437, 2765.834049957009, 2779.374640705845, 2790.2187387531526, 2805.2145399288233, 842.9199226073574, 846.4413487098547, 850.4684572142411, 851.221132663612, 870.6734974384606, 9519.524023798782, 9521.761955951088, 9566.760830979212, 9576.281778866543, 9625.71122866315, 3756.73702840804, 3799.8100094995693, 3843.7693738375788, 3857.633524815138, 3872.5546562145714, 8139.348852091818, 8151.266386025286, 8171.387145964077, 8188.058373287148, 8205.0, 4151.12826306473, 4157.10622216225, 4175.352820312856, 4187.099773548702, 4194.035371864488, 3155.353152603711, 3217.951730724041, 3658.689011434058, 3766.2655782122224, 3776.169242766587, 3348.983255083709, 3386.0857568456377, 3401.5407919930494, 3418.6068602110577, 3423.9828800856335, 1046.6807623674852, 1060.0777323728405, 1060.5545670818274, 1062.9627963021258, 1074.9408782517037, 785.2265518464308, 849.1635738797403, 1165.9883401166048, 1174.7063234191453, 1180.138498895811, 6320.778772743024, 6360.618362898241, 6365.8859699552395, 6367.108604795332, 6368.140301059298, 1006.7080546641392, 1016.339379403379, 1024.2420608749471, 1032.9173666106694, 1041.6822869024868, 5046.34397528319, 5050.3434553507805, 5078.289039534468, 5084.3644544431945, 5098.46466121052, 8233.79415514605, 8324.500529968222, 8396.370272229608, 8426.957865210634, 8602.139786021347, 8254.628541715638, 8320.8335833283, 8387.790305242417, 8396.412251142483, 8536.44513106646, 6533.673316334164, 6533.673316334164, 6674.0, 6720.798376048726, 6729.831754206184, 6363.809085727436, 6367.172267605181, 6384.0, 6388.041793730978, 6407.038944158414, 7377.815554610963, 7526.360259378014, 7564.924350756422, 7595.886061708969, 7651.196624354363, 7724.227577242231, 7756.0, 7782.0, 7805.14143444232, 7905.604719763874, 5093.0, 5233.764480598306, 5734.311882573951, 5930.822075337746, 5961.791337303347, 6479.773207937699, 6498.480121590356, 6518.315576864551, 6551.050097735706, 6570.080188773671, 6118.20463339763, 6160.568760186744, 6265.0, 6272.2159730033745, 6281.811545653638, 6023.909641355471, 6253.499720022478, 6257.499400047895, 6342.619442833445, 6348.968255158695, 5930.169776231245, 5958.195643588234, 5961.046232602763, 5962.867055259487, 5988.970055149696, 5686.175504551899, 5706.258186435737, 5718.3423906249645, 5719.113537401709, 5733.885322293614, 5684.317881854204, 5812.709364531841, 5841.4450627190345, 5848.53211743051, 5904.261967254093], "unit": "ms", "name": "mootools.html", "value": 4006.274102263607}, {"lowerIsBetter": false, "replicates": [257.28603126324447, 259.39560823281755, 262.2264320255246, 262.76220020881107, 264.1586546848288, 5425.728713564321, 5477.315335583052, 5538.335399752031, 5549.139883318082, 5626.184203290521, 5395.568354531638, 5481.862953426166, 5518.33779946406, 5525.4474552544725, 5564.248826408434, 4181.64456021237, 4190.9580904191025, 4194.0563373241, 4197.4753155855515, 4217.304144816102, 4202.0, 4204.5585213552595, 4211.199872024321, 4213.536510983789, 4221.936670949938, 3955.4462375267485, 4058.8782336529803, 4168.936921085119, 4180.498340199165, 4181.414601955728, 4045.6763458923365, 4047.959520404788, 4049.1091959768805, 4054.108096218827, 4095.9385609215888, 3470.687638112582, 3472.791632502058, 3480.286541259036, 3480.3735327641016, 3484.9825750871337, 5351.411344752074, 5366.034113859504, 5368.033753924292, 5372.623916325859, 5375.489328513824, 4569.611583015448, 4695.7886895089805, 4699.600533954618, 4699.647526435531, 4702.388689470347, 5639.774409023634, 5750.539956803445, 5807.709614519257, 5811.0, 5824.417558244184, 3745.8501659933568, 3767.981160094182, 3769.754965927206, 3777.867774627875, 3782.867599634, 6039.698015099228, 6147.969260153715, 6148.631082135086, 6148.754049838001, 6150.323464418911, 3811.8284677189595, 3888.1640447303967, 3893.182431689377, 3903.5706072332023, 3906.7265291429894, 3952.4071389291835, 3953.9802300988313, 3954.7429417087797, 3956.8812935611977, 3957.5250969883223, 4675.509071547506, 4680.695754775928, 4689.343491911135, 4689.742064186435, 4691.53084691535, 5834.095715164156, 5848.61983971049, 5860.150278209636, 5867.413258674099, 5874.295084589877, 1353.5127354152498, 1388.4515616331491, 1398.454602704946, 1398.6083896508994, 1402.0956483068364, 894.3962825093037, 916.3631276262934, 927.8144371125667, 950.1875896108866, 961.783598690303, 4963.602911767122, 4967.577755890789, 4974.104661160954, 4976.576990955809, 4978.377702787152, 6005.189299444606, 6016.398360163948, 6033.456988871023, 6051.546134039964, 6065.5450841187085, 5003.524665156877, 5025.045241404122, 5035.7985680572365, 5046.823361182414, 5047.116754567936, 3195.2171717929255, 3203.935921281608, 3233.3694929488524, 3266.738660907122, 3303.636599974001, 5646.463585959327, 5715.9997000524745, 5782.653040817564, 5783.88432231353, 5801.767929282782, 6292.811215663446, 6336.112944187817, 6342.778002769973, 6345.270293916259, 6356.77751278703, 5664.291963504562, 5784.913226301609, 5789.6526208426785, 5794.304683438015, 5803.332616749043, 6158.692065396623, 6160.199174107337, 6165.722542485689, 6168.784092556739, 6173.259208894961, 5989.490893274121, 6004.459598635969, 6007.879842403215, 6014.789482368096, 6032.849178770566, 5752.568557358131, 5761.0, 5765.913511297418, 5768.394318596487, 5786.884262314814, 3754.4556039374684, 3841.635044670752, 3887.261420330128, 3888.902777430587, 3902.200048990007, 6021.397860213943, 6056.333803281724, 6074.0, 6077.756889724362, 6087.269527656709, 5824.912626310694, 5845.795397161079, 5849.824505264849, 5868.706564671664, 5877.118432235199, 5717.828465146053, 5850.9175802476675, 5854.209681693087, 5858.297004359334, 5860.619059761102, 5733.942660573341, 5735.483806457439, 5736.483716465371, 5743.942560574341, 5756.0, 5877.206577112035, 5879.882402352015, 5884.882302354014, 5889.440503152194, 5891.970540147272, 5601.943980560142, 5749.338826034892, 5749.511291540266, 5754.813170994995, 5761.193432919478], "unit": "ms", "name": "prototype.html", "value": 4271.301992569868}, {"lowerIsBetter": false, "replicates": [611.6758118197356, 631.8262477818596, 719.7984564321988, 788.4953629677008, 791.2680770287486, 11331.320120792749, 11534.134939879512, 11656.941715291432, 11668.47491862866, 11697.532098716063, 13071.0, 13326.333683315845, 13350.1989880607, 13360.933195334033, 13368.465261389558, 783.0759703549809, 788.6214616983851, 793.1513280789528, 794.9602519874012, 799.9880001799978, 793.1552896165565, 797.4378063465272, 797.972070977516, 800.3917023062485, 802.3781569283823, 815.6451943404609, 822.5147163173726, 825.694493037577, 825.859603867344, 825.9174082591753, 809.4900212865887, 812.2080971053235, 812.7683610171102, 814.6049166154411, 814.6578437056421, 602.6534742523023, 603.9516838652897, 605.7758629307141, 609.0225188572322, 611.0284647410639, 11924.22492537991, 11986.880131198664, 11994.220375675553, 12005.159638825286, 12060.698482537919, 10662.147028237723, 10959.232853700245, 11047.558097676083, 11080.168987325902, 11285.661430157108, 8772.736817895473, 9213.0, 9377.578008989612, 9595.952020239854, 9666.226701863905, 3029.72732454078, 3077.199928018731, 3078.0919628709585, 3119.407312610597, 3135.822429813264, 39947.40078898819, 40599.59400406017, 40725.59274407248, 40886.1822763546, 41073.794631026954, 8541.86227898911, 8591.0, 8694.30445564366, 8729.956350218208, 8884.200421961925, 15783.210839457981, 15971.281292341873, 15976.281067351996, 15981.12103834277, 15994.600134996717, 5877.676727779927, 5913.467787899023, 6006.489448396847, 6058.27300723916, 6115.785947491817, 3596.496490491333, 3621.257642183346, 3675.3568125577917, 3696.075981004749, 3716.0338312039066, 2560.06557606476, 2580.4065065035147, 2601.8829152688177, 2606.153000274918, 2607.5697509911033, 445.20753059553397, 450.6552487347182, 451.14282862561396, 452.9456465224194, 459.37983721975064, 481.30211193769173, 593.0984902947496, 597.2593983460478, 601.4526780629606, 610.4627927423838, 7215.819604509824, 7240.601766902871, 7458.393668299882, 7511.474196806281, 7578.204288549733, 514.1003244322436, 552.4227182594118, 613.4172536090732, 616.1466369078857, 636.4462917262011, 3561.679448849616, 3585.8744943926836, 3645.052286405554, 3873.825677844504, 3904.9609503905167, 45440.77279613581, 46820.5317946823, 47221.527784721715, 47541.5245847544, 47822.28266576004, 43539.346909796375, 43881.56118438839, 44292.778536107755, 44316.778416107714, 44496.55503444989, 38407.80796096002, 39091.0, 39331.6066839328, 39507.40738888976, 39508.20983580312, 7458.888116678146, 7574.204708505527, 7599.696012159673, 7645.617719114133, 7698.153203147761, 29065.709342907146, 29663.0, 30161.396772064876, 30281.091567253017, 30474.84762576173, 36289.63710362863, 37128.44307335338, 37767.62232377641, 37806.24387512289, 37819.62180378161, 9905.306628535933, 10184.592616295266, 10223.744406389602, 10229.43738094412, 10337.793244135226, 11337.138542396458, 11415.200935934405, 11553.364564949008, 11643.184977051525, 12122.757544848877, 10003.499825008575, 10372.585096596353, 10544.525496352837, 10909.18181136402, 11228.606998755004, 10294.536745846304, 10322.2258330624, 10414.189357981513, 10422.166226701996, 10688.25182237236, 9301.395409298373, 9481.146696797321, 9482.620695172116, 9553.90446095558, 9653.0, 8975.461472311683, 9052.64617334804, 9087.227585655293, 9181.678641247792, 9211.539423028687, 8977.91022089797, 8986.640534378814, 8998.370114092213, 9011.369204155646, 9109.407888487227], "unit": "ms", "name": "yui.html", "value": 5625.789103101143}], "name": "dromaeo_css", "value": 6162.973231431421}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 117.0, 114.0, 116.0, 124.0, 120.0, 112.0, 114.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [158.0, 133.0, 151.0, 169.0, 136.0, 154.0, 155.0, 140.0, 166.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [164.0, 167.0, 163.0, 162.0, 162.0, 165.0, 166.0, 164.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 72.0, 148.0, 72.0, 78.0, 72.0, 72.0, 143.0], "unit": "ms", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 127.0, 94.0, 96.0, 95.0, 136.0, 95.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 149.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [83.0, 74.0, 75.0, 76.0, 75.0, 75.0, 76.0, 74.0, 75.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 75.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 86.0, 86.0, 85.0, 86.0, 86.0, 85.0, 97.0, 102.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 137.0, 125.0, 134.0, 143.0, 128.0, 128.0, 122.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.3}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 159.0, 146.0, 155.0, 136.0, 148.0, 145.0, 149.0, 149.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 72.0, 74.0, 74.0, 70.0, 75.0, 70.0, 69.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1559.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6451880072884], "unit": "score", "name": "Richards", "value": 213.11817399999993}, {"lowerIsBetter": false, "replicates": [185.11662347278786], "unit": "score", "name": "DeltaBlue", "value": 357.16943599999996}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1049.3179433368311], "unit": "score", "name": "RayTrace", "value": 705.2095169999998}, {"lowerIsBetter": false, "replicates": [718.3908045977012], "unit": "score", "name": "Earley", "value": 927.7164960000002}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [26578.947368421053], "unit": "score", "name": "RegExp", "value": 34.27468316831682}, {"lowerIsBetter": false, "replicates": [622.66500622665], "unit": "score", "name": "Splay", "value": 130.874546}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21249.34214482195}]} 05:11:33 INFO - RETURN: dromaeo_css: 6162.97 05:11:33 INFO - RETURN: kraken: 1559.10 05:11:33 INFO - RETURN: v8_7: 21249.34 05:11:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21249.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1559.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6162.97"}}} 05:11:33 INFO - Return code: 0 05:11:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:11:33 INFO - # TBPL SUCCESS # 05:11:33 INFO - Running post-action listener: _resource_record_post_action 05:11:33 INFO - Running post-run listener: _resource_record_post_run 05:11:34 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505499648; Read time: 16; Write time: 443552 05:11:34 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231948288; Read time: 0; Write time: 286296 05:11:34 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273551360; Read time: 16; Write time: 157256 05:11:34 INFO - Running post-run listener: _upload_blobber_files 05:11:34 INFO - Blob upload gear active. 05:11:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:11:34 INFO - Copying logs to upload dir... 05:11:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.673873 ========= master_lag: 12.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-12-08 05:11:46.353576) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 05:11:46.356715) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010094 build_url: 'https://queue.taskcluster.net/v1/task/n2t9IDFvQMS5sSCmokpckQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.12 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 05:11:46.491447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 05:11:46.491764) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449574240.325756-1978318908 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 1.65 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 05:11:48.141395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 05:11:48.141710) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 05:11:48.145357) ========= ========= Total master_lag: 14.80 =========