builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1464553098.89 results: success (0) buildid: 20160528004338 builduid: 51916248861840cc96bd23b7b83fbcb9 revision: 2e2c3435f648e36080c49c46416b710e0b52d55a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:18.894729) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:18.895219) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:18.895554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:18.910253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:18.910583) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 13:18:19-- 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% 33.4M=0s 2016-05-29 13:18:19 (33.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101742 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.027023) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.027343) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019205 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.076531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.076887) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e2c3435f648e36080c49c46416b710e0b52d55a --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 2e2c3435f648e36080c49c46416b710e0b52d55a --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=337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 13:18:19,204 truncating revision to first 12 chars 2016-05-29 13:18:19,204 Setting DEBUG logging. 2016-05-29 13:18:19,204 attempt 1/10 2016-05-29 13:18:19,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e2c3435f648?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 13:18:19,687 unpacking tar archive at: fx-team-2e2c3435f648/testing/mozharness/ program finished with exit code 0 elapsedTime=0.796153 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.886597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.886934) ========= script_repo_revision: 2e2c3435f648e36080c49c46416b710e0b52d55a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.887337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.887631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 13:18:19.900931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-29 13:18:19.901306) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--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=337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:18:20 INFO - MultiFileLogger online at 20160529 13:18:20 in /builds/slave/test 13:18:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:18:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:18:20 INFO - {'append_to_log': False, 13:18:20 INFO - 'base_work_dir': '/builds/slave/test', 13:18:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:18:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:18:20 INFO - 'branch': 'Fx-Team-Non-PGO', 13:18:20 INFO - 'buildbot_json_path': 'buildprops.json', 13:18:20 INFO - 'config_files': ('talos/linux_config.py',), 13:18:20 INFO - 'default_actions': ('clobber', 13:18:20 INFO - 'read-buildbot-config', 13:18:20 INFO - 'download-and-extract', 13:18:20 INFO - 'populate-webroot', 13:18:20 INFO - 'create-virtualenv', 13:18:20 INFO - 'install', 13:18:20 INFO - 'run-tests'), 13:18:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:18:20 INFO - 'download_minidump_stackwalk': True, 13:18:20 INFO - 'download_symbols': 'ondemand', 13:18:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:18:20 INFO - 'tooltool.py': '/tools/tooltool.py', 13:18:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:18:20 INFO - '/tools/misc-python/virtualenv.py')}, 13:18:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:18:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:18:20 INFO - 'installer_path': 'installer.exe', 13:18:20 INFO - 'log_level': 'info', 13:18:20 INFO - 'log_name': 'talos', 13:18:20 INFO - 'log_to_console': True, 13:18:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:18:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:18:20 INFO - 'opt_config_files': (), 13:18:20 INFO - 'pip_index': False, 13:18:20 INFO - 'sps_profile': False, 13:18:20 INFO - 'sps_profile_interval': 0, 13:18:20 INFO - 'suite': 'dromaeojs', 13:18:20 INFO - 'system_bits': '32', 13:18:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:18:20 INFO - 'title': 'talos-linux64-ix-060', 13:18:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:18:20 INFO - 'use_talos_json': True, 13:18:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:18:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:18:20 INFO - 'work_dir': 'build'} 13:18:20 INFO - ##### 13:18:20 INFO - ##### Running clobber step. 13:18:20 INFO - ##### 13:18:20 INFO - Running pre-action listener: _resource_record_pre_action 13:18:20 INFO - Running main action method: clobber 13:18:20 INFO - rmtree: /builds/slave/test/build 13:18:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:18:20 INFO - Running post-action listener: _resource_record_post_action 13:18:20 INFO - ##### 13:18:20 INFO - ##### Finished clobber step (success) 13:18:20 INFO - ##### 13:18:20 INFO - ##### 13:18:20 INFO - ##### Running read-buildbot-config step. 13:18:20 INFO - ##### 13:18:20 INFO - Running pre-action listener: _resource_record_pre_action 13:18:20 INFO - Running main action method: read_buildbot_config 13:18:20 INFO - Using buildbot properties: 13:18:20 INFO - { 13:18:20 INFO - "project": "", 13:18:20 INFO - "product": "firefox", 13:18:20 INFO - "script_repo_revision": "production", 13:18:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:18:20 INFO - "repository": "", 13:18:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:18:20 INFO - "buildid": "20160528004338", 13:18:20 INFO - "pgo_build": "False", 13:18:20 INFO - "basedir": "/builds/slave/test", 13:18:20 INFO - "buildnumber": 1798, 13:18:20 INFO - "slavename": "talos-linux64-ix-060", 13:18:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:18:20 INFO - "platform": "ubuntu64_hw", 13:18:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:18:20 INFO - "branch": "fx-team", 13:18:20 INFO - "repo_path": "integration/fx-team", 13:18:20 INFO - "revision": "2e2c3435f648e36080c49c46416b710e0b52d55a", 13:18:20 INFO - "stage_platform": "linux64", 13:18:20 INFO - "builduid": "51916248861840cc96bd23b7b83fbcb9", 13:18:20 INFO - "slavebuilddir": "test" 13:18:20 INFO - } 13:18:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:18:20 INFO - Running post-action listener: _resource_record_post_action 13:18:20 INFO - ##### 13:18:20 INFO - ##### Finished read-buildbot-config step (success) 13:18:20 INFO - ##### 13:18:20 INFO - ##### 13:18:20 INFO - ##### Running download-and-extract step. 13:18:20 INFO - ##### 13:18:20 INFO - Running pre-action listener: _resource_record_pre_action 13:18:20 INFO - Running main action method: download_and_extract 13:18:20 INFO - mkdir: /builds/slave/test/build/tests 13:18:20 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')]} 13:18:20 INFO - https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:18:21 INFO - Downloaded 1361 bytes. 13:18:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:18:21 INFO - Using the following test package requirements: 13:18:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:18:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:18:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:18:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'jsshell-linux-x86_64.zip'], 13:18:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:18:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:18:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:18:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:18:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:18:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:18:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:18: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')]} 13:18:21 INFO - https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:18:22 INFO - Downloaded 22837934 bytes. 13:18:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:18:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:18:24 INFO - Return code: 0 13:18:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:24 INFO - https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:18:26 INFO - Downloaded 22837934 bytes. 13:18:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:18:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:18:28 INFO - Return code: 0 13:18:28 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')]} 13:18:28 INFO - https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:18:29 INFO - Downloaded 10834034 bytes. 13:18:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:18:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:18:29 INFO - Return code: 0 13:18:29 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')]} 13:18:29 INFO - https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:18:31 INFO - Downloaded 54849400 bytes. 13:18:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:18:31 INFO - mkdir: /builds/slave/test/properties 13:18:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:31 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:31 INFO - Contents: 13:18:31 INFO - build_url:https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:18:32 INFO - Running post-action listener: _resource_record_post_action 13:18:32 INFO - Running post-action listener: set_extra_try_arguments 13:18:32 INFO - ##### 13:18:32 INFO - ##### Finished download-and-extract step (success) 13:18:32 INFO - ##### 13:18:32 INFO - ##### 13:18:32 INFO - ##### Running populate-webroot step. 13:18:32 INFO - ##### 13:18:32 INFO - Running pre-action listener: _resource_record_pre_action 13:18:32 INFO - Running main action method: populate_webroot 13:18:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:18:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:18:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:18:32 INFO - '--tppagecycles', 13:18:32 INFO - '7'], 13:18:32 INFO - 'tests': ['tsvgm']}}, 13:18:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:18:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:18:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:18:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:18:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['damp', 'tps']}, 13:18:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'tests': ['damp', 'tps']}, 13:18:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['dromaeo_dom']}, 13:18:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['a11yr', 13:18:32 INFO - 'ts_paint', 13:18:32 INFO - 'tpaint', 13:18:32 INFO - 'sessionrestore', 13:18:32 INFO - 'sessionrestore_no_auto_restore', 13:18:32 INFO - 'tabpaint']}, 13:18:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:18:32 INFO - 'ts_paint', 13:18:32 INFO - 'tpaint', 13:18:32 INFO - 'sessionrestore', 13:18:32 INFO - 'sessionrestore_no_auto_restore', 13:18:32 INFO - 'tabpaint']}, 13:18:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:18:32 INFO - 'ts_paint', 13:18:32 INFO - 'tpaint', 13:18:32 INFO - 'sessionrestore', 13:18:32 INFO - 'sessionrestore_no_auto_restore', 13:18:32 INFO - 'tabpaint']}, 13:18:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:18:32 INFO - 'ts_paint', 13:18:32 INFO - 'tpaint', 13:18:32 INFO - 'sessionrestore', 13:18:32 INFO - 'sessionrestore_no_auto_restore', 13:18:32 INFO - 'tabpaint']}, 13:18:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['a11yr', 13:18:32 INFO - 'ts_paint', 13:18:32 INFO - 'tpaint', 13:18:32 INFO - 'sessionrestore', 13:18:32 INFO - 'sessionrestore_no_auto_restore', 13:18:32 INFO - 'tabpaint']}, 13:18:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['a11yr', 13:18:32 INFO - 'ts_paint', 13:18:32 INFO - 'tpaint', 13:18:32 INFO - 'sessionrestore', 13:18:32 INFO - 'sessionrestore_no_auto_restore', 13:18:32 INFO - 'tabpaint']}, 13:18:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['tsvgx', 13:18:32 INFO - 'tsvgr_opacity', 13:18:32 INFO - 'tart', 13:18:32 INFO - 'tscrollx', 13:18:32 INFO - 'cart']}, 13:18:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:18:32 INFO - 'tsvgr_opacity', 13:18:32 INFO - 'tart', 13:18:32 INFO - 'tscrollx', 13:18:32 INFO - 'cart']}, 13:18:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'talos_options': ['--disable-e10s'], 13:18:32 INFO - 'tests': ['tp5o']}, 13:18:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'tests': ['tp5o']}, 13:18:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'talos_options': ['--disable-e10s', 13:18:32 INFO - '--xperf_path', 13:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:32 INFO - 'tests': ['tp5n']}, 13:18:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:32 INFO - 'talos_options': ['--xperf_path', 13:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:32 INFO - 'tests': ['tp5n']}}, 13:18:32 INFO - 'talos.zip': {'path': '', 13:18:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:18:32 INFO - Running post-action listener: _resource_record_post_action 13:18:32 INFO - ##### 13:18:32 INFO - ##### Finished populate-webroot step (success) 13:18:32 INFO - ##### 13:18:32 INFO - ##### 13:18:32 INFO - ##### Running create-virtualenv step. 13:18:32 INFO - ##### 13:18:32 INFO - Running pre-action listener: _resource_record_pre_action 13:18:32 INFO - Running main action method: create_virtualenv 13:18:32 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:32 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 13:18:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:18:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:32 INFO - Using real prefix '/usr' 13:18:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:18:35 INFO - Installing pip.................done. 13:18:35 INFO - Return code: 0 13:18:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:18:35 INFO - Using env: {'DISPLAY': ':0', 13:18:35 INFO - 'HOME': '/home/cltbld', 13:18:35 INFO - 'LANG': 'en_US.UTF-8', 13:18:35 INFO - 'LANGUAGE': 'en_US:en', 13:18:35 INFO - 'LOGNAME': 'cltbld', 13:18:35 INFO - 'MAIL': '/var/mail/cltbld', 13:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:35 INFO - 'MOZ_NO_REMOTE': '1', 13:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:35 INFO - 'NO_EM_RESTART': '1', 13:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:35 INFO - 'PWD': '/builds/slave/test', 13:18:35 INFO - 'SHELL': '/bin/bash', 13:18:35 INFO - 'SHLVL': '1', 13:18:35 INFO - 'TERM': 'linux', 13:18:35 INFO - 'TMOUT': '86400', 13:18:35 INFO - 'USER': 'cltbld', 13:18:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:35 INFO - '_': '/tools/buildbot/bin/python'} 13:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:36 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 13:18:36 INFO - Cleaning up... 13:18:36 INFO - Return code: 0 13:18:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 13:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 13:18:36 INFO - Using env: {'DISPLAY': ':0', 13:18:36 INFO - 'HOME': '/home/cltbld', 13:18:36 INFO - 'LANG': 'en_US.UTF-8', 13:18:36 INFO - 'LANGUAGE': 'en_US:en', 13:18:36 INFO - 'LOGNAME': 'cltbld', 13:18:36 INFO - 'MAIL': '/var/mail/cltbld', 13:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:36 INFO - 'MOZ_NO_REMOTE': '1', 13:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:36 INFO - 'NO_EM_RESTART': '1', 13:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:36 INFO - 'PWD': '/builds/slave/test', 13:18:36 INFO - 'SHELL': '/bin/bash', 13:18:36 INFO - 'SHLVL': '1', 13:18:36 INFO - 'TERM': 'linux', 13:18:36 INFO - 'TMOUT': '86400', 13:18:36 INFO - 'USER': 'cltbld', 13:18:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:36 INFO - '_': '/tools/buildbot/bin/python'} 13:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:36 INFO - Downloading/unpacking psutil>=3.1.1 13:18:36 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 13:18:36 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 13:18:36 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 13:18:36 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 13:18:36 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 13:18:36 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 13:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:38 INFO - Installing collected packages: psutil 13:18:38 INFO - Running setup.py install for psutil 13:18:38 INFO - building 'psutil._psutil_linux' extension 13:18:38 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 13:18:38 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 13:18:38 INFO - building 'psutil._psutil_posix' extension 13:18:38 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 13:18:38 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 13:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:38 INFO - Successfully installed psutil 13:18:38 INFO - Cleaning up... 13:18:38 INFO - Return code: 0 13:18:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 13:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 13:18:38 INFO - Using env: {'DISPLAY': ':0', 13:18:38 INFO - 'HOME': '/home/cltbld', 13:18:38 INFO - 'LANG': 'en_US.UTF-8', 13:18:38 INFO - 'LANGUAGE': 'en_US:en', 13:18:38 INFO - 'LOGNAME': 'cltbld', 13:18:38 INFO - 'MAIL': '/var/mail/cltbld', 13:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:38 INFO - 'MOZ_NO_REMOTE': '1', 13:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:38 INFO - 'NO_EM_RESTART': '1', 13:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:38 INFO - 'PWD': '/builds/slave/test', 13:18:38 INFO - 'SHELL': '/bin/bash', 13:18:38 INFO - 'SHLVL': '1', 13:18:38 INFO - 'TERM': 'linux', 13:18:38 INFO - 'TMOUT': '86400', 13:18:38 INFO - 'USER': 'cltbld', 13:18:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:38 INFO - '_': '/tools/buildbot/bin/python'} 13:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:18:39 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 13:18:39 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 13:18:39 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 13:18:39 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 13:18:39 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 13:18:39 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 13:18:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:18:41 INFO - Installing collected packages: mozsystemmonitor 13:18:41 INFO - Running setup.py install for mozsystemmonitor 13:18:41 INFO - Successfully installed mozsystemmonitor 13:18:41 INFO - Cleaning up... 13:18:41 INFO - Return code: 0 13:18:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:18:41 INFO - Using env: {'DISPLAY': ':0', 13:18:41 INFO - 'HOME': '/home/cltbld', 13:18:41 INFO - 'LANG': 'en_US.UTF-8', 13:18:41 INFO - 'LANGUAGE': 'en_US:en', 13:18:41 INFO - 'LOGNAME': 'cltbld', 13:18:41 INFO - 'MAIL': '/var/mail/cltbld', 13:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:41 INFO - 'MOZ_NO_REMOTE': '1', 13:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:41 INFO - 'NO_EM_RESTART': '1', 13:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:41 INFO - 'PWD': '/builds/slave/test', 13:18:41 INFO - 'SHELL': '/bin/bash', 13:18:41 INFO - 'SHLVL': '1', 13:18:41 INFO - 'TERM': 'linux', 13:18:41 INFO - 'TMOUT': '86400', 13:18:41 INFO - 'USER': 'cltbld', 13:18:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:41 INFO - '_': '/tools/buildbot/bin/python'} 13:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:18:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:18:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:44 INFO - Downloading docopt-0.6.1.tar.gz 13:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:18:44 INFO - Installing collected packages: blobuploader, requests, docopt 13:18:44 INFO - Running setup.py install for blobuploader 13:18:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:18:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:18:44 INFO - Running setup.py install for requests 13:18:44 INFO - Running setup.py install for docopt 13:18:44 INFO - Successfully installed blobuploader requests docopt 13:18:44 INFO - Cleaning up... 13:18:44 INFO - Return code: 0 13:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 13:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 13:18:44 INFO - Using env: {'DISPLAY': ':0', 13:18:44 INFO - 'HOME': '/home/cltbld', 13:18:44 INFO - 'LANG': 'en_US.UTF-8', 13:18:44 INFO - 'LANGUAGE': 'en_US:en', 13:18:44 INFO - 'LOGNAME': 'cltbld', 13:18:44 INFO - 'MAIL': '/var/mail/cltbld', 13:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:44 INFO - 'MOZ_NO_REMOTE': '1', 13:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:44 INFO - 'NO_EM_RESTART': '1', 13:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:44 INFO - 'PWD': '/builds/slave/test', 13:18:44 INFO - 'SHELL': '/bin/bash', 13:18:44 INFO - 'SHLVL': '1', 13:18:44 INFO - 'TERM': 'linux', 13:18:44 INFO - 'TMOUT': '86400', 13:18:44 INFO - 'USER': 'cltbld', 13:18:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:44 INFO - '_': '/tools/buildbot/bin/python'} 13:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:45 INFO - Running setup.py (path:/tmp/pip-Z5xH6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:45 INFO - Running setup.py (path:/tmp/pip-OZaYBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:45 INFO - Running setup.py (path:/tmp/pip-WeeCVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:45 INFO - Running setup.py (path:/tmp/pip-iHvWMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:45 INFO - Running setup.py (path:/tmp/pip-u8LM9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:45 INFO - Running setup.py (path:/tmp/pip-NTCj0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:45 INFO - Running setup.py (path:/tmp/pip-KTZusy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:45 INFO - Running setup.py (path:/tmp/pip-GawZSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:45 INFO - Running setup.py (path:/tmp/pip-gUdIWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:45 INFO - Running setup.py (path:/tmp/pip-4IJQmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:45 INFO - Running setup.py (path:/tmp/pip-OwGhqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:45 INFO - Running setup.py (path:/tmp/pip-VnnErf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:45 INFO - Running setup.py (path:/tmp/pip-xQaxQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:45 INFO - Running setup.py (path:/tmp/pip-xLzgoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:45 INFO - Running setup.py (path:/tmp/pip-mszxuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:46 INFO - Running setup.py (path:/tmp/pip-t1_MvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:46 INFO - Running setup.py (path:/tmp/pip-2Ut0sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:18:46 INFO - Running setup.py install for manifestparser 13:18:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:18:46 INFO - Running setup.py install for mozcrash 13:18:46 INFO - Running setup.py install for mozdebug 13:18:46 INFO - Running setup.py install for mozdevice 13:18:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:18:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:18:46 INFO - Running setup.py install for mozfile 13:18:46 INFO - Running setup.py install for mozhttpd 13:18:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:18:46 INFO - Running setup.py install for mozinfo 13:18:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:18:46 INFO - Running setup.py install for mozInstall 13:18:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Running setup.py install for mozleak 13:18:47 INFO - Running setup.py install for mozlog 13:18:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Running setup.py install for moznetwork 13:18:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Running setup.py install for mozprocess 13:18:47 INFO - Running setup.py install for mozprofile 13:18:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Running setup.py install for mozrunner 13:18:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Running setup.py install for mozscreenshot 13:18:47 INFO - Running setup.py install for moztest 13:18:47 INFO - Running setup.py install for mozversion 13:18:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:18:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:18:47 INFO - Cleaning up... 13:18:48 INFO - Return code: 0 13:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:18:48 INFO - Using env: {'DISPLAY': ':0', 13:18:48 INFO - 'HOME': '/home/cltbld', 13:18:48 INFO - 'LANG': 'en_US.UTF-8', 13:18:48 INFO - 'LANGUAGE': 'en_US:en', 13:18:48 INFO - 'LOGNAME': 'cltbld', 13:18:48 INFO - 'MAIL': '/var/mail/cltbld', 13:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:48 INFO - 'MOZ_NO_REMOTE': '1', 13:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:48 INFO - 'NO_EM_RESTART': '1', 13:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:48 INFO - 'PWD': '/builds/slave/test', 13:18:48 INFO - 'SHELL': '/bin/bash', 13:18:48 INFO - 'SHLVL': '1', 13:18:48 INFO - 'TERM': 'linux', 13:18:48 INFO - 'TMOUT': '86400', 13:18:48 INFO - 'USER': 'cltbld', 13:18:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:48 INFO - '_': '/tools/buildbot/bin/python'} 13:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:48 INFO - Running setup.py (path:/tmp/pip-hm3ODA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:48 INFO - Running setup.py (path:/tmp/pip-DIv44d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:48 INFO - Running setup.py (path:/tmp/pip-UoBLIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:48 INFO - Running setup.py (path:/tmp/pip-X33P7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:48 INFO - Running setup.py (path:/tmp/pip-XlaKa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:48 INFO - Running setup.py (path:/tmp/pip-6Cwv8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:48 INFO - Running setup.py (path:/tmp/pip-GaBfuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:48 INFO - Running setup.py (path:/tmp/pip-WIttaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:48 INFO - Running setup.py (path:/tmp/pip-2dpQVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:48 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:48 INFO - Running setup.py (path:/tmp/pip-kO_RhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:48 INFO - Running setup.py (path:/tmp/pip-XFV9Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:49 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)) 13:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:49 INFO - Running setup.py (path:/tmp/pip-A5qddG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:49 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)) 13:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:49 INFO - Running setup.py (path:/tmp/pip-WVeQIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 13:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:49 INFO - Running setup.py (path:/tmp/pip-ICgWBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:49 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)) 13:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:49 INFO - Running setup.py (path:/tmp/pip-iZH2Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:49 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)) 13:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:49 INFO - Running setup.py (path:/tmp/pip-noevw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:49 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)) 13:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:49 INFO - Running setup.py (path:/tmp/pip-u8zD1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:49 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)) 13:18:49 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:18:49 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:18:49 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)) 13:18:49 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:18:49 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:18:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:18:49 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 13:18:49 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 13:18:49 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 13:18:49 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 13:18:49 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 13:18:49 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 13:18:51 INFO - Downloading blessings-1.6.tar.gz 13:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:18:51 INFO - Installing collected packages: blessings 13:18:51 INFO - Running setup.py install for blessings 13:18:51 INFO - Successfully installed blessings 13:18:51 INFO - Cleaning up... 13:18:51 INFO - Return code: 0 13:18:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:18:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:51 INFO - Reading from file tmpfile_stdout 13:18:51 INFO - Current package versions: 13:18:51 INFO - argparse == 1.2.1 13:18:51 INFO - blessings == 1.6 13:18:51 INFO - blobuploader == 1.2.4 13:18:51 INFO - docopt == 0.6.1 13:18:51 INFO - manifestparser == 1.1 13:18:51 INFO - mozInstall == 1.12 13:18:51 INFO - mozcrash == 0.17 13:18:51 INFO - mozdebug == 0.1 13:18:51 INFO - mozdevice == 0.48 13:18:51 INFO - mozfile == 1.2 13:18:51 INFO - mozhttpd == 0.7 13:18:51 INFO - mozinfo == 0.9 13:18:51 INFO - mozleak == 0.1 13:18:51 INFO - mozlog == 3.2 13:18:51 INFO - moznetwork == 0.27 13:18:51 INFO - mozprocess == 0.22 13:18:51 INFO - mozprofile == 0.28 13:18:51 INFO - mozrunner == 6.11 13:18:51 INFO - mozscreenshot == 0.1 13:18:51 INFO - mozsystemmonitor == 0.3 13:18:51 INFO - moztest == 0.7 13:18:51 INFO - mozversion == 1.4 13:18:51 INFO - psutil == 3.1.1 13:18:51 INFO - requests == 1.2.3 13:18:51 INFO - wsgiref == 0.1.2 13:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:18:51 INFO - Using env: {'DISPLAY': ':0', 13:18:51 INFO - 'HOME': '/home/cltbld', 13:18:51 INFO - 'LANG': 'en_US.UTF-8', 13:18:51 INFO - 'LANGUAGE': 'en_US:en', 13:18:51 INFO - 'LOGNAME': 'cltbld', 13:18:51 INFO - 'MAIL': '/var/mail/cltbld', 13:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:51 INFO - 'MOZ_NO_REMOTE': '1', 13:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:51 INFO - 'NO_EM_RESTART': '1', 13:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:51 INFO - 'PWD': '/builds/slave/test', 13:18:51 INFO - 'SHELL': '/bin/bash', 13:18:51 INFO - 'SHLVL': '1', 13:18:51 INFO - 'TERM': 'linux', 13:18:51 INFO - 'TMOUT': '86400', 13:18:51 INFO - 'USER': 'cltbld', 13:18:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:51 INFO - '_': '/tools/buildbot/bin/python'} 13:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:18:52 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 2)) 13:18:52 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 3)) 13:18:52 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 4)) 13:18:52 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 5)) 13:18:52 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 6)) 13:18:52 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 7)) 13:18:52 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 8)) 13:18:52 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 9)) 13:18:52 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:18:52 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 4)) 13:18:52 INFO - Cleaning up... 13:18:52 INFO - Return code: 0 13:18:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:18:52 INFO - Using env: {'DISPLAY': ':0', 13:18:52 INFO - 'HOME': '/home/cltbld', 13:18:52 INFO - 'LANG': 'en_US.UTF-8', 13:18:52 INFO - 'LANGUAGE': 'en_US:en', 13:18:52 INFO - 'LOGNAME': 'cltbld', 13:18:52 INFO - 'MAIL': '/var/mail/cltbld', 13:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:52 INFO - 'MOZ_NO_REMOTE': '1', 13:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:52 INFO - 'NO_EM_RESTART': '1', 13:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:52 INFO - 'PWD': '/builds/slave/test', 13:18:52 INFO - 'SHELL': '/bin/bash', 13:18:52 INFO - 'SHLVL': '1', 13:18:52 INFO - 'TERM': 'linux', 13:18:52 INFO - 'TMOUT': '86400', 13:18:52 INFO - 'USER': 'cltbld', 13:18:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:52 INFO - '_': '/tools/buildbot/bin/python'} 13:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:52 INFO - Downloading/unpacking jsonschema 13:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:54 INFO - Downloading/unpacking functools32 (from jsonschema) 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:54 INFO - warning: no files found matching '*.txt' 13:18:54 INFO - no previously-included directories found matching 'build' 13:18:54 INFO - no previously-included directories found matching 'dist' 13:18:54 INFO - no previously-included directories found matching '.git*' 13:18:54 INFO - Installing collected packages: jsonschema, functools32 13:18:54 INFO - Running setup.py install for functools32 13:18:54 INFO - warning: no files found matching '*.txt' 13:18:54 INFO - no previously-included directories found matching 'build' 13:18:54 INFO - no previously-included directories found matching 'dist' 13:18:54 INFO - no previously-included directories found matching '.git*' 13:18:54 INFO - Successfully installed jsonschema functools32 13:18:54 INFO - Cleaning up... 13:18:54 INFO - Return code: 0 13:18:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f578bdf4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', '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 13:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:18:54 INFO - Using env: {'DISPLAY': ':0', 13:18:54 INFO - 'HOME': '/home/cltbld', 13:18:54 INFO - 'LANG': 'en_US.UTF-8', 13:18:54 INFO - 'LANGUAGE': 'en_US:en', 13:18:54 INFO - 'LOGNAME': 'cltbld', 13:18:54 INFO - 'MAIL': '/var/mail/cltbld', 13:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:54 INFO - 'MOZ_NO_REMOTE': '1', 13:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:54 INFO - 'NO_EM_RESTART': '1', 13:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:54 INFO - 'PWD': '/builds/slave/test', 13:18:54 INFO - 'SHELL': '/bin/bash', 13:18:54 INFO - 'SHLVL': '1', 13:18:54 INFO - 'TERM': 'linux', 13:18:54 INFO - 'TMOUT': '86400', 13:18:54 INFO - 'USER': 'cltbld', 13:18:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:54 INFO - '_': '/tools/buildbot/bin/python'} 13:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:54 INFO - Downloading/unpacking flake8 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:18:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:18:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:57 INFO - no previously-included directories found matching 'docs/_build' 13:18:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:18:57 INFO - Running setup.py install for pep8 13:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:57 INFO - no previously-included directories found matching 'docs/_build' 13:18:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:18:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:18:57 INFO - Cleaning up... 13:18:57 INFO - Return code: 0 13:18:57 INFO - Running post-action listener: _resource_record_post_action 13:18:57 INFO - Running post-action listener: _start_resource_monitoring 13:18:57 INFO - Starting resource monitoring. 13:18:57 INFO - ##### 13:18:57 INFO - ##### Finished create-virtualenv step (success) 13:18:57 INFO - ##### 13:18:57 INFO - ##### 13:18:57 INFO - ##### Running install step. 13:18:57 INFO - ##### 13:18:57 INFO - Running pre-action listener: _resource_record_pre_action 13:18:57 INFO - Running main action method: install 13:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:57 INFO - Reading from file tmpfile_stdout 13:18:57 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:58 INFO - Reading from file tmpfile_stdout 13:18:58 INFO - Output received: 13:18:58 INFO - Usage: mozinstall [options] installer 13:18:58 INFO - Options: 13:18:58 INFO - -h, --help show this help message and exit 13:18:58 INFO - -d DEST, --destination=DEST 13:18:58 INFO - Directory to install application into. [default: 13:18:58 INFO - "/builds/slave/test"] 13:18:58 INFO - --app=APP Application being installed. [default: firefox] 13:18:58 INFO - mkdir: /builds/slave/test/build/application 13:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:19:13 INFO - Reading from file tmpfile_stdout 13:19:13 INFO - Output received: 13:19:13 INFO - /builds/slave/test/build/application/firefox/firefox 13:19:13 INFO - Running post-action listener: _resource_record_post_action 13:19:13 INFO - ##### 13:19:13 INFO - ##### Finished install step (success) 13:19:13 INFO - ##### 13:19:13 INFO - ##### 13:19:13 INFO - ##### Running run-tests step. 13:19:13 INFO - ##### 13:19:13 INFO - Running pre-action listener: _resource_record_pre_action 13:19:13 INFO - Running main action method: run_tests 13:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:19:13 INFO - Python 2.7.3 13:19:13 INFO - Return code: 0 13:19:13 INFO - grabbing minidump binary from tooltool 13:19:13 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')]} 13:19:13 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11709c0>, '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 0x11718c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:19:13 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 13:19:13 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 13:19:13 INFO - Calling ['/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'] with output_timeout 600 13:19:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:19:13 INFO - Return code: 0 13:19:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:19:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:19:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:19:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:19:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:19:14 INFO - Return code: 0 13:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:19:14 INFO - Using env: {'DISPLAY': ':0', 13:19:14 INFO - 'HOME': '/home/cltbld', 13:19:14 INFO - 'LANG': 'en_US.UTF-8', 13:19:14 INFO - 'LANGUAGE': 'en_US:en', 13:19:14 INFO - 'LOGNAME': 'cltbld', 13:19:14 INFO - 'MAIL': '/var/mail/cltbld', 13:19:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:19:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:14 INFO - 'MOZ_NO_REMOTE': '1', 13:19:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:14 INFO - 'NO_EM_RESTART': '1', 13:19:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:14 INFO - 'PWD': '/builds/slave/test', 13:19:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:19:14 INFO - 'SHELL': '/bin/bash', 13:19:14 INFO - 'SHLVL': '1', 13:19:14 INFO - 'TERM': 'linux', 13:19:14 INFO - 'TMOUT': '86400', 13:19:14 INFO - 'USER': 'cltbld', 13:19:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193', 13:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:14 INFO - '_': '/tools/buildbot/bin/python'} 13:19:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:19:14 INFO - mozversion application_buildid: 20160528004338 13:19:14 INFO - mozversion application_changeset: 2e2c3435f648e36080c49c46416b710e0b52d55a 13:19:14 INFO - mozversion application_display_name: Nightly 13:19:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:19:14 INFO - mozversion application_name: Firefox 13:19:14 INFO - mozversion application_remotingname: firefox 13:19:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:19:14 INFO - mozversion application_vendor: Mozilla 13:19:14 INFO - mozversion application_version: 49.0a1 13:19:14 INFO - mozversion platform_buildid: 20160528004338 13:19:14 INFO - mozversion platform_changeset: 2e2c3435f648e36080c49c46416b710e0b52d55a 13:19:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:19:14 INFO - mozversion platform_version: 49.0a1 13:19:14 INFO - using testdate: 1464553154 13:19:14 INFO - actual date: 1464553154 13:19:14 INFO - starting webserver on 'localhost:37738' 13:19:14 INFO - SUITE-START | Running 2 tests 13:19:14 INFO - TEST-START | dromaeo_css 13:19:14 INFO - operating with platform_type : linux_ 13:19:14 INFO - Initialising browser for dromaeo_css test... 13:19:15 INFO - TEST-INFO | started process 3883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOyND8/profile http://localhost:37738/getInfo.html) 13:19:19 INFO - PROCESS | 3883 | __metrics Screen width/height:1600/1200 13:19:19 INFO - PROCESS | 3883 | colorDepth:24 13:19:19 INFO - PROCESS | 3883 | Browser inner width/height: 1024/697 13:19:19 INFO - PROCESS | 3883 | __metrics 13:19:20 ERROR - PROCESS | 3883 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:19:21 INFO - TEST-INFO | 3883: exit 0 13:19:21 INFO - Browser initialized. 13:19:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:19:21 INFO - TEST-INFO | started process 3962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOyND8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:33 INFO - PROCESS | 3962 | RSS: Main: 157147136 13:19:33 INFO - PROCESS | 3962 | 13:20:24 INFO - PROCESS | 3962 | 1464553224965 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] 13:22:36 INFO - PROCESS | 3962 | Cycle 1(1): loaded http://localhost:37738/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37738/tests/dromaeo/cssquery-ext.html) 13:22:37 INFO - PROCESS | 3962 | RSS: Main: 243314688 13:22:37 INFO - PROCESS | 3962 | 13:25:40 INFO - PROCESS | 3962 | Cycle 1(1): loaded http://localhost:37738/tests/dromaeo/cssquery-ext.html (next: http://localhost:37738/tests/dromaeo/cssquery-jquery.html) 13:25:40 INFO - PROCESS | 3962 | RSS: Main: 236371968 13:25:40 INFO - PROCESS | 3962 | 13:28:42 INFO - PROCESS | 3962 | Cycle 1(1): loaded http://localhost:37738/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37738/tests/dromaeo/cssquery-mootools.html) 13:28:43 INFO - PROCESS | 3962 | RSS: Main: 240304128 13:28:43 INFO - PROCESS | 3962 | 13:31:45 INFO - PROCESS | 3962 | Cycle 1(1): loaded http://localhost:37738/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37738/tests/dromaeo/cssquery-prototype.html) 13:31:46 INFO - PROCESS | 3962 | RSS: Main: 236204032 13:31:46 INFO - PROCESS | 3962 | 13:34:49 INFO - PROCESS | 3962 | Cycle 1(1): loaded http://localhost:37738/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37738/tests/dromaeo/cssquery-yui.html) 13:34:49 INFO - PROCESS | 3962 | RSS: Main: 218107904 13:34:49 INFO - PROCESS | 3962 | 13:37:52 INFO - PROCESS | 3962 | Cycle 1(1): loaded http://localhost:37738/tests/dromaeo/cssquery-yui.html (next: http://localhost:37738/tests/dromaeo/cssquery-dojo.html) 13:37:53 INFO - PROCESS | 3962 | RSS: Main: 275132416 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | __start_tp_report 13:37:53 INFO - PROCESS | 3962 | _x_x_mozilla_page_load 13:37:53 INFO - PROCESS | 3962 | _x_x_mozilla_page_load_details 13:37:53 INFO - PROCESS | 3962 | |i|pagename|runs| 13:37:53 INFO - PROCESS | 3962 | |0;dojo.html;2642.5243456177886;2651.5890037044264;2690.852003139828;2696.285484346647;2708.4853877763226;4651.906961860761;4669.836555720551;4736.478987311393;4745.525447455253;4797.40032495938;4693.694909830859;4697.436307643079;4697.553732395426;4752.59602933751;4776.832810851621;4089.7546147231114;4256.063665993476;4336.241157797389;4364.018095928423;4480.372747815292;4380.824767009316;4415.690901636886;4441.91173162574;4448.0436706108185;4475.328700694906;4235.322348424237;4269.082147338306;4277.957220427787;4283.528811830696;4336.046069864625;4281.914361712748;4293.313069908831;4346.826126954918;4352.347147927804;4353.172897149563;4330.480342358906;4340.153670034345;4341.7829108544765;4375.978120109411;4380.67144964129;4533.954660453386;4585.335126406652;4648.604868586174;4648.790804413809;4710.293455981596;5114;5122.718250496221;5123.590112790967;5145.434002259748;5149.639525233235;4988.90022199554;5087.313212716273;5133.281340612317;5142.922856157161;5155.639105262633;4697.3893393858925;4750.12122757291;4756.025014871943;4805.927911081337;4815.711057336571;5261.710605916712;5284.128118860422;5284.9471505284455;5286.7092309922555;5290.841274761763;4893.804247830119;4905.166121759309;4948.678335908155;4968.925466118011;5015.272785446163;5045.268436076748;5045.293658887758;5065.088284108822;5065.949340506548;5110.4123025852505;5002.449730529639;5009.348784658044;5016.54851063406;5024.924626130611;5063.367079115111;4887.853364399074;4891.461939186686;4949.802007919643;4996.800127994839;5002.199648056367;4299.742015479082;4306.2248795217165;4308.267594508941;4332.783360831946;4340.934885976713;3743.457198706172;3749.606291339425;3763.9247215055548;3798.164403831153;3812.4662547243406;4304.74171549708;4326.697131200849;4357.7385356878685;4361.127774445124;4361.454818147731;5083.847484575469;5104.3109180260935;5106.719130447861;5111.616628752859;5144.6913185209005;4388.736675799399;4392.297232442857;4395.758233297135;4420.734755914656;4439.489458712224;4433.6009759121835;4532.79602417892;4558.566936141061;4571.862844114682;4588.357629931812;4794.232922732346;4807.663463557517;4816.422029356429;4820.228763397839;4868.537488938687;5100.668456550312;5113.411957624772;5115.386153661584;5116.204966841209;5181.404138524118;4664.580187783115;4745.976270118627;4770.284457331428;4804.735739534359;4815.061063092663;5005.224190250517;5021.397432308;5029.748512574283;5035;5041.168207245763;5000.449950505369;5098.2352647103235;5115.87210319745;5120.692758434357;5165.509276618715;4896.6572339935865;4935.580475659465;4954.405471343462;4984.825531106394;5001.349824522788;4925.6305777066145;4933.358663373739;4936.654434189572;4946.727929963887;4976.850694479172;4769.070031343855;4803.807847686054;4859.805607775649;4873.561379475864;4923.261510773413;4909.877253068702;4937.975310123426;4944.035912997075;4961.404631444106;5004.3494345734825;4836.879078023077;4853.733044682576;4854.490278520704;4860.173770459101;4909.26361045846 13:37:53 INFO - PROCESS | 3962 | |1;ext.html;552.552432529651;596.7941060334184;598.5211830535574;615.114235500879;619.8605313804393;28506.429871402586;31092.378152436966;31125.221869453217;31136.377272454567;39410.60589394112;38093;42218.36672449916;42297.78851105748;42306;42325.36511952316;7649.464537482365;7853.607319633996;7857.764267071997;7860.253275938805;7869.134395216522;7708.6916523339;7739.767806965772;7745.148033716287;7746.651400686983;7840.686372545091;7766.068071831388;7811.648475818573;7815.843683126334;7817.804554886116;7822.100458447266;7783;7786.610669466504;7788;7851.528908265523;7856.057273127232;7817.843643127106;7929.682812687485;7943.841123177562;7945.721899733481;7949.562774047425;37869.62130378689;38350.80824595887;38383.616163838284;38396.23207535833;38404.61595384038;2926.2391778137626;3054.328047829474;3082.9075127746205;3135.2318681922848;3202.823844688541;29519.819207231685;29698.36658983755;29869.55195672045;30013.549796753065;30189.547156792665;3276.803391796476;3327.8169700666454;3361.8487168077495;3388.271521622863;3533.752637315389;248787;251660;252398;253475.73262133755;254554.45396049198;31222.375552489277;55198;55725.1641225382;55809;55885.720571397695;32481.18797030046;34615.307693845985;34641.48037779385;34704.30591388158;34721.479177812354;11904.464299106561;12048.578299759467;12051.819222711667;12061;12071.698207544707;9868.111869931598;9906.60373585063;9949.204063674888;9949.850752238723;9951.402915825074;7929.008873890763;7966.721164759321;7984.640691168911;7986.840263194704;8052.396070294634;3126.609173853268;3159.699828516287;3179.8410079495934;3188.9043328700177;3189.2186414328175;847.3433089355799;861.9267362274152;881.1400429197262;903.9367244292968;1048.1771809129796;27868.581971270447;28284.43431131407;28469.715302847122;28645.14064578066;28681.56977645337;769.2040475020692;951.414879848888;959.9280053995979;988.2439933450916;1023.6928921323573;14913.552593422215;15186.620334491727;15205.847941520664;15218.086914785148;15479.458218962282;399253;402630;403807;404071;404607;49989.75005124951;50376.748116259914;50503.74748126309;50514.747426262635;50517.24224136641;1109.1237922041496;1165.0679456434818;1197.1201167142144;1203.9458224379923;1251.5306759965194;27764.16707498778;29085.272868178465;29171.562426564044;29247.7075229245;29445.558316625695;41791.37312940369;47741.283880741124;48868.75565622149;49186.508134919626;53615.73192134014;373264;374554;376853;377835;378396;32151.839240803645;38018.80990595029;38424.48679623786;39004.609953901236;39453.210935781695;42539.36190957076;42764.60468247488;42833.57166428296;43280;43763.34354984614;36483.44615876863;36778.26443471062;37145;37170.25659486849;37283.627163728015;36360.0202861939;36372.818135909154;36740.81629591835;36981;37161.62838371582;36146.81926590455;36297.320468409824;36325.636743632225;36568;36649.267014660094;32492.187695307806;33881;33923.66076339304;33947.15132121717;34118;25103.874480628212;25480;25523.23430297094;25641.30553433052;25659.486810264065 13:37:53 INFO - PROCESS | 3962 | |2;jquery.html;375.35251690833314;376.43910573245853;379.29829814842526;394.5521832719862;397.8289335585699;15632.687346253068;16252.106134162632;16967.23647435865;16994.15029248539;17028.574285642866;15919.761203581955;16523.421680241194;16547.58631034225;16673.16634168293;17319.740203896952;4693.788779504914;4771.308160316752;4783.4499032611175;4865.19724245499;4869.586085182764;3522.7534072614926;5273.57811375091;5556.972215138919;5569.526590239814;5679.034564124109;5612.550995920337;5660.29246344207;5663.603547751659;5678.716064196794;5684.175794509814;5433.755481003364;5521.475459831349;5563.471470210324;5623.634463759863;5677.716114194273;3426.5202871597994;3592.8203589820405;3597.388443964532;3640.726945479073;5114.616403769732;12112.757744845141;12150;12656.557020504239;12663.176893501985;12858.871411285862;1800.2528950485532;1854.8979806110658;1885.8585606079598;1977.7527809023873;2299.563083014222;9286.953565232197;9517.524123793783;9535.998720134425;9600.95199524005;10177.89822101777;1595.9760603590955;1685.148999755128;1690.6449645574444;1715.476779582227;1772.3796671165119;67406;68437;68502.65748671275;68692.65653671749;69461;9533.617625444273;9541.713748587554;9628.71113866585;9662.661806836726;9691.466969316614;13056.673583160496;13093.803592946113;13117.737645247042;13127.737445251041;13137;6962.408195303456;6963.338482844122;6984.301569842975;6995.930040699528;7161;6520.250171230275;6733.7643182489355;6809.897851532231;6832.077669514552;6858.897116543256;4099.467069280974;4168.645665118438;4196;4291.141771645684;4555.908881822345;1586.2703156547886;1608.2200132935518;1704.701677206484;1708.8120306766245;1823.5896923192176;805.033959248892;810.4326971120239;824.5011767880346;946.1910066892846;951.2627713521938;16039.759403608956;16287.348506059861;16365.590860228589;16488.34046638121;16769;826.71065127205;834.1533343656193;861.8707193920962;901.6889173235223;958.5686441101532;7282.8179295516975;9189.90810091904;9231.953840230755;9364.719058428258;9594.17710634991;335894;347970;353376;355843;361888;73625.26374736291;73829;76973.61513192399;77007.61496192483;77117.61441192759;947.9526023698787;948.3693343926212;950.9286803489766;973.5570315506427;974.0648976982177;14560.563183104523;14574.271286435847;14611.274125098033;14726.705465890407;15068.849311506745;28814.279643009093;32513.512297315086;32562.51156232611;33558;35933.460998085575;50125.749371254366;50414.747926260134;50532.49467505278;50555;50885.491145088075;7224;7430.591317477591;7433.776986690408;7504.061992250969;7526.134494533198;11110.777784444428;11320.207585468937;11401.942990284995;11430.428478576205;11565.479553419947;4795.736234507136;5497.45025497447;9488.762780930532;9611.279154063333;9840.065193806577;9802.16681582045;10102.545385457819;10182.643607473703;10312.793744125225;10369.222308327056;10047.296689231976;10062.496875156066;10157.39055656663;10332.17342612574;10382.896171038194;7274.381677557255;7352.448566357438;7367.152777430664;7386.96306518464;7471.813204669709;8530.872036919327;9908.702738917844;10005.249606279704;10093.798124037332;10190.235732319958 13:37:53 INFO - PROCESS | 3962 | |3;mootools.html;1254.222382123084;1384.5015794314045;1447.7321695486335;1538.923053847308;1761.1018380625876;6805.727770889164;7490.700371985121;7700.614969251543;7715.961420192898;7928.5242885426915;7705.267999540049;7863.135055143944;7865;7875.330596899256;7877.251661092201;2144.6246906791325;2196.2203417786695;2200.7799220078023;2204.40481070111;2205.106931692667;2134.6691262854283;2161.2975782870553;2208.536207396449;2211.148707747521;2212.391592312111;2172.2940044485526;2173.217641649005;2183.9344819655435;2186.04906865514;2216.7007453993747;2120.4486833423266;2133.1040962795587;2134.1356750516065;2140.304401069651;2140.518383363746;2092.5814837032653;2142.5179334649733;2145.249162793026;2148.967765483519;2149.7635260121374;7316.122065352139;7496.850062998709;7745.341645960044;7793.415493837928;7796.142424333319;4674.462436819776;4866.902661946777;4868.63485238605;4876.439209490918;4882.462929077798;2939.4562006028955;3022.259546411143;3081.2142903559675;3082.4913889208256;3095.411871744361;870.3298460185622;878.5519385113574;904.2268860124565;963.7590602349412;986.9851952220722;10558.260921735482;10865.076468500187;10877.292975956616;10896.673099807018;10901.890981090246;4367.912641747211;4439.356293337448;4528.411306530196;4539.114872599877;4547.977260113745;9279.072092790802;9331;9334.206592439583;9346.11211934865;9358.906410935804;4881.560659540658;4927.482614325516;4943.8516844494725;4944.1100601892;4950.504949505093;3721.981390093032;3913.784741839226;4262;4287.97856010718;4339.609435150852;3712.3317802795755;3779.16858291181;3836.76979381238;3876.689864810865;3879.18537107205;1234.6481252843075;1249.562653071436;1275.3431982529005;1281.8397700287464;1283.1787655900046;829.4235506323048;835.3776436554806;836.9748907532784;838.6268110690806;859.0164261920191;5025.874353141127;5380.085385484477;5404.216388623706;5421.078416669176;5434.266374039533;400.42339031794126;400.4753772557958;401.8226596073533;404.0504813687869;407.22423782694017;3172.175234439016;3369.275605744777;3384.2554637979606;3414.078198886287;3440.638732933006;9163.258980793627;9460.526973651427;9495;9500;9506.714798556055;9141.862872056925;9313.53432328381;9394.342396032212;9397.107274808883;9410.200132988773;7306.96346518264;7367.484276100621;7490.550566966;7493.812654683567;7494.437917156235;5431.809886654106;5619.747111379916;5673.319201695823;5741.3397459291045;5824.621399609012;8726.389152759246;8752.69365572202;9132.543372831466;9153.954230228806;9197.264218862609;9211.078892110736;9217.631294748404;9232.95383523105;9310.627574897198;9422.811543769223;6074.878502430015;6170.660613666291;6398.264199616918;6399.8720025598295;6550.410463058348;6739.865202696017;7365.1530074042175;7367.26327367259;7374;7378.262173782578;6686.699098540675;6848.794536163923;6906.896396554156;6935.583864968118;7009.12385951756;6783.89824152648;6804.829879253059;6809.046733457221;6809.182898052265;6892.483063770137;6412.807615771534;6465.967670161619;6493;6495.740170393131;6505.251896032017;4585.81656733727;4693.577578017995;4785.042991401664;4803.375561177025;4837.080954618611;4524.864254072383;4589.541045895384;4598.435892570028;4623.722576645412;4676.836310729108 13:37:53 INFO - PROCESS | 3962 | |4;prototype.html;302.3997365230018;312.7748021424574;317.21331098874805;318.2632206442086;321.4021919230231;4582.541745825416;4688.273317635763;4693.3898593182885;4754.714717116975;4759.547842954918;4540.97729511352;4642.512536183703;4645.281245939007;4658.277966915133;4659.9534004659945;3698.5575625506076;3723.720720945926;3725.981370093146;3732.253549290153;3751.0997360633387;3608.1520842601967;3653.5798383185875;3743.1390780120587;3745.6067112953156;3747.3254814133447;3667.8166091695443;3698.5561732592128;3726.819810410913;3748.756330838487;3763.153290509641;3682.576503702082;3693.8707145249923;3699.5560532735976;3707.4428739929294;3740.5698344690436;3340.3987282289177;3350.480675495302;3356.2112903467664;3367.7137443317347;3373.7807042542404;4365.995820961165;4496.168208881368;4506.6169375602785;4531.660125490568;4550.817967281305;4244.8538894498315;4252.383404406344;4255.234057869582;4275.482203817631;4276.893077673052;4792.496787837262;4892.902141957176;4924.482929292409;4932.53140951609;4939.135651261015;3654.8903532894055;3689.8524059037873;3690.6493883081334;3700.3709369406997;3705.906757506542;5205.713685747282;5241.008416801591;5243.816466423695;5256.159014557691;5260.605454590883;3787.0496694202507;3797.8290976906105;3804.8312461896453;3812.1041555234497;3822.006278367589;3644.6173151819207;3840.231953609289;3851.4030325299623;3861.5366156061455;3863.517060367454;4265.53079161292;4272.209641216385;4282.186384586918;4291.871243862689;4310.612044915973;4922.581580565692;4941.802327906844;4959.181735013754;4974.67664601807;4986.700797952062;1228.5147366790068;1277.4698500122531;1314.2508770001198;1319.874611911886;1329.1325687409205;854.6495936665937;860.3934226370394;867.4405008769309;874.8775171475871;878.3048715978096;3938.2714197873483;3946.3685810270217;3974.6621537169085;3978.8209530570616;4006.5392479864604;4520.276755719069;4520.4575450946095;4526.864194074183;4531.799073245593;4545.909081818345;3962.306596345628;3971.3645816669195;3981.427336202184;3988.720789544704;3998;2314.317276403465;2400.7839294463583;2422.3701837522017;2434.9878250608635;2442.291735396715;4233.30150525166;4301.548337424588;4309.159713855831;4332.9133417332105;4352.912941741148;4582.793774280165;4584.633229341644;4591.265397536378;4630.699004564693;4643.326717625925;4045.959540404617;4276.636485898734;4298.645926533132;4331.45856767904;4335.934960975588;4419.055615529157;4446.866594002185;4538.909221815479;4546.772661366985;4567.954320456753;4406.537313582027;4407.427034485625;4411.551588868209;4440.689151759346;4465.950501632179;4088.8568900088353;4239.95760042408;4273.465816772903;4281.2293787118615;4309.762963037063;3441.535392722051;3452.533907922398;3458;3467.8439470223398;3483.9129021774656;4497.2129877272;4552.315643212033;4571.451425828789;4595.655325850507;4895.485973972682;4737;4956.298817144593;4978.228374601942;4981.252812078073;4983.25251212321;4930.704157750546;4949.554540091409;4971.950280497149;4992.400911890596;5003.424606170337;4787.54518320759;4837.709737415626;4923.286123511999;4926.655134140719;4942.481039490802;5013;5024.42219144803;5026.924596131134;5036.395632524121;5037.798488060436;4907.2393778964315;4907.754612269301;4912.803487860446;4914.795875010503;4916.844541532809 13:37:53 INFO - PROCESS | 3962 | |5;yui.html;585.8740370820273;591.7485068845741;624.2384291164781;634.1407392982511;728.6502478810171;10836.674899753;12333.938330308336;12745.299008554526;13341.33293335333;13363;13627.795583066261;14130.788038179435;14162.221077840715;14167.008309418345;14174.149551026945;623.7099748616893;782.4444644302552;793.9245771651683;807.2734538914995;809.0736107157302;801.32288216457;806.9072056713466;809.1584751858061;809.76516810125;809.8015986083418;851.3317046118798;856.0326830681321;856.3192262151605;856.9485830850138;857.2113655437013;846.1073567386405;849.1338834388889;849.3502470609926;849.6643825688849;850.171083193881;622.551762730833;624.5846512069513;624.9906251406233;625.3121566277059;625.4746013348808;12613.558525451564;12632;12638.178518396275;12664.176828506117;12771.872281277161;11794.469248883821;11875.881241187564;11882.16824822254;12052.698682533006;12199.390030498529;9980.750481238027;10096.091351778301;10105.89894101057;10192.541335639915;10391.948040259751;3240.837958102109;3292.818894960776;3328.234506063619;3393.558837351153;3417.094469965461;46631.533684663395;46708.76645616784;47293.52706472926;49250.26124608134;49301.99999999964;9579.856302155335;9627.951860240653;9916.950415247878;10149.238807089498;10297.639582614722;17023.48929532116;17217.91391043062;17232.138393080295;17243.913780431016;17261.482155535356;5350.785968561214;6874.621895795679;7034.402075823612;7129.394001509826;7213.350798428167;3862.088127452895;3891.2606604745574;3926.3521518949055;3947.822347994347;3960.32674445345;2884.985575072153;2989.925251868721;3000.069978306732;3000.804947678394;3001.1146711720094;566.3458705195505;583.0670926517538;599.4784537452445;615.5168192968588;619.9969000155061;569.214484012069;593.7209511529575;605.6729366142322;617.4720613875072;618.0698049435571;7295.978563001184;7362.411007119417;7426.888596671054;7444.59054751983;7612.657430415645;592.4608606168453;600.9699515024319;602.5390576209204;603.3966033966034;607.6506009044817;3682.981585092111;3687.3731465650903;3694.3165514379925;3820.3505404081375;3830.5020347354666;58883.41116588865;59962.402255864785;59995;60120.699396502736;60293;53448.465515344345;53825.461745382825;54441;56110.438895610525;56312.155317670266;48686.75656621694;48821.75589122032;50399;50639;51056.23415648694;7855.567943763148;7860.685572577262;7884.605769711607;8023.438359314792;8307.418480706534;30623.693763062085;31157.37685246237;31192.064238072893;31234.21914452157;31888.202794930312;32494;34833.47749783705;40570.1885962285;40738.79630601828;41084.79457602693;10716.19628527848;10914;11131.220814542905;11157.27477713946;11245;11370.488328025092;11518.94240528792;11530.308181509135;11946.283223006647;12437.502499899903;10417.479126043516;10631.255812093079;10824.24230303871;10979.505922233358;11147.219694621299;10806;10869.945650272015;10944.23390362667;11054.170937179582;11111.555537778399;10775.407352595683;11060.391678457761;11088;11416.143789215675;11445.942770286096;9608.9039109608;9623.807523849344;9667.564959576695;9733.902660973583;9948.35335703177;9357.953210233905;9473.905260947302;9585.856212156963;9594.712158635251;9736.513174341113 13:37:53 INFO - PROCESS | 3962 | __end_tp_report 13:37:53 INFO - PROCESS | 3962 | __start_cc_report 13:37:53 INFO - PROCESS | 3962 | _x_x_mozilla_cycle_collect,847 13:37:53 INFO - PROCESS | 3962 | __end_cc_report 13:37:53 INFO - PROCESS | 3962 | __startTimestamp1464554273001__endTimestamp 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | ------- Summary: start ------- 13:37:53 INFO - PROCESS | 3962 | Number of tests: 6 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | [#0] dojo.html Cycles:165 Average:4684.43 Median:4815.06 stddev:493.05 (10.2%) stddev-sans-first:467.81 13:37:53 INFO - PROCESS | 3962 | Values: 2642.5 2651.6 2690.9 2696.3 2708.5 4651.9 4669.8 4736.5 4745.5 4797.4 4693.7 4697.4 4697.6 4752.6 4776.8 4089.8 4256.1 4336.2 4364.0 4480.4 4380.8 4415.7 4441.9 4448.0 4475.3 4235.3 4269.1 4278.0 4283.5 4336.0 4281.9 4293.3 4346.8 4352.3 4353.2 4330.5 4340.2 4341.8 4376.0 4380.7 4534.0 4585.3 4648.6 4648.8 4710.3 5114.0 5122.7 5123.6 5145.4 5149.6 4988.9 5087.3 5133.3 5142.9 5155.6 4697.4 4750.1 4756.0 4805.9 4815.7 5261.7 5284.1 5284.9 5286.7 5290.8 4893.8 4905.2 4948.7 4968.9 5015.3 5045.3 5045.3 5065.1 5065.9 5110.4 5002.4 5009.3 5016.5 5024.9 5063.4 4887.9 4891.5 4949.8 4996.8 5002.2 4299.7 4306.2 4308.3 4332.8 4340.9 3743.5 3749.6 3763.9 3798.2 3812.5 4304.7 4326.7 4357.7 4361.1 4361.5 5083.8 5104.3 5106.7 5111.6 5144.7 4388.7 4392.3 4395.8 4420.7 4439.5 4433.6 4532.8 4558.6 4571.9 4588.4 4794.2 4807.7 4816.4 4820.2 4868.5 5100.7 5113.4 5115.4 5116.2 5181.4 4664.6 4746.0 4770.3 4804.7 4815.1 5005.2 5021.4 5029.7 5035.0 5041.2 5000.4 5098.2 5115.9 5120.7 5165.5 4896.7 4935.6 4954.4 4984.8 5001.3 4925.6 4933.4 4936.7 4946.7 4976.9 4769.1 4803.8 4859.8 4873.6 4923.3 4909.9 4938.0 4944.0 4961.4 5004.3 4836.9 4853.7 4854.5 4860.2 4909.3 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | [#1] ext.html Cycles:180 Average:48922.86 Median:377344.00 stddev:92561.53 (24.5%) stddev-sans-first:92749.94 13:37:53 INFO - PROCESS | 3962 | Values: 552.6 596.8 598.5 615.1 619.9 28506.4 31092.4 31125.2 31136.4 39410.6 38093.0 42218.4 42297.8 42306.0 42325.4 7649.5 7853.6 7857.8 7860.3 7869.1 7708.7 7739.8 7745.1 7746.7 7840.7 7766.1 7811.6 7815.8 7817.8 7822.1 7783.0 7786.6 7788.0 7851.5 7856.1 7817.8 7929.7 7943.8 7945.7 7949.6 37869.6 38350.8 38383.6 38396.2 38404.6 2926.2 3054.3 3082.9 3135.2 3202.8 29519.8 29698.4 29869.6 30013.5 30189.5 3276.8 3327.8 3361.8 3388.3 3533.8 248787.0 251660.0 252398.0 253475.7 254554.5 31222.4 55198.0 55725.2 55809.0 55885.7 32481.2 34615.3 34641.5 34704.3 34721.5 11904.5 12048.6 12051.8 12061.0 12071.7 9868.1 9906.6 9949.2 9949.9 9951.4 7929.0 7966.7 7984.6 7986.8 8052.4 3126.6 3159.7 3179.8 3188.9 3189.2 847.3 861.9 881.1 903.9 1048.2 27868.6 28284.4 28469.7 28645.1 28681.6 769.2 951.4 959.9 988.2 1023.7 14913.6 15186.6 15205.8 15218.1 15479.5 399253.0 402630.0 403807.0 404071.0 404607.0 49989.8 50376.7 50503.7 50514.7 50517.2 1109.1 1165.1 1197.1 1203.9 1251.5 27764.2 29085.3 29171.6 29247.7 29445.6 41791.4 47741.3 48868.8 49186.5 53615.7 373264.0 374554.0 376853.0 377835.0 378396.0 32151.8 38018.8 38424.5 39004.6 39453.2 42539.4 42764.6 42833.6 43280.0 43763.3 36483.4 36778.3 37145.0 37170.3 37283.6 36360.0 36372.8 36740.8 36981.0 37161.6 36146.8 36297.3 36325.6 36568.0 36649.3 32492.2 33881.0 33923.7 33947.2 34118.0 25103.9 25480.0 25523.2 25641.3 25659.5 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | [#2] jquery.html Cycles:180 Average:22555.31 Median:4789.59 stddev:58256.91 (1216.3%) stddev-sans-first:58396.53 13:37:53 INFO - PROCESS | 3962 | Values: 375.4 376.4 379.3 394.6 397.8 15632.7 16252.1 16967.2 16994.2 17028.6 15919.8 16523.4 16547.6 16673.2 17319.7 4693.8 4771.3 4783.4 4865.2 4869.6 3522.8 5273.6 5557.0 5569.5 5679.0 5612.6 5660.3 5663.6 5678.7 5684.2 5433.8 5521.5 5563.5 5623.6 5677.7 3426.5 3592.8 3597.4 3640.7 5114.6 12112.8 12150.0 12656.6 12663.2 12858.9 1800.3 1854.9 1885.9 1977.8 2299.6 9287.0 9517.5 9536.0 9601.0 10177.9 1596.0 1685.1 1690.6 1715.5 1772.4 67406.0 68437.0 68502.7 68692.7 69461.0 9533.6 9541.7 9628.7 9662.7 9691.5 13056.7 13093.8 13117.7 13127.7 13137.0 6962.4 6963.3 6984.3 6995.9 7161.0 6520.3 6733.8 6809.9 6832.1 6858.9 4099.5 4168.6 4196.0 4291.1 4555.9 1586.3 1608.2 1704.7 1708.8 1823.6 805.0 810.4 824.5 946.2 951.3 16039.8 16287.3 16365.6 16488.3 16769.0 826.7 834.2 861.9 901.7 958.6 7282.8 9189.9 9232.0 9364.7 9594.2 335894.0 347970.0 353376.0 355843.0 361888.0 73625.3 73829.0 76973.6 77007.6 77117.6 948.0 948.4 950.9 973.6 974.1 14560.6 14574.3 14611.3 14726.7 15068.8 28814.3 32513.5 32562.5 33558.0 35933.5 50125.7 50414.7 50532.5 50555.0 50885.5 7224.0 7430.6 7433.8 7504.1 7526.1 11110.8 11320.2 11401.9 11430.4 11565.5 4795.7 5497.5 9488.8 9611.3 9840.1 9802.2 10102.5 10182.6 10312.8 10369.2 10047.3 10062.5 10157.4 10332.2 10382.9 7274.4 7352.4 7367.2 7387.0 7471.8 8530.9 9908.7 10005.2 10093.8 10190.2 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | [#3] mootools.html Cycles:180 Average:5166.15 Median:5202.98 stddev:2891.10 (55.6%) stddev-sans-first:2884.27 13:37:53 INFO - PROCESS | 3962 | Values: 1254.2 1384.5 1447.7 1538.9 1761.1 6805.7 7490.7 7700.6 7716.0 7928.5 7705.3 7863.1 7865.0 7875.3 7877.3 2144.6 2196.2 2200.8 2204.4 2205.1 2134.7 2161.3 2208.5 2211.1 2212.4 2172.3 2173.2 2183.9 2186.0 2216.7 2120.4 2133.1 2134.1 2140.3 2140.5 2092.6 2142.5 2145.2 2149.0 2149.8 7316.1 7496.9 7745.3 7793.4 7796.1 4674.5 4866.9 4868.6 4876.4 4882.5 2939.5 3022.3 3081.2 3082.5 3095.4 870.3 878.6 904.2 963.8 987.0 10558.3 10865.1 10877.3 10896.7 10901.9 4367.9 4439.4 4528.4 4539.1 4548.0 9279.1 9331.0 9334.2 9346.1 9358.9 4881.6 4927.5 4943.9 4944.1 4950.5 3722.0 3913.8 4262.0 4288.0 4339.6 3712.3 3779.2 3836.8 3876.7 3879.2 1234.6 1249.6 1275.3 1281.8 1283.2 829.4 835.4 837.0 838.6 859.0 5025.9 5380.1 5404.2 5421.1 5434.3 400.4 400.5 401.8 404.1 407.2 3172.2 3369.3 3384.3 3414.1 3440.6 9163.3 9460.5 9495.0 9500.0 9506.7 9141.9 9313.5 9394.3 9397.1 9410.2 7307.0 7367.5 7490.6 7493.8 7494.4 5431.8 5619.7 5673.3 5741.3 5824.6 8726.4 8752.7 9132.5 9154.0 9197.3 9211.1 9217.6 9233.0 9310.6 9422.8 6074.9 6170.7 6398.3 6399.9 6550.4 6739.9 7365.2 7367.3 7374.0 7378.3 6686.7 6848.8 6906.9 6935.6 7009.1 6783.9 6804.8 6809.0 6809.2 6892.5 6412.8 6466.0 6493.0 6495.7 6505.3 4585.8 4693.6 4785.0 4803.4 4837.1 4524.9 4589.5 4598.4 4623.7 4676.8 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | [#4] prototype.html Cycles:180 Average:3985.26 Median:4321.04 stddev:1124.21 (26.0%) stddev-sans-first:1092.85 13:37:53 INFO - PROCESS | 3962 | Values: 302.4 312.8 317.2 318.3 321.4 4582.5 4688.3 4693.4 4754.7 4759.5 4541.0 4642.5 4645.3 4658.3 4660.0 3698.6 3723.7 3726.0 3732.3 3751.1 3608.2 3653.6 3743.1 3745.6 3747.3 3667.8 3698.6 3726.8 3748.8 3763.2 3682.6 3693.9 3699.6 3707.4 3740.6 3340.4 3350.5 3356.2 3367.7 3373.8 4366.0 4496.2 4506.6 4531.7 4550.8 4244.9 4252.4 4255.2 4275.5 4276.9 4792.5 4892.9 4924.5 4932.5 4939.1 3654.9 3689.9 3690.6 3700.4 3705.9 5205.7 5241.0 5243.8 5256.2 5260.6 3787.0 3797.8 3804.8 3812.1 3822.0 3644.6 3840.2 3851.4 3861.5 3863.5 4265.5 4272.2 4282.2 4291.9 4310.6 4922.6 4941.8 4959.2 4974.7 4986.7 1228.5 1277.5 1314.3 1319.9 1329.1 854.6 860.4 867.4 874.9 878.3 3938.3 3946.4 3974.7 3978.8 4006.5 4520.3 4520.5 4526.9 4531.8 4545.9 3962.3 3971.4 3981.4 3988.7 3998.0 2314.3 2400.8 2422.4 2435.0 2442.3 4233.3 4301.5 4309.2 4332.9 4352.9 4582.8 4584.6 4591.3 4630.7 4643.3 4046.0 4276.6 4298.6 4331.5 4335.9 4419.1 4446.9 4538.9 4546.8 4568.0 4406.5 4407.4 4411.6 4440.7 4466.0 4088.9 4240.0 4273.5 4281.2 4309.8 3441.5 3452.5 3458.0 3467.8 3483.9 4497.2 4552.3 4571.5 4595.7 4895.5 4737.0 4956.3 4978.2 4981.3 4983.3 4930.7 4949.6 4972.0 4992.4 5003.4 4787.5 4837.7 4923.3 4926.7 4942.5 5013.0 5024.4 5026.9 5036.4 5037.8 4907.2 4907.8 4912.8 4914.8 4916.8 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - PROCESS | 3962 | [#5] yui.html Cycles:180 Average:13541.00 Median:49036.01 stddev:16187.38 (33.0%) stddev-sans-first:16203.55 13:37:53 INFO - PROCESS | 3962 | Values: 585.9 591.7 624.2 634.1 728.7 10836.7 12333.9 12745.3 13341.3 13363.0 13627.8 14130.8 14162.2 14167.0 14174.1 623.7 782.4 793.9 807.3 809.1 801.3 806.9 809.2 809.8 809.8 851.3 856.0 856.3 856.9 857.2 846.1 849.1 849.4 849.7 850.2 622.6 624.6 625.0 625.3 625.5 12613.6 12632.0 12638.2 12664.2 12771.9 11794.5 11875.9 11882.2 12052.7 12199.4 9980.8 10096.1 10105.9 10192.5 10391.9 3240.8 3292.8 3328.2 3393.6 3417.1 46631.5 46708.8 47293.5 49250.3 49302.0 9579.9 9628.0 9917.0 10149.2 10297.6 17023.5 17217.9 17232.1 17243.9 17261.5 5350.8 6874.6 7034.4 7129.4 7213.4 3862.1 3891.3 3926.4 3947.8 3960.3 2885.0 2989.9 3000.1 3000.8 3001.1 566.3 583.1 599.5 615.5 620.0 569.2 593.7 605.7 617.5 618.1 7296.0 7362.4 7426.9 7444.6 7612.7 592.5 601.0 602.5 603.4 607.7 3683.0 3687.4 3694.3 3820.4 3830.5 58883.4 59962.4 59995.0 60120.7 60293.0 53448.5 53825.5 54441.0 56110.4 56312.2 48686.8 48821.8 50399.0 50639.0 51056.2 7855.6 7860.7 7884.6 8023.4 8307.4 30623.7 31157.4 31192.1 31234.2 31888.2 32494.0 34833.5 40570.2 40738.8 41084.8 10716.2 10914.0 11131.2 11157.3 11245.0 11370.5 11518.9 11530.3 11946.3 12437.5 10417.5 10631.3 10824.2 10979.5 11147.2 10806.0 10869.9 10944.2 11054.2 11111.6 10775.4 11060.4 11088.0 11416.1 11445.9 9608.9 9623.8 9667.6 9733.9 9948.4 9358.0 9473.9 9585.9 9594.7 9736.5 13:37:53 INFO - PROCESS | 3962 | -------- Summary: end -------- 13:37:53 INFO - PROCESS | 3962 | 13:37:53 INFO - TEST-INFO | 3962: exit 0 13:37:53 INFO - TEST-OK | dromaeo_css | took 1118788ms 13:37:53 INFO - TEST-START | kraken 13:37:53 INFO - operating with platform_type : linux_ 13:37:53 INFO - Initialising browser for kraken test... 13:37:53 INFO - TEST-INFO | started process 4142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQyPfl6/profile http://localhost:37738/getInfo.html) 13:37:58 INFO - PROCESS | 4142 | __metrics Screen width/height:1600/1200 13:37:58 INFO - PROCESS | 4142 | colorDepth:24 13:37:58 INFO - PROCESS | 4142 | Browser inner width/height: 1024/697 13:37:58 INFO - PROCESS | 4142 | __metrics 13:37:59 ERROR - PROCESS | 4142 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:37:59 INFO - TEST-INFO | 4142: exit 0 13:37:59 INFO - Browser initialized. 13:37:59 INFO - Running cycle 1/1 for kraken test... 13:38:00 INFO - TEST-INFO | started process 4224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQyPfl6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:11 INFO - PROCESS | 4224 | RSS: Main: 157458432 13:38:11 INFO - PROCESS | 4224 | 13:38:14 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37738/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:15 INFO - PROCESS | 4224 | RSS: Main: 214364160 13:38:15 INFO - PROCESS | 4224 | 13:38:18 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37738/tests/kraken/driver.html?testName=audio-dft) 13:38:19 INFO - PROCESS | 4224 | RSS: Main: 201842688 13:38:19 INFO - PROCESS | 4224 | 13:38:22 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37738/tests/kraken/driver.html?testName=audio-fft) 13:38:22 INFO - PROCESS | 4224 | RSS: Main: 270487552 13:38:22 INFO - PROCESS | 4224 | 13:38:25 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37738/tests/kraken/driver.html?testName=audio-oscillator) 13:38:25 INFO - PROCESS | 4224 | RSS: Main: 180891648 13:38:25 INFO - PROCESS | 4224 | 13:38:27 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37738/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:38:28 INFO - PROCESS | 4224 | RSS: Main: 183668736 13:38:28 INFO - PROCESS | 4224 | 13:38:31 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37738/tests/kraken/driver.html?testName=imaging-darkroom) 13:38:32 INFO - PROCESS | 4224 | RSS: Main: 220409856 13:38:32 INFO - PROCESS | 4224 | 13:38:35 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37738/tests/kraken/driver.html?testName=imaging-desaturate) 13:38:36 INFO - PROCESS | 4224 | RSS: Main: 217378816 13:38:36 INFO - PROCESS | 4224 | 13:38:39 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37738/tests/kraken/driver.html?testName=json-parse-financial) 13:38:39 INFO - PROCESS | 4224 | RSS: Main: 219299840 13:38:39 INFO - PROCESS | 4224 | 13:38:41 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37738/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:38:42 INFO - PROCESS | 4224 | RSS: Main: 208232448 13:38:42 INFO - PROCESS | 4224 | 13:38:44 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:38:44 INFO - PROCESS | 4224 | RSS: Main: 212021248 13:38:44 INFO - PROCESS | 4224 | 13:38:46 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:38:47 INFO - PROCESS | 4224 | RSS: Main: 218333184 13:38:47 INFO - PROCESS | 4224 | 13:38:50 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:50 INFO - PROCESS | 4224 | RSS: Main: 221523968 13:38:50 INFO - PROCESS | 4224 | 13:38:53 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:54 INFO - PROCESS | 4224 | RSS: Main: 222269440 13:38:54 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:37738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37738/tests/kraken/driver.html?testName=ai-astar) 13:38:56 INFO - PROCESS | 4224 | RSS: Main: 264523776 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | __start_tp_report 13:38:56 INFO - PROCESS | 4224 | _x_x_mozilla_page_load 13:38:56 INFO - PROCESS | 4224 | _x_x_mozilla_page_load_details 13:38:56 INFO - PROCESS | 4224 | |i|pagename|runs| 13:38:56 INFO - PROCESS | 4224 | |0;ai-astar;113;109;115;113;114;114;113;113;112;113 13:38:56 INFO - PROCESS | 4224 | |1;audio-beat-detection;169;128;135;175;129;161;153;130;177;145 13:38:56 INFO - PROCESS | 4224 | |2;audio-dft;162;162;162;161;162;161;161;161;162;160 13:38:56 INFO - PROCESS | 4224 | |3;audio-fft;77;75;75;130;75;78;76;76;105;75 13:38:56 INFO - PROCESS | 4224 | |4;audio-oscillator;85;85;108;84;85;86;124;84;85;124 13:38:56 INFO - PROCESS | 4224 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 13:38:56 INFO - PROCESS | 4224 | |6;imaging-darkroom;146;146;147;146;146;146;147;147;146;148 13:38:56 INFO - PROCESS | 4224 | |7;imaging-desaturate;95;95;96;95;95;94;95;95;95;95 13:38:56 INFO - PROCESS | 4224 | |8;json-parse-financial;62;64;63;64;62;65;63;64;63;63 13:38:56 INFO - PROCESS | 4224 | |9;json-stringify-tinderbox;65;65;65;66;65;65;66;65;65;66 13:38:56 INFO - PROCESS | 4224 | |10;stanford-crypto-aes;83;82;84;83;84;84;85;84;124;91 13:38:56 INFO - PROCESS | 4224 | |11;stanford-crypto-ccm;137;134;131;130;137;140;128;138;140;138 13:38:56 INFO - PROCESS | 4224 | |12;stanford-crypto-pbkdf2;171;169;170;168;168;168;168;169;166;166 13:38:56 INFO - PROCESS | 4224 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;71;66;67;66;67 13:38:56 INFO - PROCESS | 4224 | __end_tp_report 13:38:56 INFO - PROCESS | 4224 | __start_cc_report 13:38:56 INFO - PROCESS | 4224 | _x_x_mozilla_cycle_collect,1885 13:38:56 INFO - PROCESS | 4224 | __end_cc_report 13:38:56 INFO - PROCESS | 4224 | __startTimestamp1464554336451__endTimestamp 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | ------- Summary: start ------- 13:38:56 INFO - PROCESS | 4224 | Number of tests: 14 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.60 (1.4%) stddev-sans-first:1.69 13:38:56 INFO - PROCESS | 4224 | Values: 113.0 109.0 115.0 113.0 114.0 114.0 113.0 113.0 112.0 113.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.00 stddev:19.49 (12.4%) stddev-sans-first:19.45 13:38:56 INFO - PROCESS | 4224 | Values: 169.0 128.0 135.0 175.0 129.0 161.0 153.0 130.0 177.0 145.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 13:38:56 INFO - PROCESS | 4224 | Values: 162.0 162.0 162.0 161.0 162.0 161.0 161.0 161.0 162.0 160.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.50 stddev:18.54 (24.6%) stddev-sans-first:19.48 13:38:56 INFO - PROCESS | 4224 | Values: 77.0 75.0 75.0 130.0 75.0 78.0 76.0 76.0 105.0 75.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:85.00 stddev:16.91 (19.9%) stddev-sans-first:17.55 13:38:56 INFO - PROCESS | 4224 | Values: 85.0 85.0 108.0 84.0 85.0 86.0 124.0 84.0 85.0 124.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:38:56 INFO - PROCESS | 4224 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 13:38:56 INFO - PROCESS | 4224 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 148.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:38:56 INFO - PROCESS | 4224 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.88 13:38:56 INFO - PROCESS | 4224 | Values: 62.0 64.0 63.0 64.0 62.0 65.0 63.0 64.0 63.0 63.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 13:38:56 INFO - PROCESS | 4224 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 66.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:84.00 stddev:12.75 (15.2%) stddev-sans-first:13.37 13:38:56 INFO - PROCESS | 4224 | Values: 83.0 82.0 84.0 83.0 84.0 84.0 85.0 84.0 124.0 91.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:137.50 stddev:4.30 (3.1%) stddev-sans-first:4.51 13:38:56 INFO - PROCESS | 4224 | Values: 137.0 134.0 131.0 130.0 137.0 140.0 128.0 138.0 140.0 138.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:1.57 (0.9%) stddev-sans-first:1.32 13:38:56 INFO - PROCESS | 4224 | Values: 171.0 169.0 170.0 168.0 168.0 168.0 168.0 169.0 166.0 166.0 13:38:56 INFO - PROCESS | 4224 | 13:38:56 INFO - PROCESS | 4224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 13:38:56 INFO - PROCESS | 4224 | Values: 67.0 66.0 67.0 66.0 66.0 71.0 66.0 67.0 66.0 67.0 13:38:56 INFO - PROCESS | 4224 | -------- Summary: end -------- 13:38:56 INFO - PROCESS | 4224 | 13:38:57 INFO - TEST-INFO | 4224: exit 0 13:38:57 INFO - TEST-OK | kraken | took 63670ms 13:38:57 INFO - SUITE-END | took 1182s 13:38:57 INFO - Completed test suite (00:19:42) 13:38:57 INFO - javascript benchmark 13:38:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.5243456177886, 2651.5890037044264, 2690.852003139828, 2696.285484346647, 2708.4853877763226, 4651.906961860761, 4669.836555720551, 4736.478987311393, 4745.525447455253, 4797.40032495938, 4693.694909830859, 4697.436307643079, 4697.553732395426, 4752.59602933751, 4776.832810851621, 4089.7546147231114, 4256.063665993476, 4336.241157797389, 4364.018095928423, 4480.372747815292, 4380.824767009316, 4415.690901636886, 4441.91173162574, 4448.0436706108185, 4475.328700694906, 4235.322348424237, 4269.082147338306, 4277.957220427787, 4283.528811830696, 4336.046069864625, 4281.914361712748, 4293.313069908831, 4346.826126954918, 4352.347147927804, 4353.172897149563, 4330.480342358906, 4340.153670034345, 4341.7829108544765, 4375.978120109411, 4380.67144964129, 4533.954660453386, 4585.335126406652, 4648.604868586174, 4648.790804413809, 4710.293455981596, 5114.0, 5122.718250496221, 5123.590112790967, 5145.434002259748, 5149.639525233235, 4988.90022199554, 5087.313212716273, 5133.281340612317, 5142.922856157161, 5155.639105262633, 4697.3893393858925, 4750.12122757291, 4756.025014871943, 4805.927911081337, 4815.711057336571, 5261.710605916712, 5284.128118860422, 5284.9471505284455, 5286.7092309922555, 5290.841274761763, 4893.804247830119, 4905.166121759309, 4948.678335908155, 4968.925466118011, 5015.272785446163, 5045.268436076748, 5045.293658887758, 5065.088284108822, 5065.949340506548, 5110.4123025852505, 5002.449730529639, 5009.348784658044, 5016.54851063406, 5024.924626130611, 5063.367079115111, 4887.853364399074, 4891.461939186686, 4949.802007919643, 4996.800127994839, 5002.199648056367, 4299.742015479082, 4306.2248795217165, 4308.267594508941, 4332.783360831946, 4340.934885976713, 3743.457198706172, 3749.606291339425, 3763.9247215055548, 3798.164403831153, 3812.4662547243406, 4304.74171549708, 4326.697131200849, 4357.7385356878685, 4361.127774445124, 4361.454818147731, 5083.847484575469, 5104.3109180260935, 5106.719130447861, 5111.616628752859, 5144.6913185209005, 4388.736675799399, 4392.297232442857, 4395.758233297135, 4420.734755914656, 4439.489458712224, 4433.6009759121835, 4532.79602417892, 4558.566936141061, 4571.862844114682, 4588.357629931812, 4794.232922732346, 4807.663463557517, 4816.422029356429, 4820.228763397839, 4868.537488938687, 5100.668456550312, 5113.411957624772, 5115.386153661584, 5116.204966841209, 5181.404138524118, 4664.580187783115, 4745.976270118627, 4770.284457331428, 4804.735739534359, 4815.061063092663, 5005.224190250517, 5021.397432308, 5029.748512574283, 5035.0, 5041.168207245763, 5000.449950505369, 5098.2352647103235, 5115.87210319745, 5120.692758434357, 5165.509276618715, 4896.6572339935865, 4935.580475659465, 4954.405471343462, 4984.825531106394, 5001.349824522788, 4925.6305777066145, 4933.358663373739, 4936.654434189572, 4946.727929963887, 4976.850694479172, 4769.070031343855, 4803.807847686054, 4859.805607775649, 4873.561379475864, 4923.261510773413, 4909.877253068702, 4937.975310123426, 4944.035912997075, 4961.404631444106, 5004.3494345734825, 4836.879078023077, 4853.733044682576, 4854.490278520704, 4860.173770459101, 4909.26361045846], "value": 4653.183793951791, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.552432529651, 596.7941060334184, 598.5211830535574, 615.114235500879, 619.8605313804393, 28506.429871402586, 31092.378152436966, 31125.221869453217, 31136.377272454567, 39410.60589394112, 38093.0, 42218.36672449916, 42297.78851105748, 42306.0, 42325.36511952316, 7649.464537482365, 7853.607319633996, 7857.764267071997, 7860.253275938805, 7869.134395216522, 7708.6916523339, 7739.767806965772, 7745.148033716287, 7746.651400686983, 7840.686372545091, 7766.068071831388, 7811.648475818573, 7815.843683126334, 7817.804554886116, 7822.100458447266, 7783.0, 7786.610669466504, 7788.0, 7851.528908265523, 7856.057273127232, 7817.843643127106, 7929.682812687485, 7943.841123177562, 7945.721899733481, 7949.562774047425, 37869.62130378689, 38350.80824595887, 38383.616163838284, 38396.23207535833, 38404.61595384038, 2926.2391778137626, 3054.328047829474, 3082.9075127746205, 3135.2318681922848, 3202.823844688541, 29519.819207231685, 29698.36658983755, 29869.55195672045, 30013.549796753065, 30189.547156792665, 3276.803391796476, 3327.8169700666454, 3361.8487168077495, 3388.271521622863, 3533.752637315389, 248787.0, 251660.0, 252398.0, 253475.73262133755, 254554.45396049198, 31222.375552489277, 55198.0, 55725.1641225382, 55809.0, 55885.720571397695, 32481.18797030046, 34615.307693845985, 34641.48037779385, 34704.30591388158, 34721.479177812354, 11904.464299106561, 12048.578299759467, 12051.819222711667, 12061.0, 12071.698207544707, 9868.111869931598, 9906.60373585063, 9949.204063674888, 9949.850752238723, 9951.402915825074, 7929.008873890763, 7966.721164759321, 7984.640691168911, 7986.840263194704, 8052.396070294634, 3126.609173853268, 3159.699828516287, 3179.8410079495934, 3188.9043328700177, 3189.2186414328175, 847.3433089355799, 861.9267362274152, 881.1400429197262, 903.9367244292968, 1048.1771809129796, 27868.581971270447, 28284.43431131407, 28469.715302847122, 28645.14064578066, 28681.56977645337, 769.2040475020692, 951.414879848888, 959.9280053995979, 988.2439933450916, 1023.6928921323573, 14913.552593422215, 15186.620334491727, 15205.847941520664, 15218.086914785148, 15479.458218962282, 399253.0, 402630.0, 403807.0, 404071.0, 404607.0, 49989.75005124951, 50376.748116259914, 50503.74748126309, 50514.747426262635, 50517.24224136641, 1109.1237922041496, 1165.0679456434818, 1197.1201167142144, 1203.9458224379923, 1251.5306759965194, 27764.16707498778, 29085.272868178465, 29171.562426564044, 29247.7075229245, 29445.558316625695, 41791.37312940369, 47741.283880741124, 48868.75565622149, 49186.508134919626, 53615.73192134014, 373264.0, 374554.0, 376853.0, 377835.0, 378396.0, 32151.839240803645, 38018.80990595029, 38424.48679623786, 39004.609953901236, 39453.210935781695, 42539.36190957076, 42764.60468247488, 42833.57166428296, 43280.0, 43763.34354984614, 36483.44615876863, 36778.26443471062, 37145.0, 37170.25659486849, 37283.627163728015, 36360.0202861939, 36372.818135909154, 36740.81629591835, 36981.0, 37161.62838371582, 36146.81926590455, 36297.320468409824, 36325.636743632225, 36568.0, 36649.267014660094, 32492.187695307806, 33881.0, 33923.66076339304, 33947.15132121717, 34118.0, 25103.874480628212, 25480.0, 25523.23430297094, 25641.30553433052, 25659.486810264065], "value": 16754.976138153583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.35251690833314, 376.43910573245853, 379.29829814842526, 394.5521832719862, 397.8289335585699, 15632.687346253068, 16252.106134162632, 16967.23647435865, 16994.15029248539, 17028.574285642866, 15919.761203581955, 16523.421680241194, 16547.58631034225, 16673.16634168293, 17319.740203896952, 4693.788779504914, 4771.308160316752, 4783.4499032611175, 4865.19724245499, 4869.586085182764, 3522.7534072614926, 5273.57811375091, 5556.972215138919, 5569.526590239814, 5679.034564124109, 5612.550995920337, 5660.29246344207, 5663.603547751659, 5678.716064196794, 5684.175794509814, 5433.755481003364, 5521.475459831349, 5563.471470210324, 5623.634463759863, 5677.716114194273, 3426.5202871597994, 3592.8203589820405, 3597.388443964532, 3640.726945479073, 5114.616403769732, 12112.757744845141, 12150.0, 12656.557020504239, 12663.176893501985, 12858.871411285862, 1800.2528950485532, 1854.8979806110658, 1885.8585606079598, 1977.7527809023873, 2299.563083014222, 9286.953565232197, 9517.524123793783, 9535.998720134425, 9600.95199524005, 10177.89822101777, 1595.9760603590955, 1685.148999755128, 1690.6449645574444, 1715.476779582227, 1772.3796671165119, 67406.0, 68437.0, 68502.65748671275, 68692.65653671749, 69461.0, 9533.617625444273, 9541.713748587554, 9628.71113866585, 9662.661806836726, 9691.466969316614, 13056.673583160496, 13093.803592946113, 13117.737645247042, 13127.737445251041, 13137.0, 6962.408195303456, 6963.338482844122, 6984.301569842975, 6995.930040699528, 7161.0, 6520.250171230275, 6733.7643182489355, 6809.897851532231, 6832.077669514552, 6858.897116543256, 4099.467069280974, 4168.645665118438, 4196.0, 4291.141771645684, 4555.908881822345, 1586.2703156547886, 1608.2200132935518, 1704.701677206484, 1708.8120306766245, 1823.5896923192176, 805.033959248892, 810.4326971120239, 824.5011767880346, 946.1910066892846, 951.2627713521938, 16039.759403608956, 16287.348506059861, 16365.590860228589, 16488.34046638121, 16769.0, 826.71065127205, 834.1533343656193, 861.8707193920962, 901.6889173235223, 958.5686441101532, 7282.8179295516975, 9189.90810091904, 9231.953840230755, 9364.719058428258, 9594.17710634991, 335894.0, 347970.0, 353376.0, 355843.0, 361888.0, 73625.26374736291, 73829.0, 76973.61513192399, 77007.61496192483, 77117.61441192759, 947.9526023698787, 948.3693343926212, 950.9286803489766, 973.5570315506427, 974.0648976982177, 14560.563183104523, 14574.271286435847, 14611.274125098033, 14726.705465890407, 15068.849311506745, 28814.279643009093, 32513.512297315086, 32562.51156232611, 33558.0, 35933.460998085575, 50125.749371254366, 50414.747926260134, 50532.49467505278, 50555.0, 50885.491145088075, 7224.0, 7430.591317477591, 7433.776986690408, 7504.061992250969, 7526.134494533198, 11110.777784444428, 11320.207585468937, 11401.942990284995, 11430.428478576205, 11565.479553419947, 4795.736234507136, 5497.45025497447, 9488.762780930532, 9611.279154063333, 9840.065193806577, 9802.16681582045, 10102.545385457819, 10182.643607473703, 10312.793744125225, 10369.222308327056, 10047.296689231976, 10062.496875156066, 10157.39055656663, 10332.17342612574, 10382.896171038194, 7274.381677557255, 7352.448566357438, 7367.152777430664, 7386.96306518464, 7471.813204669709, 8530.872036919327, 9908.702738917844, 10005.249606279704, 10093.798124037332, 10190.235732319958], "value": 7793.9876324367615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.222382123084, 1384.5015794314045, 1447.7321695486335, 1538.923053847308, 1761.1018380625876, 6805.727770889164, 7490.700371985121, 7700.614969251543, 7715.961420192898, 7928.5242885426915, 7705.267999540049, 7863.135055143944, 7865.0, 7875.330596899256, 7877.251661092201, 2144.6246906791325, 2196.2203417786695, 2200.7799220078023, 2204.40481070111, 2205.106931692667, 2134.6691262854283, 2161.2975782870553, 2208.536207396449, 2211.148707747521, 2212.391592312111, 2172.2940044485526, 2173.217641649005, 2183.9344819655435, 2186.04906865514, 2216.7007453993747, 2120.4486833423266, 2133.1040962795587, 2134.1356750516065, 2140.304401069651, 2140.518383363746, 2092.5814837032653, 2142.5179334649733, 2145.249162793026, 2148.967765483519, 2149.7635260121374, 7316.122065352139, 7496.850062998709, 7745.341645960044, 7793.415493837928, 7796.142424333319, 4674.462436819776, 4866.902661946777, 4868.63485238605, 4876.439209490918, 4882.462929077798, 2939.4562006028955, 3022.259546411143, 3081.2142903559675, 3082.4913889208256, 3095.411871744361, 870.3298460185622, 878.5519385113574, 904.2268860124565, 963.7590602349412, 986.9851952220722, 10558.260921735482, 10865.076468500187, 10877.292975956616, 10896.673099807018, 10901.890981090246, 4367.912641747211, 4439.356293337448, 4528.411306530196, 4539.114872599877, 4547.977260113745, 9279.072092790802, 9331.0, 9334.206592439583, 9346.11211934865, 9358.906410935804, 4881.560659540658, 4927.482614325516, 4943.8516844494725, 4944.1100601892, 4950.504949505093, 3721.981390093032, 3913.784741839226, 4262.0, 4287.97856010718, 4339.609435150852, 3712.3317802795755, 3779.16858291181, 3836.76979381238, 3876.689864810865, 3879.18537107205, 1234.6481252843075, 1249.562653071436, 1275.3431982529005, 1281.8397700287464, 1283.1787655900046, 829.4235506323048, 835.3776436554806, 836.9748907532784, 838.6268110690806, 859.0164261920191, 5025.874353141127, 5380.085385484477, 5404.216388623706, 5421.078416669176, 5434.266374039533, 400.42339031794126, 400.4753772557958, 401.8226596073533, 404.0504813687869, 407.22423782694017, 3172.175234439016, 3369.275605744777, 3384.2554637979606, 3414.078198886287, 3440.638732933006, 9163.258980793627, 9460.526973651427, 9495.0, 9500.0, 9506.714798556055, 9141.862872056925, 9313.53432328381, 9394.342396032212, 9397.107274808883, 9410.200132988773, 7306.96346518264, 7367.484276100621, 7490.550566966, 7493.812654683567, 7494.437917156235, 5431.809886654106, 5619.747111379916, 5673.319201695823, 5741.3397459291045, 5824.621399609012, 8726.389152759246, 8752.69365572202, 9132.543372831466, 9153.954230228806, 9197.264218862609, 9211.078892110736, 9217.631294748404, 9232.95383523105, 9310.627574897198, 9422.811543769223, 6074.878502430015, 6170.660613666291, 6398.264199616918, 6399.8720025598295, 6550.410463058348, 6739.865202696017, 7365.1530074042175, 7367.26327367259, 7374.0, 7378.262173782578, 6686.699098540675, 6848.794536163923, 6906.896396554156, 6935.583864968118, 7009.12385951756, 6783.89824152648, 6804.829879253059, 6809.046733457221, 6809.182898052265, 6892.483063770137, 6412.807615771534, 6465.967670161619, 6493.0, 6495.740170393131, 6505.251896032017, 4585.81656733727, 4693.577578017995, 4785.042991401664, 4803.375561177025, 4837.080954618611, 4524.864254072383, 4589.541045895384, 4598.435892570028, 4623.722576645412, 4676.836310729108], "value": 4093.170955805268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.3997365230018, 312.7748021424574, 317.21331098874805, 318.2632206442086, 321.4021919230231, 4582.541745825416, 4688.273317635763, 4693.3898593182885, 4754.714717116975, 4759.547842954918, 4540.97729511352, 4642.512536183703, 4645.281245939007, 4658.277966915133, 4659.9534004659945, 3698.5575625506076, 3723.720720945926, 3725.981370093146, 3732.253549290153, 3751.0997360633387, 3608.1520842601967, 3653.5798383185875, 3743.1390780120587, 3745.6067112953156, 3747.3254814133447, 3667.8166091695443, 3698.5561732592128, 3726.819810410913, 3748.756330838487, 3763.153290509641, 3682.576503702082, 3693.8707145249923, 3699.5560532735976, 3707.4428739929294, 3740.5698344690436, 3340.3987282289177, 3350.480675495302, 3356.2112903467664, 3367.7137443317347, 3373.7807042542404, 4365.995820961165, 4496.168208881368, 4506.6169375602785, 4531.660125490568, 4550.817967281305, 4244.8538894498315, 4252.383404406344, 4255.234057869582, 4275.482203817631, 4276.893077673052, 4792.496787837262, 4892.902141957176, 4924.482929292409, 4932.53140951609, 4939.135651261015, 3654.8903532894055, 3689.8524059037873, 3690.6493883081334, 3700.3709369406997, 3705.906757506542, 5205.713685747282, 5241.008416801591, 5243.816466423695, 5256.159014557691, 5260.605454590883, 3787.0496694202507, 3797.8290976906105, 3804.8312461896453, 3812.1041555234497, 3822.006278367589, 3644.6173151819207, 3840.231953609289, 3851.4030325299623, 3861.5366156061455, 3863.517060367454, 4265.53079161292, 4272.209641216385, 4282.186384586918, 4291.871243862689, 4310.612044915973, 4922.581580565692, 4941.802327906844, 4959.181735013754, 4974.67664601807, 4986.700797952062, 1228.5147366790068, 1277.4698500122531, 1314.2508770001198, 1319.874611911886, 1329.1325687409205, 854.6495936665937, 860.3934226370394, 867.4405008769309, 874.8775171475871, 878.3048715978096, 3938.2714197873483, 3946.3685810270217, 3974.6621537169085, 3978.8209530570616, 4006.5392479864604, 4520.276755719069, 4520.4575450946095, 4526.864194074183, 4531.799073245593, 4545.909081818345, 3962.306596345628, 3971.3645816669195, 3981.427336202184, 3988.720789544704, 3998.0, 2314.317276403465, 2400.7839294463583, 2422.3701837522017, 2434.9878250608635, 2442.291735396715, 4233.30150525166, 4301.548337424588, 4309.159713855831, 4332.9133417332105, 4352.912941741148, 4582.793774280165, 4584.633229341644, 4591.265397536378, 4630.699004564693, 4643.326717625925, 4045.959540404617, 4276.636485898734, 4298.645926533132, 4331.45856767904, 4335.934960975588, 4419.055615529157, 4446.866594002185, 4538.909221815479, 4546.772661366985, 4567.954320456753, 4406.537313582027, 4407.427034485625, 4411.551588868209, 4440.689151759346, 4465.950501632179, 4088.8568900088353, 4239.95760042408, 4273.465816772903, 4281.2293787118615, 4309.762963037063, 3441.535392722051, 3452.533907922398, 3458.0, 3467.8439470223398, 3483.9129021774656, 4497.2129877272, 4552.315643212033, 4571.451425828789, 4595.655325850507, 4895.485973972682, 4737.0, 4956.298817144593, 4978.228374601942, 4981.252812078073, 4983.25251212321, 4930.704157750546, 4949.554540091409, 4971.950280497149, 4992.400911890596, 5003.424606170337, 4787.54518320759, 4837.709737415626, 4923.286123511999, 4926.655134140719, 4942.481039490802, 5013.0, 5024.42219144803, 5026.924596131134, 5036.395632524121, 5037.798488060436, 4907.2393778964315, 4907.754612269301, 4912.803487860446, 4914.795875010503, 4916.844541532809], "value": 3640.2373691141415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8740370820273, 591.7485068845741, 624.2384291164781, 634.1407392982511, 728.6502478810171, 10836.674899753, 12333.938330308336, 12745.299008554526, 13341.33293335333, 13363.0, 13627.795583066261, 14130.788038179435, 14162.221077840715, 14167.008309418345, 14174.149551026945, 623.7099748616893, 782.4444644302552, 793.9245771651683, 807.2734538914995, 809.0736107157302, 801.32288216457, 806.9072056713466, 809.1584751858061, 809.76516810125, 809.8015986083418, 851.3317046118798, 856.0326830681321, 856.3192262151605, 856.9485830850138, 857.2113655437013, 846.1073567386405, 849.1338834388889, 849.3502470609926, 849.6643825688849, 850.171083193881, 622.551762730833, 624.5846512069513, 624.9906251406233, 625.3121566277059, 625.4746013348808, 12613.558525451564, 12632.0, 12638.178518396275, 12664.176828506117, 12771.872281277161, 11794.469248883821, 11875.881241187564, 11882.16824822254, 12052.698682533006, 12199.390030498529, 9980.750481238027, 10096.091351778301, 10105.89894101057, 10192.541335639915, 10391.948040259751, 3240.837958102109, 3292.818894960776, 3328.234506063619, 3393.558837351153, 3417.094469965461, 46631.533684663395, 46708.76645616784, 47293.52706472926, 49250.26124608134, 49301.99999999964, 9579.856302155335, 9627.951860240653, 9916.950415247878, 10149.238807089498, 10297.639582614722, 17023.48929532116, 17217.91391043062, 17232.138393080295, 17243.913780431016, 17261.482155535356, 5350.785968561214, 6874.621895795679, 7034.402075823612, 7129.394001509826, 7213.350798428167, 3862.088127452895, 3891.2606604745574, 3926.3521518949055, 3947.822347994347, 3960.32674445345, 2884.985575072153, 2989.925251868721, 3000.069978306732, 3000.804947678394, 3001.1146711720094, 566.3458705195505, 583.0670926517538, 599.4784537452445, 615.5168192968588, 619.9969000155061, 569.214484012069, 593.7209511529575, 605.6729366142322, 617.4720613875072, 618.0698049435571, 7295.978563001184, 7362.411007119417, 7426.888596671054, 7444.59054751983, 7612.657430415645, 592.4608606168453, 600.9699515024319, 602.5390576209204, 603.3966033966034, 607.6506009044817, 3682.981585092111, 3687.3731465650903, 3694.3165514379925, 3820.3505404081375, 3830.5020347354666, 58883.41116588865, 59962.402255864785, 59995.0, 60120.699396502736, 60293.0, 53448.465515344345, 53825.461745382825, 54441.0, 56110.438895610525, 56312.155317670266, 48686.75656621694, 48821.75589122032, 50399.0, 50639.0, 51056.23415648694, 7855.567943763148, 7860.685572577262, 7884.605769711607, 8023.438359314792, 8307.418480706534, 30623.693763062085, 31157.37685246237, 31192.064238072893, 31234.21914452157, 31888.202794930312, 32494.0, 34833.47749783705, 40570.1885962285, 40738.79630601828, 41084.79457602693, 10716.19628527848, 10914.0, 11131.220814542905, 11157.27477713946, 11245.0, 11370.488328025092, 11518.94240528792, 11530.308181509135, 11946.283223006647, 12437.502499899903, 10417.479126043516, 10631.255812093079, 10824.24230303871, 10979.505922233358, 11147.219694621299, 10806.0, 10869.945650272015, 10944.23390362667, 11054.170937179582, 11111.555537778399, 10775.407352595683, 11060.391678457761, 11088.0, 11416.143789215675, 11445.942770286096, 9608.9039109608, 9623.807523849344, 9667.564959576695, 9733.902660973583, 9948.35335703177, 9357.953210233905, 9473.905260947302, 9585.856212156963, 9594.712158635251, 9736.513174341113], "value": 6065.258436514082, "unit": "score"}], "name": "dromaeo_css", "value": 6165.339438159198, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 115.0, 113.0, 114.0, 114.0, 113.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 128.0, 135.0, 175.0, 129.0, 161.0, 153.0, 130.0, 177.0, 145.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 130.0, 75.0, 78.0, 76.0, 76.0, 105.0, 75.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 108.0, 84.0, 85.0, 86.0, 124.0, 84.0, 85.0, 124.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 148.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 64.0, 62.0, 65.0, 63.0, 64.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 83.0, 84.0, 84.0, 85.0, 84.0, 124.0, 91.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 131.0, 130.0, 137.0, 140.0, 128.0, 138.0, 140.0, 138.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 170.0, 168.0, 168.0, 168.0, 168.0, 169.0, 166.0, 166.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 71.0, 66.0, 67.0, 66.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1549.6000000000001, "alertThreshold": 2.0}]} 13:38:57 INFO - Return code: 0 13:38:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:38:57 ERROR - # TBPL SUCCESS # 13:38:57 INFO - Running post-action listener: _resource_record_post_action 13:38:57 INFO - ##### 13:38:57 INFO - ##### Finished run-tests step (success) 13:38:57 INFO - ##### 13:38:57 INFO - Running post-run listener: _resource_record_post_run 13:38:57 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 425984; Write bytes: 285888512; Read time: 52; Write time: 180108 13:38:57 INFO - TinderboxPrint: CPU usage
13.2% 13:38:57 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 52 13:38:57 INFO - TinderboxPrint: I/O write bytes / time
285,888,512 / 180,108 13:38:57 INFO - TinderboxPrint: CPU idle
8,309.0 (86.8%) 13:38:57 INFO - TinderboxPrint: CPU user
1,218.2 (12.7%) 13:38:57 INFO - TinderboxPrint: Swap in / out
0 / 0 13:38:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5193728; Read time: 0; Write time: 428 13:38:57 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 425984; Write bytes: 280694784; Read time: 52; Write time: 179680 13:38:58 INFO - Running post-run listener: _upload_blobber_files 13:38:58 INFO - Blob upload gear active. 13:38:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:58 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:38:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:59 INFO - (blobuploader) - INFO - Done attempting. 13:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:00 INFO - (blobuploader) - INFO - Done attempting. 13:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:05 INFO - (blobuploader) - INFO - Done attempting. 13:39:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:05 INFO - Return code: 0 13:39:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/350c565580c1c50c36750fbd5ce958cb6b0d42cd6fe142781f22f995906fcaec4c9ad6eefa30629373c220096b3bf6204e4b4ca80d22f646639210dac33fd004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ff84af888e9fc8363ff34691d868ac7fd8652a46c9697a8b3243ef66de707fbbfc6ad01ac579090bb9eec81701e7bd7501c799f2b8513df743473dfb78954ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa19af3313809345aa2b306591c374a8723ec51a2620f50b1f537258769415720f29e3795ba1a939df8868bbaf3d6c3451639e7da280ad784b1f7840ecff5d1b"} 13:39:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:05 INFO - Contents: 13:39:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/350c565580c1c50c36750fbd5ce958cb6b0d42cd6fe142781f22f995906fcaec4c9ad6eefa30629373c220096b3bf6204e4b4ca80d22f646639210dac33fd004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ff84af888e9fc8363ff34691d868ac7fd8652a46c9697a8b3243ef66de707fbbfc6ad01ac579090bb9eec81701e7bd7501c799f2b8513df743473dfb78954ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa19af3313809345aa2b306591c374a8723ec51a2620f50b1f537258769415720f29e3795ba1a939df8868bbaf3d6c3451639e7da280ad784b1f7840ecff5d1b"} 13:39:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:05 INFO - Copying logs to upload dir... 13:39:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.103589 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-29 13:39:05.022251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 13:39:05.026047) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/350c565580c1c50c36750fbd5ce958cb6b0d42cd6fe142781f22f995906fcaec4c9ad6eefa30629373c220096b3bf6204e4b4ca80d22f646639210dac33fd004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ff84af888e9fc8363ff34691d868ac7fd8652a46c9697a8b3243ef66de707fbbfc6ad01ac579090bb9eec81701e7bd7501c799f2b8513df743473dfb78954ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa19af3313809345aa2b306591c374a8723ec51a2620f50b1f537258769415720f29e3795ba1a939df8868bbaf3d6c3451639e7da280ad784b1f7840ecff5d1b"} build_url:https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/RUBG0kN4TWOMfkMiBk8JbA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/350c565580c1c50c36750fbd5ce958cb6b0d42cd6fe142781f22f995906fcaec4c9ad6eefa30629373c220096b3bf6204e4b4ca80d22f646639210dac33fd004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ff84af888e9fc8363ff34691d868ac7fd8652a46c9697a8b3243ef66de707fbbfc6ad01ac579090bb9eec81701e7bd7501c799f2b8513df743473dfb78954ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa19af3313809345aa2b306591c374a8723ec51a2620f50b1f537258769415720f29e3795ba1a939df8868bbaf3d6c3451639e7da280ad784b1f7840ecff5d1b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 13:39:05.052930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:39:05.053323) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464551797.564105-1447688193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 13:39:05.137175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 13:39:05.137563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 13:39:05.137911) ========= ========= Total master_lag: 0.17 =========