builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1463422212.27 results: success (0) buildid: 20160516083029 builduid: 8f664dff4974456ab19959ee3e861b6c revision: e9533997fcef31fa5d2db464c6ceec0ca6ea560f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.275138) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.275509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.275773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.293222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.293487) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 11:10:15-- 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% 227M=0s 2016-05-16 11:10:15 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.414816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.415108) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014834 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.465962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.466265) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e9533997fcef31fa5d2db464c6ceec0ca6ea560f --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 e9533997fcef31fa5d2db464c6ceec0ca6ea560f --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=3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 11:10:15,731 truncating revision to first 12 chars 2016-05-16 11:10:15,731 Setting DEBUG logging. 2016-05-16 11:10:15,731 attempt 1/10 2016-05-16 11:10:15,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e9533997fcef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 11:10:15,982 unpacking tar archive at: fx-team-e9533997fcef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.506355 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.985076) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.985370) ========= script_repo_revision: e9533997fcef31fa5d2db464c6ceec0ca6ea560f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.985778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.986040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 11:10:12.994037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-16 11:10:12.994302) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:10:16 INFO - MultiFileLogger online at 20160516 11:10:16 in /builds/slave/test 11:10:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:10:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:10:16 INFO - {'append_to_log': False, 11:10:16 INFO - 'base_work_dir': '/builds/slave/test', 11:10:16 INFO - 'blob_upload_branch': 'Fx-Team', 11:10:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:10:16 INFO - 'branch': 'Fx-Team', 11:10:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:10:16 INFO - 'config_files': ('talos/linux_config.py',), 11:10:16 INFO - 'default_actions': ('clobber', 11:10:16 INFO - 'read-buildbot-config', 11:10:16 INFO - 'download-and-extract', 11:10:16 INFO - 'populate-webroot', 11:10:16 INFO - 'create-virtualenv', 11:10:16 INFO - 'install', 11:10:16 INFO - 'run-tests'), 11:10:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:10:16 INFO - 'download_minidump_stackwalk': True, 11:10:16 INFO - 'download_symbols': 'ondemand', 11:10:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:10:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:10:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:10:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:10:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:10:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:10:16 INFO - 'installer_path': 'installer.exe', 11:10:16 INFO - 'log_level': 'info', 11:10:16 INFO - 'log_name': 'talos', 11:10:16 INFO - 'log_to_console': True, 11:10:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:10:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:10:16 INFO - 'opt_config_files': (), 11:10:16 INFO - 'pip_index': False, 11:10:16 INFO - 'sps_profile': False, 11:10:16 INFO - 'sps_profile_interval': 0, 11:10:16 INFO - 'suite': 'dromaeojs', 11:10:16 INFO - 'system_bits': '32', 11:10:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:10:16 INFO - 'title': 'talos-linux64-ix-059', 11:10:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:10:16 INFO - 'use_talos_json': True, 11:10:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:10:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:10:16 INFO - 'work_dir': 'build'} 11:10:16 INFO - ##### 11:10:16 INFO - ##### Running clobber step. 11:10:16 INFO - ##### 11:10:16 INFO - Running pre-action listener: _resource_record_pre_action 11:10:16 INFO - Running main action method: clobber 11:10:16 INFO - rmtree: /builds/slave/test/build 11:10:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:10:17 INFO - Running post-action listener: _resource_record_post_action 11:10:17 INFO - ##### 11:10:17 INFO - ##### Finished clobber step (success) 11:10:17 INFO - ##### 11:10:17 INFO - ##### 11:10:17 INFO - ##### Running read-buildbot-config step. 11:10:17 INFO - ##### 11:10:17 INFO - Running pre-action listener: _resource_record_pre_action 11:10:17 INFO - Running main action method: read_buildbot_config 11:10:17 INFO - Using buildbot properties: 11:10:17 INFO - { 11:10:17 INFO - "project": "", 11:10:17 INFO - "product": "firefox", 11:10:17 INFO - "script_repo_revision": "production", 11:10:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:10:17 INFO - "repository": "", 11:10:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:10:17 INFO - "buildid": "20160516083029", 11:10:17 INFO - "pgo_build": "True", 11:10:17 INFO - "basedir": "/builds/slave/test", 11:10:17 INFO - "buildnumber": 685, 11:10:17 INFO - "slavename": "talos-linux64-ix-059", 11:10:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:10:17 INFO - "platform": "ubuntu64_hw", 11:10:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:10:17 INFO - "branch": "fx-team", 11:10:17 INFO - "repo_path": "integration/fx-team", 11:10:17 INFO - "revision": "e9533997fcef31fa5d2db464c6ceec0ca6ea560f", 11:10:17 INFO - "stage_platform": "linux64-pgo", 11:10:17 INFO - "builduid": "8f664dff4974456ab19959ee3e861b6c", 11:10:17 INFO - "slavebuilddir": "test" 11:10:17 INFO - } 11:10:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:10:17 INFO - Running post-action listener: _resource_record_post_action 11:10:17 INFO - ##### 11:10:17 INFO - ##### Finished read-buildbot-config step (success) 11:10:17 INFO - ##### 11:10:17 INFO - ##### 11:10:17 INFO - ##### Running download-and-extract step. 11:10:17 INFO - ##### 11:10:17 INFO - Running pre-action listener: _resource_record_pre_action 11:10:17 INFO - Running main action method: download_and_extract 11:10:17 INFO - mkdir: /builds/slave/test/build/tests 11:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:17 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:10:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:10:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:10:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:28 INFO - Downloaded 1361 bytes. 11:10:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:10:28 INFO - Using the following test package requirements: 11:10:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:10:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:10:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'jsshell-linux-x86_64.zip'], 11:10:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:10:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:10:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:10:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:10:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:10:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:10:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:10:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:10: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')]} 11:10:28 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:39 INFO - Downloaded 24023786 bytes. 11:10:39 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'] 11:10:39 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 11:10:40 INFO - Return code: 0 11:10:40 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 11:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:40 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:42 INFO - Downloaded 24023786 bytes. 11:10:42 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'] 11:10:42 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 11:10:43 INFO - Return code: 0 11:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:43 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:45 INFO - Downloaded 10840194 bytes. 11:10:45 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'] 11:10:45 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 11:10:45 INFO - Return code: 0 11:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:45 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/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 11:10:47 INFO - Downloaded 58395842 bytes. 11:10:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:10:47 INFO - mkdir: /builds/slave/test/properties 11:10:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:10:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:10:47 INFO - Contents: 11:10:47 INFO - build_url:https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:10:47 INFO - Running post-action listener: _resource_record_post_action 11:10:47 INFO - Running post-action listener: set_extra_try_arguments 11:10:47 INFO - ##### 11:10:47 INFO - ##### Finished download-and-extract step (success) 11:10:47 INFO - ##### 11:10:47 INFO - ##### 11:10:47 INFO - ##### Running populate-webroot step. 11:10:47 INFO - ##### 11:10:47 INFO - Running pre-action listener: _resource_record_pre_action 11:10:47 INFO - Running main action method: populate_webroot 11:10:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:10:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:10:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:10:47 INFO - '--tppagecycles', 11:10:47 INFO - '7'], 11:10:47 INFO - 'tests': ['tsvgm']}}, 11:10:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:10:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:10:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:10:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:10:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['damp', 'tps']}, 11:10:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'tests': ['damp', 'tps']}, 11:10:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['dromaeo_dom']}, 11:10:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:10:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['a11yr', 11:10:47 INFO - 'ts_paint', 11:10:47 INFO - 'tpaint', 11:10:47 INFO - 'sessionrestore', 11:10:47 INFO - 'sessionrestore_no_auto_restore', 11:10:47 INFO - 'tabpaint']}, 11:10:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:10:47 INFO - 'ts_paint', 11:10:47 INFO - 'tpaint', 11:10:47 INFO - 'sessionrestore', 11:10:47 INFO - 'sessionrestore_no_auto_restore', 11:10:47 INFO - 'tabpaint']}, 11:10:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:10:47 INFO - 'ts_paint', 11:10:47 INFO - 'tpaint', 11:10:47 INFO - 'sessionrestore', 11:10:47 INFO - 'sessionrestore_no_auto_restore', 11:10:47 INFO - 'tabpaint']}, 11:10:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:10:47 INFO - 'ts_paint', 11:10:47 INFO - 'tpaint', 11:10:47 INFO - 'sessionrestore', 11:10:47 INFO - 'sessionrestore_no_auto_restore', 11:10:47 INFO - 'tabpaint']}, 11:10:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['a11yr', 11:10:47 INFO - 'ts_paint', 11:10:47 INFO - 'tpaint', 11:10:47 INFO - 'sessionrestore', 11:10:47 INFO - 'sessionrestore_no_auto_restore', 11:10:47 INFO - 'tabpaint']}, 11:10:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['a11yr', 11:10:47 INFO - 'ts_paint', 11:10:47 INFO - 'tpaint', 11:10:47 INFO - 'sessionrestore', 11:10:47 INFO - 'sessionrestore_no_auto_restore', 11:10:47 INFO - 'tabpaint']}, 11:10:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['tsvgx', 11:10:47 INFO - 'tsvgr_opacity', 11:10:47 INFO - 'tart', 11:10:47 INFO - 'tscrollx', 11:10:47 INFO - 'cart']}, 11:10:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:10:47 INFO - 'tsvgr_opacity', 11:10:47 INFO - 'tart', 11:10:47 INFO - 'tscrollx', 11:10:47 INFO - 'cart']}, 11:10:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'talos_options': ['--disable-e10s'], 11:10:47 INFO - 'tests': ['tp5o']}, 11:10:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'tests': ['tp5o']}, 11:10:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'talos_options': ['--disable-e10s', 11:10:47 INFO - '--xperf_path', 11:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:47 INFO - 'tests': ['tp5n']}, 11:10:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:47 INFO - 'talos_options': ['--xperf_path', 11:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:47 INFO - 'tests': ['tp5n']}}, 11:10:47 INFO - 'talos.zip': {'path': '', 11:10:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:10:47 INFO - Running post-action listener: _resource_record_post_action 11:10:47 INFO - ##### 11:10:47 INFO - ##### Finished populate-webroot step (success) 11:10:47 INFO - ##### 11:10:47 INFO - ##### 11:10:47 INFO - ##### Running create-virtualenv step. 11:10:47 INFO - ##### 11:10:47 INFO - Running pre-action listener: _resource_record_pre_action 11:10:47 INFO - Running main action method: create_virtualenv 11:10:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:10:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:10:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:10:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:10:47 INFO - Using real prefix '/usr' 11:10:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:10:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:10:50 INFO - Installing pip.................done. 11:10:50 INFO - Return code: 0 11:10:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:50 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:10:50 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 11:10:50 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 11:10:50 INFO - Using env: {'DISPLAY': ':0', 11:10:50 INFO - 'HOME': '/home/cltbld', 11:10:50 INFO - 'LANG': 'en_US.UTF-8', 11:10:50 INFO - 'LANGUAGE': 'en_US:en', 11:10:50 INFO - 'LOGNAME': 'cltbld', 11:10:50 INFO - 'MAIL': '/var/mail/cltbld', 11:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:50 INFO - 'MOZ_NO_REMOTE': '1', 11:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:50 INFO - 'NO_EM_RESTART': '1', 11:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:50 INFO - 'PWD': '/builds/slave/test', 11:10:50 INFO - 'SHELL': '/bin/bash', 11:10:50 INFO - 'SHLVL': '1', 11:10:50 INFO - 'TERM': 'linux', 11:10:50 INFO - 'TMOUT': '86400', 11:10:50 INFO - 'USER': 'cltbld', 11:10:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:50 INFO - '_': '/tools/buildbot/bin/python'} 11:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:10:50 INFO - Cleaning up... 11:10:50 INFO - Return code: 0 11:10:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:50 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:10:50 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 11:10:50 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 11:10:50 INFO - Using env: {'DISPLAY': ':0', 11:10:50 INFO - 'HOME': '/home/cltbld', 11:10:50 INFO - 'LANG': 'en_US.UTF-8', 11:10:50 INFO - 'LANGUAGE': 'en_US:en', 11:10:50 INFO - 'LOGNAME': 'cltbld', 11:10:50 INFO - 'MAIL': '/var/mail/cltbld', 11:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:50 INFO - 'MOZ_NO_REMOTE': '1', 11:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:50 INFO - 'NO_EM_RESTART': '1', 11:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:50 INFO - 'PWD': '/builds/slave/test', 11:10:50 INFO - 'SHELL': '/bin/bash', 11:10:50 INFO - 'SHLVL': '1', 11:10:50 INFO - 'TERM': 'linux', 11:10:50 INFO - 'TMOUT': '86400', 11:10:50 INFO - 'USER': 'cltbld', 11:10:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:50 INFO - '_': '/tools/buildbot/bin/python'} 11:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:50 INFO - Downloading/unpacking psutil>=3.1.1 11:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:10:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:52 INFO - Installing collected packages: psutil 11:10:52 INFO - Running setup.py install for psutil 11:10:52 INFO - building 'psutil._psutil_linux' extension 11:10:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:10:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:10:53 INFO - building 'psutil._psutil_posix' extension 11:10:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:10:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:10:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:53 INFO - Successfully installed psutil 11:10:53 INFO - Cleaning up... 11:10:53 INFO - Return code: 0 11:10:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:53 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:10:53 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 11:10:53 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 11:10:53 INFO - Using env: {'DISPLAY': ':0', 11:10:53 INFO - 'HOME': '/home/cltbld', 11:10:53 INFO - 'LANG': 'en_US.UTF-8', 11:10:53 INFO - 'LANGUAGE': 'en_US:en', 11:10:53 INFO - 'LOGNAME': 'cltbld', 11:10:53 INFO - 'MAIL': '/var/mail/cltbld', 11:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:53 INFO - 'MOZ_NO_REMOTE': '1', 11:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:53 INFO - 'NO_EM_RESTART': '1', 11:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:53 INFO - 'PWD': '/builds/slave/test', 11:10:53 INFO - 'SHELL': '/bin/bash', 11:10:53 INFO - 'SHLVL': '1', 11:10:53 INFO - 'TERM': 'linux', 11:10:53 INFO - 'TMOUT': '86400', 11:10:53 INFO - 'USER': 'cltbld', 11:10:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:53 INFO - '_': '/tools/buildbot/bin/python'} 11:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:10:55 INFO - Installing collected packages: mozsystemmonitor 11:10:55 INFO - Running setup.py install for mozsystemmonitor 11:10:55 INFO - Successfully installed mozsystemmonitor 11:10:55 INFO - Cleaning up... 11:10:55 INFO - Return code: 0 11:10:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:55 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:10:55 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 11:10:55 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 11:10:55 INFO - Using env: {'DISPLAY': ':0', 11:10:55 INFO - 'HOME': '/home/cltbld', 11:10:55 INFO - 'LANG': 'en_US.UTF-8', 11:10:55 INFO - 'LANGUAGE': 'en_US:en', 11:10:55 INFO - 'LOGNAME': 'cltbld', 11:10:55 INFO - 'MAIL': '/var/mail/cltbld', 11:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:55 INFO - 'MOZ_NO_REMOTE': '1', 11:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:55 INFO - 'NO_EM_RESTART': '1', 11:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:55 INFO - 'PWD': '/builds/slave/test', 11:10:55 INFO - 'SHELL': '/bin/bash', 11:10:55 INFO - 'SHLVL': '1', 11:10:55 INFO - 'TERM': 'linux', 11:10:55 INFO - 'TMOUT': '86400', 11:10:55 INFO - 'USER': 'cltbld', 11:10:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:55 INFO - '_': '/tools/buildbot/bin/python'} 11:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:10: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 11:10: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 11:10: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 11:10: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 11:10: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 11:10: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 11:10:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:10:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:10:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:58 INFO - Downloading docopt-0.6.1.tar.gz 11:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:10:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:10:58 INFO - Running setup.py install for blobuploader 11:10:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:10:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:10:58 INFO - Running setup.py install for requests 11:10:59 INFO - Running setup.py install for docopt 11:10:59 INFO - Successfully installed blobuploader requests docopt 11:10:59 INFO - Cleaning up... 11:10:59 INFO - Return code: 0 11:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 11:10:59 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 11:10:59 INFO - Using env: {'DISPLAY': ':0', 11:10:59 INFO - 'HOME': '/home/cltbld', 11:10:59 INFO - 'LANG': 'en_US.UTF-8', 11:10:59 INFO - 'LANGUAGE': 'en_US:en', 11:10:59 INFO - 'LOGNAME': 'cltbld', 11:10:59 INFO - 'MAIL': '/var/mail/cltbld', 11:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:59 INFO - 'MOZ_NO_REMOTE': '1', 11:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:59 INFO - 'NO_EM_RESTART': '1', 11:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:59 INFO - 'PWD': '/builds/slave/test', 11:10:59 INFO - 'SHELL': '/bin/bash', 11:10:59 INFO - 'SHLVL': '1', 11:10:59 INFO - 'TERM': 'linux', 11:10:59 INFO - 'TMOUT': '86400', 11:10:59 INFO - 'USER': 'cltbld', 11:10:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:59 INFO - '_': '/tools/buildbot/bin/python'} 11:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:10:59 INFO - Running setup.py (path:/tmp/pip-Wfji2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:10:59 INFO - Running setup.py (path:/tmp/pip-LRqMZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:10:59 INFO - Running setup.py (path:/tmp/pip-5ihe2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:10:59 INFO - Running setup.py (path:/tmp/pip-CP6vyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:10:59 INFO - Running setup.py (path:/tmp/pip-5FDVj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:10:59 INFO - Running setup.py (path:/tmp/pip-2qYHHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:10:59 INFO - Running setup.py (path:/tmp/pip-O51Hb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:10:59 INFO - Running setup.py (path:/tmp/pip-Rfp3UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:00 INFO - Running setup.py (path:/tmp/pip-HNIrgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:00 INFO - Running setup.py (path:/tmp/pip-sGvUGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:00 INFO - Running setup.py (path:/tmp/pip-o4YbDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:00 INFO - Running setup.py (path:/tmp/pip-Q3GRVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:00 INFO - Running setup.py (path:/tmp/pip-CmD6x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:00 INFO - Running setup.py (path:/tmp/pip-hJMjMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:00 INFO - Running setup.py (path:/tmp/pip-9suRbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:00 INFO - Running setup.py (path:/tmp/pip-z9AuYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:00 INFO - Running setup.py (path:/tmp/pip-ttUUJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:00 INFO - Running setup.py install for manifestparser 11:11:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:11:00 INFO - Running setup.py install for mozcrash 11:11:00 INFO - Running setup.py install for mozdebug 11:11:00 INFO - Running setup.py install for mozdevice 11:11:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Running setup.py install for mozfile 11:11:01 INFO - Running setup.py install for mozhttpd 11:11:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Running setup.py install for mozinfo 11:11:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Running setup.py install for mozInstall 11:11:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Running setup.py install for mozleak 11:11:01 INFO - Running setup.py install for mozlog 11:11:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Running setup.py install for moznetwork 11:11:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:11:01 INFO - Running setup.py install for mozprocess 11:11:01 INFO - Running setup.py install for mozprofile 11:11:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:11:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:11:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:11:02 INFO - Running setup.py install for mozrunner 11:11:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:11:02 INFO - Running setup.py install for mozscreenshot 11:11:02 INFO - Running setup.py install for moztest 11:11:02 INFO - Running setup.py install for mozversion 11:11:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:11:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:02 INFO - Cleaning up... 11:11:02 INFO - Return code: 0 11:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:02 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:02 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 11:11:02 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 11:11:02 INFO - Using env: {'DISPLAY': ':0', 11:11:02 INFO - 'HOME': '/home/cltbld', 11:11:02 INFO - 'LANG': 'en_US.UTF-8', 11:11:02 INFO - 'LANGUAGE': 'en_US:en', 11:11:02 INFO - 'LOGNAME': 'cltbld', 11:11:02 INFO - 'MAIL': '/var/mail/cltbld', 11:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:02 INFO - 'MOZ_NO_REMOTE': '1', 11:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:02 INFO - 'NO_EM_RESTART': '1', 11:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:02 INFO - 'PWD': '/builds/slave/test', 11:11:02 INFO - 'SHELL': '/bin/bash', 11:11:02 INFO - 'SHLVL': '1', 11:11:02 INFO - 'TERM': 'linux', 11:11:02 INFO - 'TMOUT': '86400', 11:11:02 INFO - 'USER': 'cltbld', 11:11:02 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:02 INFO - '_': '/tools/buildbot/bin/python'} 11:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:11:02 INFO - Running setup.py (path:/tmp/pip-LQILyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:11:02 INFO - Running setup.py (path:/tmp/pip-xtu2Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:11:02 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)) 11:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:11:02 INFO - Running setup.py (path:/tmp/pip-efgURw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:11:02 INFO - Running setup.py (path:/tmp/pip-1QBiau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:11:02 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)) 11:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:11:02 INFO - Running setup.py (path:/tmp/pip-iw5kd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:11:03 INFO - Running setup.py (path:/tmp/pip-R9nPlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:11:03 INFO - Running setup.py (path:/tmp/pip-Bua4tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:11:03 INFO - Running setup.py (path:/tmp/pip-Sg3eFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:11:03 INFO - Running setup.py (path:/tmp/pip-rb1qb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:11:03 INFO - Running setup.py (path:/tmp/pip-TzEbYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:11:03 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)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:11:03 INFO - Running setup.py (path:/tmp/pip-sTfBOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:11:03 INFO - Running setup.py (path:/tmp/pip-f4wjpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:11:03 INFO - Running setup.py (path:/tmp/pip-DXfHbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:11:03 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)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:11:03 INFO - Running setup.py (path:/tmp/pip-sMpomp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:03 INFO - Running setup.py (path:/tmp/pip-We0JJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:11:03 INFO - Running setup.py (path:/tmp/pip-2n23pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:11:03 INFO - Running setup.py (path:/tmp/pip-i33UWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:11:03 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)) 11:11:03 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)) 11:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:11:03 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)) 11:11:03 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)) 11:11:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:05 INFO - Downloading blessings-1.6.tar.gz 11:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:11:05 INFO - Installing collected packages: blessings 11:11:05 INFO - Running setup.py install for blessings 11:11:05 INFO - Successfully installed blessings 11:11:05 INFO - Cleaning up... 11:11:06 INFO - Return code: 0 11:11:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:06 INFO - Reading from file tmpfile_stdout 11:11:06 INFO - Current package versions: 11:11:06 INFO - argparse == 1.2.1 11:11:06 INFO - blessings == 1.6 11:11:06 INFO - blobuploader == 1.2.4 11:11:06 INFO - docopt == 0.6.1 11:11:06 INFO - manifestparser == 1.1 11:11:06 INFO - mozInstall == 1.12 11:11:06 INFO - mozcrash == 0.17 11:11:06 INFO - mozdebug == 0.1 11:11:06 INFO - mozdevice == 0.48 11:11:06 INFO - mozfile == 1.2 11:11:06 INFO - mozhttpd == 0.7 11:11:06 INFO - mozinfo == 0.9 11:11:06 INFO - mozleak == 0.1 11:11:06 INFO - mozlog == 3.2 11:11:06 INFO - moznetwork == 0.27 11:11:06 INFO - mozprocess == 0.22 11:11:06 INFO - mozprofile == 0.28 11:11:06 INFO - mozrunner == 6.11 11:11:06 INFO - mozscreenshot == 0.1 11:11:06 INFO - mozsystemmonitor == 0.3 11:11:06 INFO - moztest == 0.7 11:11:06 INFO - mozversion == 1.4 11:11:06 INFO - psutil == 3.1.1 11:11:06 INFO - requests == 1.2.3 11:11:06 INFO - wsgiref == 0.1.2 11:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:06 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:06 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 11:11:06 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 11:11:06 INFO - Using env: {'DISPLAY': ':0', 11:11:06 INFO - 'HOME': '/home/cltbld', 11:11:06 INFO - 'LANG': 'en_US.UTF-8', 11:11:06 INFO - 'LANGUAGE': 'en_US:en', 11:11:06 INFO - 'LOGNAME': 'cltbld', 11:11:06 INFO - 'MAIL': '/var/mail/cltbld', 11:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:06 INFO - 'MOZ_NO_REMOTE': '1', 11:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:06 INFO - 'NO_EM_RESTART': '1', 11:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:06 INFO - 'PWD': '/builds/slave/test', 11:11:06 INFO - 'SHELL': '/bin/bash', 11:11:06 INFO - 'SHLVL': '1', 11:11:06 INFO - 'TERM': 'linux', 11:11:06 INFO - 'TMOUT': '86400', 11:11:06 INFO - 'USER': 'cltbld', 11:11:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:06 INFO - '_': '/tools/buildbot/bin/python'} 11:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 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)) 11:11:06 INFO - Cleaning up... 11:11:06 INFO - Return code: 0 11:11:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:06 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:06 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 11:11:06 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 11:11:06 INFO - Using env: {'DISPLAY': ':0', 11:11:06 INFO - 'HOME': '/home/cltbld', 11:11:06 INFO - 'LANG': 'en_US.UTF-8', 11:11:06 INFO - 'LANGUAGE': 'en_US:en', 11:11:06 INFO - 'LOGNAME': 'cltbld', 11:11:06 INFO - 'MAIL': '/var/mail/cltbld', 11:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:06 INFO - 'MOZ_NO_REMOTE': '1', 11:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:06 INFO - 'NO_EM_RESTART': '1', 11:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:06 INFO - 'PWD': '/builds/slave/test', 11:11:06 INFO - 'SHELL': '/bin/bash', 11:11:06 INFO - 'SHLVL': '1', 11:11:06 INFO - 'TERM': 'linux', 11:11:06 INFO - 'TMOUT': '86400', 11:11:06 INFO - 'USER': 'cltbld', 11:11:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:06 INFO - '_': '/tools/buildbot/bin/python'} 11:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:06 INFO - Downloading/unpacking jsonschema 11:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:08 INFO - Downloading/unpacking functools32 (from jsonschema) 11:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:08 INFO - warning: no files found matching '*.txt' 11:11:08 INFO - no previously-included directories found matching 'build' 11:11:08 INFO - no previously-included directories found matching 'dist' 11:11:08 INFO - no previously-included directories found matching '.git*' 11:11:08 INFO - Installing collected packages: jsonschema, functools32 11:11:08 INFO - Running setup.py install for functools32 11:11:09 INFO - warning: no files found matching '*.txt' 11:11:09 INFO - no previously-included directories found matching 'build' 11:11:09 INFO - no previously-included directories found matching 'dist' 11:11:09 INFO - no previously-included directories found matching '.git*' 11:11:09 INFO - Successfully installed jsonschema functools32 11:11:09 INFO - Cleaning up... 11:11:09 INFO - Return code: 0 11:11:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:09 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 0x7f9809a74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:11:09 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 11:11:09 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 11:11:09 INFO - Using env: {'DISPLAY': ':0', 11:11:09 INFO - 'HOME': '/home/cltbld', 11:11:09 INFO - 'LANG': 'en_US.UTF-8', 11:11:09 INFO - 'LANGUAGE': 'en_US:en', 11:11:09 INFO - 'LOGNAME': 'cltbld', 11:11:09 INFO - 'MAIL': '/var/mail/cltbld', 11:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:09 INFO - 'MOZ_NO_REMOTE': '1', 11:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:09 INFO - 'NO_EM_RESTART': '1', 11:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:09 INFO - 'PWD': '/builds/slave/test', 11:11:09 INFO - 'SHELL': '/bin/bash', 11:11:09 INFO - 'SHLVL': '1', 11:11:09 INFO - 'TERM': 'linux', 11:11:09 INFO - 'TMOUT': '86400', 11:11:09 INFO - 'USER': 'cltbld', 11:11:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:09 INFO - '_': '/tools/buildbot/bin/python'} 11:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:09 INFO - Downloading/unpacking flake8 11:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:11:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:11:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:11:11 INFO - no previously-included directories found matching 'docs/_build' 11:11:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:11:12 INFO - Running setup.py install for pep8 11:11:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:11:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:11:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:11:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:11:12 INFO - no previously-included directories found matching 'docs/_build' 11:11:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:11:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:11:12 INFO - Cleaning up... 11:11:12 INFO - Return code: 0 11:11:12 INFO - Running post-action listener: _resource_record_post_action 11:11:12 INFO - Running post-action listener: _start_resource_monitoring 11:11:12 INFO - Starting resource monitoring. 11:11:12 INFO - ##### 11:11:12 INFO - ##### Finished create-virtualenv step (success) 11:11:12 INFO - ##### 11:11:12 INFO - ##### 11:11:12 INFO - ##### Running install step. 11:11:12 INFO - ##### 11:11:12 INFO - Running pre-action listener: _resource_record_pre_action 11:11:12 INFO - Running main action method: install 11:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:11:12 INFO - Reading from file tmpfile_stdout 11:11:12 INFO - Detecting whether we're running mozinstall >=1.0... 11:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:11:12 INFO - Reading from file tmpfile_stdout 11:11:12 INFO - Output received: 11:11:12 INFO - Usage: mozinstall [options] installer 11:11:12 INFO - Options: 11:11:12 INFO - -h, --help show this help message and exit 11:11:12 INFO - -d DEST, --destination=DEST 11:11:12 INFO - Directory to install application into. [default: 11:11:12 INFO - "/builds/slave/test"] 11:11:12 INFO - --app=APP Application being installed. [default: firefox] 11:11:12 INFO - mkdir: /builds/slave/test/build/application 11:11:12 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'] 11:11:12 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 11:11:29 INFO - Reading from file tmpfile_stdout 11:11:29 INFO - Output received: 11:11:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:11:29 INFO - Running post-action listener: _resource_record_post_action 11:11:29 INFO - ##### 11:11:29 INFO - ##### Finished install step (success) 11:11:29 INFO - ##### 11:11:29 INFO - ##### 11:11:29 INFO - ##### Running run-tests step. 11:11:29 INFO - ##### 11:11:29 INFO - Running pre-action listener: _resource_record_pre_action 11:11:29 INFO - Running main action method: run_tests 11:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:11:29 INFO - Python 2.7.3 11:11:29 INFO - Return code: 0 11:11:29 INFO - grabbing minidump binary from tooltool 11:11: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')]} 11:11:29 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 0x19fd9c0>, '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 0x19fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:11:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:11:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:11:29 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 11:11:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:11:29 INFO - Return code: 0 11:11:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:11:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:11:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:11:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:11:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:11:30 INFO - Return code: 0 11:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 11:11:30 INFO - Using env: {'DISPLAY': ':0', 11:11:30 INFO - 'HOME': '/home/cltbld', 11:11:30 INFO - 'LANG': 'en_US.UTF-8', 11:11:30 INFO - 'LANGUAGE': 'en_US:en', 11:11:30 INFO - 'LOGNAME': 'cltbld', 11:11:30 INFO - 'MAIL': '/var/mail/cltbld', 11:11:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:11:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:30 INFO - 'MOZ_NO_REMOTE': '1', 11:11:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:30 INFO - 'NO_EM_RESTART': '1', 11:11:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:30 INFO - 'PWD': '/builds/slave/test', 11:11:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:11:30 INFO - 'SHELL': '/bin/bash', 11:11:30 INFO - 'SHLVL': '1', 11:11:30 INFO - 'TERM': 'linux', 11:11:30 INFO - 'TMOUT': '86400', 11:11:30 INFO - 'USER': 'cltbld', 11:11:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289', 11:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:30 INFO - '_': '/tools/buildbot/bin/python'} 11:11:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:11:30 INFO - mozversion application_buildid: 20160516083029 11:11:30 INFO - mozversion application_changeset: e9533997fcef31fa5d2db464c6ceec0ca6ea560f 11:11:30 INFO - mozversion application_display_name: Nightly 11:11:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:11:30 INFO - mozversion application_name: Firefox 11:11:30 INFO - mozversion application_remotingname: firefox 11:11:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:11:30 INFO - mozversion application_vendor: Mozilla 11:11:30 INFO - mozversion application_version: 49.0a1 11:11:30 INFO - mozversion platform_buildid: 20160516083029 11:11:30 INFO - mozversion platform_changeset: e9533997fcef31fa5d2db464c6ceec0ca6ea560f 11:11:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:11:30 INFO - mozversion platform_version: 49.0a1 11:11:30 INFO - using testdate: 1463422290 11:11:30 INFO - actual date: 1463422290 11:11:30 INFO - starting webserver on 'localhost:45722' 11:11:30 INFO - SUITE-START | Running 2 tests 11:11:30 INFO - TEST-START | dromaeo_css 11:11:30 INFO - operating with platform_type : linux_ 11:11:30 INFO - Initialising browser for dromaeo_css test... 11:11:30 INFO - TEST-INFO | started process 3603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMTgwjl/profile http://localhost:45722/getInfo.html) 11:11:34 INFO - PROCESS | 3603 | __metrics Screen width/height:1600/1200 11:11:34 INFO - PROCESS | 3603 | colorDepth:24 11:11:34 INFO - PROCESS | 3603 | Browser inner width/height: 1024/697 11:11:34 INFO - PROCESS | 3603 | __metrics 11:11:35 ERROR - PROCESS | 3603 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:11:36 INFO - TEST-INFO | 3603: exit 0 11:11:36 INFO - Browser initialized. 11:11:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:11:36 INFO - TEST-INFO | started process 3683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMTgwjl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:48 INFO - PROCESS | 3683 | RSS: Main: 152403968 11:11:48 INFO - PROCESS | 3683 | 11:12:39 INFO - PROCESS | 3683 | 1463422359783 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:14:47 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45722/tests/dromaeo/cssquery-ext.html) 11:14:48 INFO - PROCESS | 3683 | RSS: Main: 242360320 11:14:48 INFO - PROCESS | 3683 | 11:17:51 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-ext.html (next: http://localhost:45722/tests/dromaeo/cssquery-jquery.html) 11:17:51 INFO - PROCESS | 3683 | RSS: Main: 241852416 11:17:51 INFO - PROCESS | 3683 | 11:20:53 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45722/tests/dromaeo/cssquery-mootools.html) 11:20:54 INFO - PROCESS | 3683 | RSS: Main: 248389632 11:20:54 INFO - PROCESS | 3683 | 11:23:56 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45722/tests/dromaeo/cssquery-prototype.html) 11:23:56 INFO - PROCESS | 3683 | RSS: Main: 236339200 11:23:56 INFO - PROCESS | 3683 | 11:26:59 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45722/tests/dromaeo/cssquery-yui.html) 11:26:59 INFO - PROCESS | 3683 | RSS: Main: 209633280 11:26:59 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-yui.html (next: http://localhost:45722/tests/dromaeo/cssquery-dojo.html) 11:30:02 INFO - PROCESS | 3683 | RSS: Main: 274034688 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | __start_tp_report 11:30:02 INFO - PROCESS | 3683 | _x_x_mozilla_page_load 11:30:02 INFO - PROCESS | 3683 | _x_x_mozilla_page_load_details 11:30:02 INFO - PROCESS | 3683 | |i|pagename|runs| 11:30:02 INFO - PROCESS | 3683 | |0;dojo.html;3146.8898588549405;3148.9999999999995;3197.792143510671;3202.631697354802;3217.662145474725;5246.1868410396355;5288.867778305545;5443.074677304858;5458.208559758833;5497.862553436161;5284.524392804647;5288.471152884709;5325.627206095575;5371.75827087781;5382.085045542258;4757.476677565465;4840.419149702041;4844.442889067767;4861.659683822134;5083.135866902617;5011.273365362039;5037.974810125944;5057.671251368649;5078.746062696869;5116.232565115225;4771.069641419925;4804.183288840871;4839.5886349660495;4857.222844344888;4875.804967801284;4811.350467686852;4814.085323788469;4814.301926220678;4816.109019831342;4900.950990490121;4815.5906747926465;4831.565159135695;4851.611871050342;4855.393075865517;4891.853244402673;5099.71951542665;5253.4221235664045;5304.496072873071;5403.027455058088;5421.078416669176;5812.157237200625;5821.505172060338;5882.588218824684;5888.676122813244;5890.823275301748;5866.70666466675;5933.554983376264;5954.047352423591;5957.731902064417;5959.046552551571;5277.76250068744;5319.787208511655;5386.461353864622;5408.918866216971;5492.176173573996;6020.578559500793;6026.54800889935;6028.2766068072115;6028.788992385245;6032.245969253843;5508.091164957737;5742.48317651405;5745.569082318842;5792;5811.709414529257;5592.273004509388;5627.803026894039;5636.126400407943;5657.20799088128;5659.151127330851;5661.943380566142;5667.376588575254;5673.744681489343;5674.631148975303;5680.602357834994;5371.3822910365025;5622.943770562324;5658;5669.2346533218315;5672;4376.409184760017;4388.341748737715;4400.273954797422;4444.422225110779;4447.599716025508;3920.980395098063;3923.2741942740686;3928.8035598219976;3931.6264954829817;3960.4851369321805;5217.06092903281;5322.281491998608;5327.680339179662;5465.316835395575;5512.3385193777;5740.483356497852;5799.855003624859;5817.95276850171;5825.621334613236;5860.120981852671;5417.485338892799;5422.6475279106735;5429.6199266051;5432.75552600134;5434.592405569598;4854.150523658345;4911.45973942866;4965.975170124127;4973.502649734997;5020.246962955513;6005.219321488178;6006.729697163638;6011.27864656244;6020.337762846083;6064.332923378425;5820.73806678692;5829.47534721877;5842.561807864512;5846.327672317738;5847.26909136358;5757.453041961007;5864.149698293809;5895.14520394549;5952.226210592596;5994.6403215807195;5683.033884239772;5696.743646535999;5696.743646535999;5703.058995265735;5703.08750599902;5734.082546792493;5779.682117483579;5780.248567686174;5784.161296611884;5784.595078344644;5448.972755136199;5557.360903495988;5574.247476590771;5612.607117501899;5681.744321505459;5660.886782264414;5668.688222147822;5669.943300566942;5670.461306175906;5681.431856814285;5370.838874833761;5516.751746171351;5555.7499912504845;5589.413111623384;5598.300212473441;5518.641288316247;5601.187827765033;5619.044762390486;5695.373508913934;5724.4561766632105;5470.507654311131;5480.451954804647;5480.506754392124;5484.424135465719;5513.9448605513435 11:30:02 INFO - PROCESS | 3683 | |1;ext.html;633.547013885072;643.9452646525045;655.6688872119579;658.868226354729;662.6918482905445;42647.57352426475;44173.116537669266;44270.55729442709;47471;47513.76243118788;46076.30885536711;46365.07269854609;46669.7666511667;46693.29960050602;46717;8840.292776577875;8973.237274831647;8979.057198994109;8985.550722463884;8988.550572471382;8849.601767920427;8905;8932.374733768638;8934.955325223365;8946.552672366355;8972.968108667488;8987.325950553735;9001.729948101567;9009.054049324825;9010.504422256774;8924.286057115416;8924.687635932743;8956.686515971975;8960.686375976842;8961.955190224073;8670.219680228747;8712.782180445476;8727.912720872773;8728.563571821447;8733.388662793543;42802.14395712069;43019.70940871779;43079.7846010768;43159.35260971088;43284;3627.6372362763777;3649.1606930406156;3698.204885949534;3712.535933008374;3853.2678791029894;32913.3417331652;33096.17259568506;33461.665383346095;33502.162445938804;34312.31375372504;4324.675649326313;4349.064951035511;4478.798454069574;4523.5024147343765;4600.884977875547;349606;349818;350821;351637;352116;52704.73647631814;57128.714356427954;58662.360193791385;58788.412115878295;59860.70069649624;63143.684281578295;63203.36796631975;63213.68393158097;63535.68232158902;63600.68199658972;16882.74675879863;17270.568235794206;17302.134893255286;17329.56676083083;17332.82667173312;11646.883531164749;12742.299173545358;13140.27728474924;13459.730805383837;13480.730385392237;17820.46538603844;17827.643447130984;17895.284188632308;17911.37310194163;17944.102794860206;6140.815775526741;6207.596506227081;6220.937790622036;6225.595336303126;6374.394432528902;1030.1707125763683;1036.1296510930854;1073.2058276875057;1094.8850370710961;1118.725912151528;33127.83436082804;33272.00183994484;33713.662863371545;33783;34124.317513649585;1178.7171078941165;1185.25921299188;1195.6293548999838;1204.8855358740905;1225.07506832341;17336;17544.56138596545;17638.823611763975;17663.293468261127;17730.468085957444;447850;449267;449709;450785;451762;59158.0841915805;59265;59277.11084333738;59316.703416483506;59318;1376.4769387632637;1409.7673883809261;1415.547024952026;1435.1460880775921;1435.2321507993174;31287;32364.676353236166;32616.004709027435;32672.836635816668;32980.50529242111;51776.482235177165;51837.740811295705;52090.47909521008;52094.739526302124;52108.73945630248;415671;417845;419979;429896;436613;41532.58467415287;41720;42119.36820947627;42187.726534183224;42205.78897105495;44727.77636111798;49272.26091608557;51111.74444127904;53661.19508207302;54880.72559637176;42772.144557109306;43072.78463607662;43165.3525197116;44055.559444405146;44062.11875762531;42399;42498.36252456278;42930.35604465873;43008.56991430045;43668.34497482604;41451.37822932719;42676;43679;43872.56127438812;43985.56014439814;33309;36613.26773464569;37057.25885482221;37147.44278835766;37270.813645931594;27996.72003279941;28236.910486544803;28653;28911.855440722662;30463.84768076234 11:30:02 INFO - PROCESS | 3683 | |2;jquery.html;366.10304753354256;389.250692417097;390.14558117722197;396.3400937439164;406.60559257520197;14124.364403601838;16585.83414165858;18272.269109235614;19069.52326191846;19078.427647170607;17784.822151778477;18618.53453663659;18793.812061879376;18845.623087538243;18886.055697215153;4160.687948403866;5577.749001294951;5722.055860782966;5743.597948143632;5757.193992841006;5997.790077347294;6260.593061451013;6333.683315834213;6384.425401713845;6470.579412338207;6172.197614310134;6299.212598425197;6391.105245265667;6401.519886008545;6401.711922963478;6315.684215789192;6352.841178970517;6366.840828979266;6398.040293955921;6407.551471397004;4941.827036053721;5192.688438693653;5197.714125723083;5273.947260527422;5310.495502927254;12572.30852303123;12793.360331983456;12846.293453860035;12903.0322725795;13090.738185236338;2263.864168149916;2278.646809744492;2399.952000959971;2419.697537807774;2500.099964012954;9910.20718342538;9942.602295908155;10352.378857268588;10523.73690657732;10691.091257243144;1891.848652107828;1928.3443629166152;1937.5543624966338;2014.0936578539715;2025.1696804310309;52041.47958520404;54607.45392546103;71545.64227178883;73351.26648733551;78202.60898695527;10842.891571084347;10872.402017888933;11147.21969462146;11156.835848193828;11836.112291578165;15186.544403667907;15547.766783498257;15656.217189140498;15662.530124096294;15700.76448853268;8095.757127286191;8272.793180170544;8360.958195208985;8501.702440414556;8528.01111349855;8020.157883422274;8028.678852845937;8082.2725954664365;8232.711855085043;8262.297704695047;4467.285234362486;4587.220172570671;4697.31888876111;4728.3143944127905;4878.195097808822;1929.218666440094;2002.3892712722468;2014.9597008059757;2019.1014998325898;2039.765426975887;964.8938616752292;1042.4891803016467;1090.1769164280918;1093.868735751715;1107.2304748200086;18825.717614235797;19031.858088514735;19156.23375064982;19423.611527769364;19517.707234391495;980.3382716666364;998.7153661206667;1023.2683631203726;1024.635808794043;1067.8558394616628;10460.68617941463;10703.518341674644;10923;10931.890681093088;10954.616588419527;463969;473975;480465;481141;483011;85352;88636.5568172155;88864.5556772212;89055.55472222598;89708;1032.5147180825;1048.62249590149;1053.4679986606714;1074.693712291993;1074.8065348237235;16660.250288736792;16877.557035313042;17052.65894682124;17161;17545.122743863012;38600.42099368568;38711.61288387193;39157.60842391539;39177;39470;50173.74913125411;55832;55860.44139558553;55921.44078559162;56017.43982560122;8865.113488651083;8887.244584210415;8900.465972041698;8962.820743584962;9211.953940230256;10104.292699510963;13717.657058573615;13748.243846588133;13934.372953216927;14243.857561424667;8671.176238257356;11970.341631210018;12052;12272.26366417982;12342.506299747909;11587.8261826071;11733.296002239893;11847.289162650268;11911.285322880654;12023.4589443477;12074.39628018578;12193.146479746332;12203;12285.201461904948;12510.249385036926;8512.101415693809;8644.308455323684;8736.519491428033;8945.552722363986;8946.150115738994;11157.832632510681;11535.250208736405;11847.940760296144;11978.281303121841;12279 11:30:02 INFO - PROCESS | 3683 | |3;mootools.html;1366.159811715795;1535.7158925598765;1552.8369521200273;1734.1589329175347;1866.9813301866986;8335.54154521501;8783.297336213103;8802.647894084237;9043.95478022609;9066.048064953184;8817.867731984026;9010.549472526363;9024.23294020009;9027.503487308195;9028.097190280969;2000.699895015752;2261.7851304126166;2331.5570041692067;2359.834811563191;2367.4199821043867;2363.161077817376;2367.3253122859987;2369.4194922243987;2375.798057165143;2380.7976322012564;2302.0561569756405;2319.35058183708;2347.1315613223132;2348.3307257431634;2350.059976009601;1971.122850331603;2232.174095584628;2246.359787460574;2296.517731276417;2301.5396920615945;2229.2420577003895;2244.652078927769;2247.752747197807;2249.1116009176285;2250.44864008319;8999.955000225022;9068.138526839939;9074.77313067172;9079.81840363189;9085.636574537011;5321.680699158062;5461.836144915659;5465.207544905967;5471.37079235889;5473.698946557938;3350.430426827445;3406.67636574525;3459.3600183966046;3528.1179705073732;3536.328097661436;1148.7702459508048;1162.4768854015726;1188.3761025461615;1192.8389667394965;1207.879212078794;12642.74714505714;12729.618111456579;12745.681357966032;12751.36243187837;12765.106442549026;4528.207563676344;4577.5880170784785;4653.813847446064;4666.556677115668;4683.1336202802595;10084.596616135419;10091.545880435398;10103.949480252551;10105.696829095139;10126.44304563256;5319.973400133052;5390.299261096033;5401.540869026177;5403;5405.351357837085;4353.804078816461;4719.3628860103445;4833.830815921497;4834.178189707688;4899.387576552931;3669.6697297243377;3730.981345093257;3811.7712937223855;3819.3698039823676;3840.6543411093135;1100.158378840172;1125.9662210133708;1131.5643477261315;1153.0487347937985;1156.1213477756964;946.6733976778;976.4043933200742;979.6326377608397;982.7690492734201;991.4646091110719;5628.352739434936;5727.398623144593;5753.309602847685;5881.470667639933;5906;432.10985370137615;443.7825465521871;444.012073137267;444.7487169749146;1001.814230746234;3855.20968201518;3937.704672149543;3950.288947989332;3995.4805875236616;4032.3749818778138;11148.219624626361;11218.270812397168;11405.08759299254;11444.14168937333;11444.942775286238;11089.667309980714;11147.331160130418;11149.386783726974;11194.888051119384;11290.604828830952;7874.6850125994315;8184.304334131546;8193.180681931759;8519.701810436605;8660.30717542595;5933.3769954154195;6031.788887388921;6111.877762444815;6123.84690382744;6163.753449861955;10421.791564168523;10597;10664.84002739944;10691.518881650189;10702.946485267836;9686.467244301632;10143.137833284254;10150.187984961332;10155.070536598023;10552.314099583502;7085.291470852873;7830.060392752906;8000.119986801564;8126;8147.837043258983;9058.864117038382;9085.77285567866;9106.134917182857;9160.908390916005;9164.450132992042;7861.1352751198465;8188.2630563249595;8220.219079187467;8330.666773329;8342.082370939313;7963.562004089831;8035.517868927883;8078.6364613593705;8131.974190210521;8233.094359620556;7187.460940429384;7285.708571657075;7295.489315747846;7368.37368823656;7437.628118593941;4990.451050384382;5049.990001999541;5088.796448142033;5130.538251557377;5218.947810521846;5197.402298735543;5197.948020519746;5264.052470555337;5384.300040994645;5389.676619402849 11:30:02 INFO - PROCESS | 3683 | |4;prototype.html;320.90372888133555;324.43548226086614;329.7049141018787;331.98506067226987;345.87029863801075;5149.922751158726;5258.868528286795;5396.379416367119;5418.512333889949;5442.482964118412;5297.099493086175;5316.5215130638235;5318.441563635821;5326.813561525348;5357.249985002103;4167.437395951538;4202.726822756526;4213.683973701977;4230.17511585241;4235.491740991085;3912.941305880414;3995.6403923646867;4100.302948498747;4261.318189089746;4263.4225336625495;4101.159262351226;4137.1725654869;4146.129312844291;4155.252054630166;4172.019575399779;4091.2635725569385;4105.055837157471;4108.897277568055;4113.424120623085;4117.702923579063;3471.1842716961496;3653.6894363979095;3656.926861462756;3660.2679464107287;3664.175560498893;5135.537801597837;5149.407818100892;5165.845024649267;5171.560417364529;5178.14560597501;4769.523047695237;4801.15979703554;4808.326834243208;4822.42130944289;4823.155947709172;5289.920651190235;5444.475546846889;5500.092484740013;5540.36285827127;5562.805301814417;3926.2540117377894;3938.5667576566557;3947.1908258806875;3953.4267531207815;3964.4251583520227;5744.253247077895;5746.2529871116485;5768.221290125864;5770.538356931435;5808.186853840466;3915.9636988765683;4021.9195616087513;4041.333180025322;4043.8180281887385;4080.204360149742;4138.213739389566;4149.37759336102;4151.730137541111;4152.896177595584;4161.9375709364385;4711.246200607955;4720.622350211975;4736.242201247784;4746.311784791186;4750.7387093709485;5448.264484294648;5537.667739935617;5567.526760225426;5593.636413633101;5631.521320687705;1409.7955796409462;1417.2771886338041;1427.5360507834996;1428.39293300349;1428.8785453236592;886.609891647673;897.7979954510314;901.2474583722534;905.2441211588266;906.6282824042111;4716.410448693913;4754.480125533472;4791;4791.928121078186;4827.782749776268;5066.746662666926;5075.325142702899;5082.390113186368;5085.7202853842655;5105.642605017613;4772.689775164603;4800.159972004955;4805.687630304019;4820.879478013007;4967.875803104879;3083.5683004378957;3085.768567357457;3097.132802815215;3104.3480869017308;3116.376724655078;5944;5955.974968510727;5958.553108516879;5972.611780234271;5974.910376344358;5632.464915832989;5870.82583483305;5872.383399743051;5892.646441213541;5901.557383196277;5909.911351329733;5922.437368449991;5941.881162376815;5946.643201407929;5990.7903223386975;5571.275734154534;5718.628289161191;5767.653940763567;5848.210491583752;5875.6474611523445;5671.914921276101;5673.262475878109;5677.233573467529;5706.686132262766;5707.429257074259;5924.851878703067;5933.347331793413;5945.64326140433;5975.940240597538;5976.133460648095;3887.8833634990997;4040.797960101924;4061.614146656063;4073.246449406869;4096.242195193899;5673.801416950387;5681.573881958787;5690.118031705092;5733.426657334233;5784.768609255582;5623.297087864017;5641.182028605747;5648.435156484319;5671.376148623565;5671.695510032798;5393.67854875558;5599.300087489064;5610.579206559606;5610.691411972218;5627.986962346817;5509.201165831012;5555.333359996826;5570.470805273492;5570.885822835368;5602.9719851402115;5355.928814237246;5614.736684246012;5671.631343962629;5703.543716502752;5705.22979397776;5533.557315414677;5571.164325351229;5571.888562228652;5580.330360356621;5590.776368945197 11:30:02 INFO - PROCESS | 3683 | |5;yui.html;797.7447216890594;841.928436082933;852.8592782190939;862.9309655227582;878.1087196495554;13749.106308089968;14825.851741482595;14902.105873647588;15000.699986000274;15109.77335339968;14365.497207597737;14394.640133996629;14396.784048239258;14404.855951440482;14424.783628245585;694.4895501806182;803.618281316373;819.573821612761;825.471698113208;835.8328334333128;831.8918540589746;837.4975014991018;840.2437805974641;840.5671079394117;840.6637345061963;884.6992022712277;885.1414128295576;885.8626912828522;885.9468431894074;886.5035580075146;738.1658725640019;863.5595846118493;879.2658130461073;879.846026945282;883.1036497954581;640.0591131037368;640.7565125252374;641.4291280760127;641.5445034025847;641.6759536434117;14431.206283654396;14482.203478808662;14492.927535362362;14494.927525362411;14509.492167774182;13930.233837138954;14001.78997315031;14008.649783755385;14177.36201870908;14275.928620356935;11599;12111.212771169845;12290;12487.562935297312;12813.167144135601;4471.3740076389;4478.955210447886;4570.565796249351;4593.586577208034;4621.168189725848;55574.44425555733;56907.14639280414;57050.714746426005;57323;57649.13526297151;10938.398388088572;11128.610498632508;11368.147388945863;11589.24669896454;11686.298822070703;19893.60212795736;20056.69064604353;20069.29757458482;20072.397828065183;20076;8076.555789431638;8081.676732930617;8428.32573394127;8449.105195542494;8522.957385213034;4523.751193684379;4693.342931989524;4695.81216751333;4743.573078422958;4944.233643785219;3594.4608308753373;3676.3750162472443;3689.169936764207;3699.0382500549513;3704.1850792825535;671.2180309938964;682.7234969837224;684.0662495693343;696.3697853442643;706.9010338552607;693.7225109956058;717.3973861955982;722.5267449820376;759.3583422008394;770.1643716567474;9768.560414781352;9851.852222216672;9908.20734341251;9938.155256803107;9949.850752238723;699.8005568412977;714.7998560403096;737.1412304665005;750.7297372945735;757.144426797715;4601.539846015372;4635.142498637762;4669.369635099286;4686.461056978491;4693.718376897397;67237;67292;69667.30332696608;70244.64877675578;70508;60301.57285844207;63435.36564634387;63853;63949;64585.67707161528;53460;54484.182737258976;56172;56675.14987275194;57024.71487642535;9089.136532029446;9089.909210894735;9137.63449462014;9160.954195228982;9282.396644218104;36736.26527469382;37095.25809483741;37209.62790372062;37809.432858506596;37858.43212351872;45360.31959520676;49044.2643360357;49062.79217435295;49315.26027109524;49903.251451228985;10931.945340273247;11311.71720706956;11394.145439091935;11414.94292528532;11759.118066145244;12326.198797078161;12357.629271121881;12416.565420210249;12624.936875315932;12879.549215777402;11152.275102118336;11616.419179041182;11937;11991.160618756952;12542.749145016865;11874.584389546324;11967.940160299142;12217.205881617667;12415.813762793385;12618.936905315415;12044.578439754567;12045.976092032275;12072.154949153826;12441.44013519412;12502.624921252376;10000.399976001463;10090.596376144871;10381.636642717469;10425.530851111567;10427.374357538572;9930.900690992998;10099.29304948676;10144.340617859816;10187.235957303381;10202.081812636898 11:30:02 INFO - PROCESS | 3683 | __end_tp_report 11:30:02 INFO - PROCESS | 3683 | __start_cc_report 11:30:02 INFO - PROCESS | 3683 | _x_x_mozilla_cycle_collect,788 11:30:02 INFO - PROCESS | 3683 | __end_cc_report 11:30:02 INFO - PROCESS | 3683 | __startTimestamp1463423402756__endTimestamp 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | ------- Summary: start ------- 11:30:02 INFO - PROCESS | 3683 | Number of tests: 6 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | [#0] dojo.html Cycles:165 Average:5347.62 Median:5512.34 stddev:609.75 (11.1%) stddev-sans-first:586.67 11:30:02 INFO - PROCESS | 3683 | Values: 3146.9 3149.0 3197.8 3202.6 3217.7 5246.2 5288.9 5443.1 5458.2 5497.9 5284.5 5288.5 5325.6 5371.8 5382.1 4757.5 4840.4 4844.4 4861.7 5083.1 5011.3 5038.0 5057.7 5078.7 5116.2 4771.1 4804.2 4839.6 4857.2 4875.8 4811.4 4814.1 4814.3 4816.1 4901.0 4815.6 4831.6 4851.6 4855.4 4891.9 5099.7 5253.4 5304.5 5403.0 5421.1 5812.2 5821.5 5882.6 5888.7 5890.8 5866.7 5933.6 5954.0 5957.7 5959.0 5277.8 5319.8 5386.5 5408.9 5492.2 6020.6 6026.5 6028.3 6028.8 6032.2 5508.1 5742.5 5745.6 5792.0 5811.7 5592.3 5627.8 5636.1 5657.2 5659.2 5661.9 5667.4 5673.7 5674.6 5680.6 5371.4 5622.9 5658.0 5669.2 5672.0 4376.4 4388.3 4400.3 4444.4 4447.6 3921.0 3923.3 3928.8 3931.6 3960.5 5217.1 5322.3 5327.7 5465.3 5512.3 5740.5 5799.9 5818.0 5825.6 5860.1 5417.5 5422.6 5429.6 5432.8 5434.6 4854.2 4911.5 4966.0 4973.5 5020.2 6005.2 6006.7 6011.3 6020.3 6064.3 5820.7 5829.5 5842.6 5846.3 5847.3 5757.5 5864.1 5895.1 5952.2 5994.6 5683.0 5696.7 5696.7 5703.1 5703.1 5734.1 5779.7 5780.2 5784.2 5784.6 5449.0 5557.4 5574.2 5612.6 5681.7 5660.9 5668.7 5669.9 5670.5 5681.4 5370.8 5516.8 5555.7 5589.4 5598.3 5518.6 5601.2 5619.0 5695.4 5724.5 5470.5 5480.5 5480.5 5484.4 5513.9 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | [#1] ext.html Cycles:180 Average:58528.78 Median:43119.57 stddev:108122.08 (250.7%) stddev-sans-first:108338.01 11:30:02 INFO - PROCESS | 3683 | Values: 633.5 643.9 655.7 658.9 662.7 42647.6 44173.1 44270.6 47471.0 47513.8 46076.3 46365.1 46669.8 46693.3 46717.0 8840.3 8973.2 8979.1 8985.6 8988.6 8849.6 8905.0 8932.4 8935.0 8946.6 8973.0 8987.3 9001.7 9009.1 9010.5 8924.3 8924.7 8956.7 8960.7 8962.0 8670.2 8712.8 8727.9 8728.6 8733.4 42802.1 43019.7 43079.8 43159.4 43284.0 3627.6 3649.2 3698.2 3712.5 3853.3 32913.3 33096.2 33461.7 33502.2 34312.3 4324.7 4349.1 4478.8 4523.5 4600.9 349606.0 349818.0 350821.0 351637.0 352116.0 52704.7 57128.7 58662.4 58788.4 59860.7 63143.7 63203.4 63213.7 63535.7 63600.7 16882.7 17270.6 17302.1 17329.6 17332.8 11646.9 12742.3 13140.3 13459.7 13480.7 17820.5 17827.6 17895.3 17911.4 17944.1 6140.8 6207.6 6220.9 6225.6 6374.4 1030.2 1036.1 1073.2 1094.9 1118.7 33127.8 33272.0 33713.7 33783.0 34124.3 1178.7 1185.3 1195.6 1204.9 1225.1 17336.0 17544.6 17638.8 17663.3 17730.5 447850.0 449267.0 449709.0 450785.0 451762.0 59158.1 59265.0 59277.1 59316.7 59318.0 1376.5 1409.8 1415.5 1435.1 1435.2 31287.0 32364.7 32616.0 32672.8 32980.5 51776.5 51837.7 52090.5 52094.7 52108.7 415671.0 417845.0 419979.0 429896.0 436613.0 41532.6 41720.0 42119.4 42187.7 42205.8 44727.8 49272.3 51111.7 53661.2 54880.7 42772.1 43072.8 43165.4 44055.6 44062.1 42399.0 42498.4 42930.4 43008.6 43668.3 41451.4 42676.0 43679.0 43872.6 43985.6 33309.0 36613.3 37057.3 37147.4 37270.8 27996.7 28236.9 28653.0 28911.9 30463.8 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | [#2] jquery.html Cycles:180 Average:27672.61 Median:2339.30 stddev:78328.85 (3348.4%) stddev-sans-first:78521.74 11:30:02 INFO - PROCESS | 3683 | Values: 366.1 389.3 390.1 396.3 406.6 14124.4 16585.8 18272.3 19069.5 19078.4 17784.8 18618.5 18793.8 18845.6 18886.1 4160.7 5577.7 5722.1 5743.6 5757.2 5997.8 6260.6 6333.7 6384.4 6470.6 6172.2 6299.2 6391.1 6401.5 6401.7 6315.7 6352.8 6366.8 6398.0 6407.6 4941.8 5192.7 5197.7 5273.9 5310.5 12572.3 12793.4 12846.3 12903.0 13090.7 2263.9 2278.6 2400.0 2419.7 2500.1 9910.2 9942.6 10352.4 10523.7 10691.1 1891.8 1928.3 1937.6 2014.1 2025.2 52041.5 54607.5 71545.6 73351.3 78202.6 10842.9 10872.4 11147.2 11156.8 11836.1 15186.5 15547.8 15656.2 15662.5 15700.8 8095.8 8272.8 8361.0 8501.7 8528.0 8020.2 8028.7 8082.3 8232.7 8262.3 4467.3 4587.2 4697.3 4728.3 4878.2 1929.2 2002.4 2015.0 2019.1 2039.8 964.9 1042.5 1090.2 1093.9 1107.2 18825.7 19031.9 19156.2 19423.6 19517.7 980.3 998.7 1023.3 1024.6 1067.9 10460.7 10703.5 10923.0 10931.9 10954.6 463969.0 473975.0 480465.0 481141.0 483011.0 85352.0 88636.6 88864.6 89055.6 89708.0 1032.5 1048.6 1053.5 1074.7 1074.8 16660.3 16877.6 17052.7 17161.0 17545.1 38600.4 38711.6 39157.6 39177.0 39470.0 50173.7 55832.0 55860.4 55921.4 56017.4 8865.1 8887.2 8900.5 8962.8 9212.0 10104.3 13717.7 13748.2 13934.4 14243.9 8671.2 11970.3 12052.0 12272.3 12342.5 11587.8 11733.3 11847.3 11911.3 12023.5 12074.4 12193.1 12203.0 12285.2 12510.2 8512.1 8644.3 8736.5 8945.6 8946.2 11157.8 11535.3 11847.9 11978.3 12279.0 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | [#3] mootools.html Cycles:180 Average:5895.51 Median:4552.90 stddev:3435.96 (75.5%) stddev-sans-first:3428.73 11:30:02 INFO - PROCESS | 3683 | Values: 1366.2 1535.7 1552.8 1734.2 1867.0 8335.5 8783.3 8802.6 9044.0 9066.0 8817.9 9010.5 9024.2 9027.5 9028.1 2000.7 2261.8 2331.6 2359.8 2367.4 2363.2 2367.3 2369.4 2375.8 2380.8 2302.1 2319.4 2347.1 2348.3 2350.1 1971.1 2232.2 2246.4 2296.5 2301.5 2229.2 2244.7 2247.8 2249.1 2250.4 9000.0 9068.1 9074.8 9079.8 9085.6 5321.7 5461.8 5465.2 5471.4 5473.7 3350.4 3406.7 3459.4 3528.1 3536.3 1148.8 1162.5 1188.4 1192.8 1207.9 12642.7 12729.6 12745.7 12751.4 12765.1 4528.2 4577.6 4653.8 4666.6 4683.1 10084.6 10091.5 10103.9 10105.7 10126.4 5320.0 5390.3 5401.5 5403.0 5405.4 4353.8 4719.4 4833.8 4834.2 4899.4 3669.7 3731.0 3811.8 3819.4 3840.7 1100.2 1126.0 1131.6 1153.0 1156.1 946.7 976.4 979.6 982.8 991.5 5628.4 5727.4 5753.3 5881.5 5906.0 432.1 443.8 444.0 444.7 1001.8 3855.2 3937.7 3950.3 3995.5 4032.4 11148.2 11218.3 11405.1 11444.1 11444.9 11089.7 11147.3 11149.4 11194.9 11290.6 7874.7 8184.3 8193.2 8519.7 8660.3 5933.4 6031.8 6111.9 6123.8 6163.8 10421.8 10597.0 10664.8 10691.5 10702.9 9686.5 10143.1 10150.2 10155.1 10552.3 7085.3 7830.1 8000.1 8126.0 8147.8 9058.9 9085.8 9106.1 9160.9 9164.5 7861.1 8188.3 8220.2 8330.7 8342.1 7963.6 8035.5 8078.6 8132.0 8233.1 7187.5 7285.7 7295.5 7368.4 7437.6 4990.5 5050.0 5088.8 5130.5 5218.9 5197.4 5197.9 5264.1 5384.3 5389.7 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | [#4] prototype.html Cycles:180 Average:4659.20 Median:5218.51 stddev:1376.55 (26.4%) stddev-sans-first:1341.34 11:30:02 INFO - PROCESS | 3683 | Values: 320.9 324.4 329.7 332.0 345.9 5149.9 5258.9 5396.4 5418.5 5442.5 5297.1 5316.5 5318.4 5326.8 5357.2 4167.4 4202.7 4213.7 4230.2 4235.5 3912.9 3995.6 4100.3 4261.3 4263.4 4101.2 4137.2 4146.1 4155.3 4172.0 4091.3 4105.1 4108.9 4113.4 4117.7 3471.2 3653.7 3656.9 3660.3 3664.2 5135.5 5149.4 5165.8 5171.6 5178.1 4769.5 4801.2 4808.3 4822.4 4823.2 5289.9 5444.5 5500.1 5540.4 5562.8 3926.3 3938.6 3947.2 3953.4 3964.4 5744.3 5746.3 5768.2 5770.5 5808.2 3916.0 4021.9 4041.3 4043.8 4080.2 4138.2 4149.4 4151.7 4152.9 4161.9 4711.2 4720.6 4736.2 4746.3 4750.7 5448.3 5537.7 5567.5 5593.6 5631.5 1409.8 1417.3 1427.5 1428.4 1428.9 886.6 897.8 901.2 905.2 906.6 4716.4 4754.5 4791.0 4791.9 4827.8 5066.7 5075.3 5082.4 5085.7 5105.6 4772.7 4800.2 4805.7 4820.9 4967.9 3083.6 3085.8 3097.1 3104.3 3116.4 5944.0 5956.0 5958.6 5972.6 5974.9 5632.5 5870.8 5872.4 5892.6 5901.6 5909.9 5922.4 5941.9 5946.6 5990.8 5571.3 5718.6 5767.7 5848.2 5875.6 5671.9 5673.3 5677.2 5706.7 5707.4 5924.9 5933.3 5945.6 5975.9 5976.1 3887.9 4040.8 4061.6 4073.2 4096.2 5673.8 5681.6 5690.1 5733.4 5784.8 5623.3 5641.2 5648.4 5671.4 5671.7 5393.7 5599.3 5610.6 5610.7 5628.0 5509.2 5555.3 5570.5 5570.9 5603.0 5355.9 5614.7 5671.6 5703.5 5705.2 5533.6 5571.2 5571.9 5580.3 5590.8 11:30:02 INFO - PROCESS | 3683 | 11:30:02 INFO - PROCESS | 3683 | [#5] yui.html Cycles:180 Average:15677.00 Median:4693.53 stddev:18889.57 (402.5%) stddev-sans-first:18909.51 11:30:02 INFO - PROCESS | 3683 | Values: 797.7 841.9 852.9 862.9 878.1 13749.1 14825.9 14902.1 15000.7 15109.8 14365.5 14394.6 14396.8 14404.9 14424.8 694.5 803.6 819.6 825.5 835.8 831.9 837.5 840.2 840.6 840.7 884.7 885.1 885.9 885.9 886.5 738.2 863.6 879.3 879.8 883.1 640.1 640.8 641.4 641.5 641.7 14431.2 14482.2 14492.9 14494.9 14509.5 13930.2 14001.8 14008.6 14177.4 14275.9 11599.0 12111.2 12290.0 12487.6 12813.2 4471.4 4479.0 4570.6 4593.6 4621.2 55574.4 56907.1 57050.7 57323.0 57649.1 10938.4 11128.6 11368.1 11589.2 11686.3 19893.6 20056.7 20069.3 20072.4 20076.0 8076.6 8081.7 8428.3 8449.1 8523.0 4523.8 4693.3 4695.8 4743.6 4944.2 3594.5 3676.4 3689.2 3699.0 3704.2 671.2 682.7 684.1 696.4 706.9 693.7 717.4 722.5 759.4 770.2 9768.6 9851.9 9908.2 9938.2 9949.9 699.8 714.8 737.1 750.7 757.1 4601.5 4635.1 4669.4 4686.5 4693.7 67237.0 67292.0 69667.3 70244.6 70508.0 60301.6 63435.4 63853.0 63949.0 64585.7 53460.0 54484.2 56172.0 56675.1 57024.7 9089.1 9089.9 9137.6 9161.0 9282.4 36736.3 37095.3 37209.6 37809.4 37858.4 45360.3 49044.3 49062.8 49315.3 49903.3 10931.9 11311.7 11394.1 11414.9 11759.1 12326.2 12357.6 12416.6 12624.9 12879.5 11152.3 11616.4 11937.0 11991.2 12542.7 11874.6 11967.9 12217.2 12415.8 12618.9 12044.6 12046.0 12072.2 12441.4 12502.6 10000.4 10090.6 10381.6 10425.5 10427.4 9930.9 10099.3 10144.3 10187.2 10202.1 11:30:02 INFO - PROCESS | 3683 | -------- Summary: end -------- 11:30:02 INFO - PROCESS | 3683 | 11:30:03 INFO - TEST-INFO | 3683: exit 0 11:30:03 INFO - TEST-OK | dromaeo_css | took 1113064ms 11:30:03 INFO - TEST-START | kraken 11:30:03 INFO - operating with platform_type : linux_ 11:30:03 INFO - Initialising browser for kraken test... 11:30:03 INFO - TEST-INFO | started process 3863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAKXJA/profile http://localhost:45722/getInfo.html) 11:30:07 INFO - PROCESS | 3863 | __metrics Screen width/height:1600/1200 11:30:07 INFO - PROCESS | 3863 | colorDepth:24 11:30:07 INFO - PROCESS | 3863 | Browser inner width/height: 1024/697 11:30:07 INFO - PROCESS | 3863 | __metrics 11:30:08 ERROR - PROCESS | 3863 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:30:08 INFO - TEST-INFO | 3863: exit 0 11:30:08 INFO - Browser initialized. 11:30:08 INFO - Running cycle 1/1 for kraken test... 11:30:08 INFO - TEST-INFO | started process 3944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAKXJA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:20 INFO - PROCESS | 3944 | RSS: Main: 152150016 11:30:20 INFO - PROCESS | 3944 | 11:30:23 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-beat-detection) 11:30:24 INFO - PROCESS | 3944 | RSS: Main: 208785408 11:30:24 INFO - PROCESS | 3944 | 11:30:26 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-dft) 11:30:27 INFO - PROCESS | 3944 | RSS: Main: 198082560 11:30:27 INFO - PROCESS | 3944 | 11:30:30 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-fft) 11:30:31 INFO - PROCESS | 3944 | RSS: Main: 265547776 11:30:31 INFO - PROCESS | 3944 | 11:30:33 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-oscillator) 11:30:34 INFO - PROCESS | 3944 | RSS: Main: 174514176 11:30:34 INFO - PROCESS | 3944 | 11:30:36 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:30:36 INFO - PROCESS | 3944 | RSS: Main: 178229248 11:30:36 INFO - PROCESS | 3944 | 11:30:40 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45722/tests/kraken/driver.html?testName=imaging-darkroom) 11:30:40 INFO - PROCESS | 3944 | RSS: Main: 214790144 11:30:40 INFO - PROCESS | 3944 | 11:30:44 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45722/tests/kraken/driver.html?testName=imaging-desaturate) 11:30:44 INFO - PROCESS | 3944 | RSS: Main: 215171072 11:30:44 INFO - PROCESS | 3944 | 11:30:47 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45722/tests/kraken/driver.html?testName=json-parse-financial) 11:30:48 INFO - PROCESS | 3944 | RSS: Main: 215588864 11:30:48 INFO - PROCESS | 3944 | 11:30:50 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:30:50 INFO - PROCESS | 3944 | RSS: Main: 204369920 11:30:50 INFO - PROCESS | 3944 | 11:30:52 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:30:53 INFO - PROCESS | 3944 | RSS: Main: 209149952 11:30:53 INFO - PROCESS | 3944 | 11:30:55 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:30:55 INFO - PROCESS | 3944 | RSS: Main: 217518080 11:30:55 INFO - PROCESS | 3944 | 11:30:58 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:30:59 INFO - PROCESS | 3944 | RSS: Main: 223952896 11:30:59 INFO - PROCESS | 3944 | 11:31:01 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:02 INFO - PROCESS | 3944 | RSS: Main: 219082752 11:31:02 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45722/tests/kraken/driver.html?testName=ai-astar) 11:31:04 INFO - PROCESS | 3944 | RSS: Main: 265416704 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | __start_tp_report 11:31:04 INFO - PROCESS | 3944 | _x_x_mozilla_page_load 11:31:04 INFO - PROCESS | 3944 | _x_x_mozilla_page_load_details 11:31:04 INFO - PROCESS | 3944 | |i|pagename|runs| 11:31:04 INFO - PROCESS | 3944 | |0;ai-astar;108;105;108;109;109;109;109;110;109;109 11:31:04 INFO - PROCESS | 3944 | |1;audio-beat-detection;160;131;147;215;132;154;147;132;175;123 11:31:04 INFO - PROCESS | 3944 | |2;audio-dft;162;164;163;163;165;162;163;170;162;160 11:31:04 INFO - PROCESS | 3944 | |3;audio-fft;75;75;75;155;75;74;76;75;143;77 11:31:04 INFO - PROCESS | 3944 | |4;audio-oscillator;92;92;146;92;91;91;122;91;90;124 11:31:04 INFO - PROCESS | 3944 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;117 11:31:04 INFO - PROCESS | 3944 | |6;imaging-darkroom;145;145;145;145;146;145;145;146;146;146 11:31:04 INFO - PROCESS | 3944 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;96;95 11:31:04 INFO - PROCESS | 3944 | |8;json-parse-financial;55;55;57;54;56;55;54;107;53;54 11:31:04 INFO - PROCESS | 3944 | |9;json-stringify-tinderbox;59;60;60;60;60;59;59;60;60;60 11:31:04 INFO - PROCESS | 3944 | |10;stanford-crypto-aes;81;85;78;79;78;84;78;81;79;79 11:31:04 INFO - PROCESS | 3944 | |11;stanford-crypto-ccm;125;123;119;118;118;120;117;116;200;132 11:31:04 INFO - PROCESS | 3944 | |12;stanford-crypto-pbkdf2;163;162;164;162;165;159;161;168;161;161 11:31:04 INFO - PROCESS | 3944 | |13;stanford-crypto-sha256-iterative;62;65;63;63;65;64;63;63;62;62 11:31:04 INFO - PROCESS | 3944 | __end_tp_report 11:31:04 INFO - PROCESS | 3944 | __start_cc_report 11:31:04 INFO - PROCESS | 3944 | _x_x_mozilla_cycle_collect,1859 11:31:04 INFO - PROCESS | 3944 | __end_cc_report 11:31:04 INFO - PROCESS | 3944 | __startTimestamp1463423464428__endTimestamp 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | ------- Summary: start ------- 11:31:04 INFO - PROCESS | 3944 | Number of tests: 14 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 11:31:04 INFO - PROCESS | 3944 | Values: 108.0 105.0 108.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:150.50 stddev:27.28 (18.1%) stddev-sans-first:28.76 11:31:04 INFO - PROCESS | 3944 | Values: 160.0 131.0 147.0 215.0 132.0 154.0 147.0 132.0 175.0 123.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.67 (1.6%) stddev-sans-first:2.79 11:31:04 INFO - PROCESS | 3944 | Values: 162.0 164.0 163.0 163.0 165.0 162.0 163.0 170.0 162.0 160.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#3] audio-fft Cycles:10 Average:90.00 Median:75.00 stddev:31.23 (41.6%) stddev-sans-first:32.65 11:31:04 INFO - PROCESS | 3944 | Values: 75.0 75.0 75.0 155.0 75.0 74.0 76.0 75.0 143.0 77.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:91.00 stddev:20.04 (22.0%) stddev-sans-first:20.85 11:31:04 INFO - PROCESS | 3944 | Values: 92.0 92.0 146.0 92.0 91.0 91.0 122.0 91.0 90.0 124.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:31:04 INFO - PROCESS | 3944 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:31:04 INFO - PROCESS | 3944 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:31:04 INFO - PROCESS | 3944 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:55.00 stddev:16.55 (30.1%) stddev-sans-first:17.46 11:31:04 INFO - PROCESS | 3944 | Values: 55.0 55.0 57.0 54.0 56.0 55.0 54.0 107.0 53.0 54.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 11:31:04 INFO - PROCESS | 3944 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 60.0 60.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.53 (3.2%) stddev-sans-first:2.67 11:31:04 INFO - PROCESS | 3944 | Values: 81.0 85.0 78.0 79.0 78.0 84.0 78.0 81.0 79.0 79.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:121.50 stddev:25.47 (21.0%) stddev-sans-first:26.98 11:31:04 INFO - PROCESS | 3944 | Values: 125.0 123.0 119.0 118.0 118.0 120.0 117.0 116.0 200.0 132.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:162.50 stddev:2.55 (1.6%) stddev-sans-first:2.70 11:31:04 INFO - PROCESS | 3944 | Values: 163.0 162.0 164.0 162.0 165.0 159.0 161.0 168.0 161.0 161.0 11:31:04 INFO - PROCESS | 3944 | 11:31:04 INFO - PROCESS | 3944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.12 11:31:04 INFO - PROCESS | 3944 | Values: 62.0 65.0 63.0 63.0 65.0 64.0 63.0 63.0 62.0 62.0 11:31:04 INFO - PROCESS | 3944 | -------- Summary: end -------- 11:31:04 INFO - PROCESS | 3944 | 11:31:05 INFO - TEST-INFO | 3944: exit 0 11:31:05 INFO - TEST-OK | kraken | took 62039ms 11:31:05 INFO - SUITE-END | took 1175s 11:31:05 INFO - Completed test suite (00:19:35) 11:31:05 INFO - javascript benchmark 11:31:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.8898588549405, 3148.9999999999995, 3197.792143510671, 3202.631697354802, 3217.662145474725, 5246.1868410396355, 5288.867778305545, 5443.074677304858, 5458.208559758833, 5497.862553436161, 5284.524392804647, 5288.471152884709, 5325.627206095575, 5371.75827087781, 5382.085045542258, 4757.476677565465, 4840.419149702041, 4844.442889067767, 4861.659683822134, 5083.135866902617, 5011.273365362039, 5037.974810125944, 5057.671251368649, 5078.746062696869, 5116.232565115225, 4771.069641419925, 4804.183288840871, 4839.5886349660495, 4857.222844344888, 4875.804967801284, 4811.350467686852, 4814.085323788469, 4814.301926220678, 4816.109019831342, 4900.950990490121, 4815.5906747926465, 4831.565159135695, 4851.611871050342, 4855.393075865517, 4891.853244402673, 5099.71951542665, 5253.4221235664045, 5304.496072873071, 5403.027455058088, 5421.078416669176, 5812.157237200625, 5821.505172060338, 5882.588218824684, 5888.676122813244, 5890.823275301748, 5866.70666466675, 5933.554983376264, 5954.047352423591, 5957.731902064417, 5959.046552551571, 5277.76250068744, 5319.787208511655, 5386.461353864622, 5408.918866216971, 5492.176173573996, 6020.578559500793, 6026.54800889935, 6028.2766068072115, 6028.788992385245, 6032.245969253843, 5508.091164957737, 5742.48317651405, 5745.569082318842, 5792.0, 5811.709414529257, 5592.273004509388, 5627.803026894039, 5636.126400407943, 5657.20799088128, 5659.151127330851, 5661.943380566142, 5667.376588575254, 5673.744681489343, 5674.631148975303, 5680.602357834994, 5371.3822910365025, 5622.943770562324, 5658.0, 5669.2346533218315, 5672.0, 4376.409184760017, 4388.341748737715, 4400.273954797422, 4444.422225110779, 4447.599716025508, 3920.980395098063, 3923.2741942740686, 3928.8035598219976, 3931.6264954829817, 3960.4851369321805, 5217.06092903281, 5322.281491998608, 5327.680339179662, 5465.316835395575, 5512.3385193777, 5740.483356497852, 5799.855003624859, 5817.95276850171, 5825.621334613236, 5860.120981852671, 5417.485338892799, 5422.6475279106735, 5429.6199266051, 5432.75552600134, 5434.592405569598, 4854.150523658345, 4911.45973942866, 4965.975170124127, 4973.502649734997, 5020.246962955513, 6005.219321488178, 6006.729697163638, 6011.27864656244, 6020.337762846083, 6064.332923378425, 5820.73806678692, 5829.47534721877, 5842.561807864512, 5846.327672317738, 5847.26909136358, 5757.453041961007, 5864.149698293809, 5895.14520394549, 5952.226210592596, 5994.6403215807195, 5683.033884239772, 5696.743646535999, 5696.743646535999, 5703.058995265735, 5703.08750599902, 5734.082546792493, 5779.682117483579, 5780.248567686174, 5784.161296611884, 5784.595078344644, 5448.972755136199, 5557.360903495988, 5574.247476590771, 5612.607117501899, 5681.744321505459, 5660.886782264414, 5668.688222147822, 5669.943300566942, 5670.461306175906, 5681.431856814285, 5370.838874833761, 5516.751746171351, 5555.7499912504845, 5589.413111623384, 5598.300212473441, 5518.641288316247, 5601.187827765033, 5619.044762390486, 5695.373508913934, 5724.4561766632105, 5470.507654311131, 5480.451954804647, 5480.506754392124, 5484.424135465719, 5513.9448605513435], "value": 5307.095244436385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.547013885072, 643.9452646525045, 655.6688872119579, 658.868226354729, 662.6918482905445, 42647.57352426475, 44173.116537669266, 44270.55729442709, 47471.0, 47513.76243118788, 46076.30885536711, 46365.07269854609, 46669.7666511667, 46693.29960050602, 46717.0, 8840.292776577875, 8973.237274831647, 8979.057198994109, 8985.550722463884, 8988.550572471382, 8849.601767920427, 8905.0, 8932.374733768638, 8934.955325223365, 8946.552672366355, 8972.968108667488, 8987.325950553735, 9001.729948101567, 9009.054049324825, 9010.504422256774, 8924.286057115416, 8924.687635932743, 8956.686515971975, 8960.686375976842, 8961.955190224073, 8670.219680228747, 8712.782180445476, 8727.912720872773, 8728.563571821447, 8733.388662793543, 42802.14395712069, 43019.70940871779, 43079.7846010768, 43159.35260971088, 43284.0, 3627.6372362763777, 3649.1606930406156, 3698.204885949534, 3712.535933008374, 3853.2678791029894, 32913.3417331652, 33096.17259568506, 33461.665383346095, 33502.162445938804, 34312.31375372504, 4324.675649326313, 4349.064951035511, 4478.798454069574, 4523.5024147343765, 4600.884977875547, 349606.0, 349818.0, 350821.0, 351637.0, 352116.0, 52704.73647631814, 57128.714356427954, 58662.360193791385, 58788.412115878295, 59860.70069649624, 63143.684281578295, 63203.36796631975, 63213.68393158097, 63535.68232158902, 63600.68199658972, 16882.74675879863, 17270.568235794206, 17302.134893255286, 17329.56676083083, 17332.82667173312, 11646.883531164749, 12742.299173545358, 13140.27728474924, 13459.730805383837, 13480.730385392237, 17820.46538603844, 17827.643447130984, 17895.284188632308, 17911.37310194163, 17944.102794860206, 6140.815775526741, 6207.596506227081, 6220.937790622036, 6225.595336303126, 6374.394432528902, 1030.1707125763683, 1036.1296510930854, 1073.2058276875057, 1094.8850370710961, 1118.725912151528, 33127.83436082804, 33272.00183994484, 33713.662863371545, 33783.0, 34124.317513649585, 1178.7171078941165, 1185.25921299188, 1195.6293548999838, 1204.8855358740905, 1225.07506832341, 17336.0, 17544.56138596545, 17638.823611763975, 17663.293468261127, 17730.468085957444, 447850.0, 449267.0, 449709.0, 450785.0, 451762.0, 59158.0841915805, 59265.0, 59277.11084333738, 59316.703416483506, 59318.0, 1376.4769387632637, 1409.7673883809261, 1415.547024952026, 1435.1460880775921, 1435.2321507993174, 31287.0, 32364.676353236166, 32616.004709027435, 32672.836635816668, 32980.50529242111, 51776.482235177165, 51837.740811295705, 52090.47909521008, 52094.739526302124, 52108.73945630248, 415671.0, 417845.0, 419979.0, 429896.0, 436613.0, 41532.58467415287, 41720.0, 42119.36820947627, 42187.726534183224, 42205.78897105495, 44727.77636111798, 49272.26091608557, 51111.74444127904, 53661.19508207302, 54880.72559637176, 42772.144557109306, 43072.78463607662, 43165.3525197116, 44055.559444405146, 44062.11875762531, 42399.0, 42498.36252456278, 42930.35604465873, 43008.56991430045, 43668.34497482604, 41451.37822932719, 42676.0, 43679.0, 43872.56127438812, 43985.56014439814, 33309.0, 36613.26773464569, 37057.25885482221, 37147.44278835766, 37270.813645931594, 27996.72003279941, 28236.910486544803, 28653.0, 28911.855440722662, 30463.84768076234], "value": 20633.670217695857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.10304753354256, 389.250692417097, 390.14558117722197, 396.3400937439164, 406.60559257520197, 14124.364403601838, 16585.83414165858, 18272.269109235614, 19069.52326191846, 19078.427647170607, 17784.822151778477, 18618.53453663659, 18793.812061879376, 18845.623087538243, 18886.055697215153, 4160.687948403866, 5577.749001294951, 5722.055860782966, 5743.597948143632, 5757.193992841006, 5997.790077347294, 6260.593061451013, 6333.683315834213, 6384.425401713845, 6470.579412338207, 6172.197614310134, 6299.212598425197, 6391.105245265667, 6401.519886008545, 6401.711922963478, 6315.684215789192, 6352.841178970517, 6366.840828979266, 6398.040293955921, 6407.551471397004, 4941.827036053721, 5192.688438693653, 5197.714125723083, 5273.947260527422, 5310.495502927254, 12572.30852303123, 12793.360331983456, 12846.293453860035, 12903.0322725795, 13090.738185236338, 2263.864168149916, 2278.646809744492, 2399.952000959971, 2419.697537807774, 2500.099964012954, 9910.20718342538, 9942.602295908155, 10352.378857268588, 10523.73690657732, 10691.091257243144, 1891.848652107828, 1928.3443629166152, 1937.5543624966338, 2014.0936578539715, 2025.1696804310309, 52041.47958520404, 54607.45392546103, 71545.64227178883, 73351.26648733551, 78202.60898695527, 10842.891571084347, 10872.402017888933, 11147.21969462146, 11156.835848193828, 11836.112291578165, 15186.544403667907, 15547.766783498257, 15656.217189140498, 15662.530124096294, 15700.76448853268, 8095.757127286191, 8272.793180170544, 8360.958195208985, 8501.702440414556, 8528.01111349855, 8020.157883422274, 8028.678852845937, 8082.2725954664365, 8232.711855085043, 8262.297704695047, 4467.285234362486, 4587.220172570671, 4697.31888876111, 4728.3143944127905, 4878.195097808822, 1929.218666440094, 2002.3892712722468, 2014.9597008059757, 2019.1014998325898, 2039.765426975887, 964.8938616752292, 1042.4891803016467, 1090.1769164280918, 1093.868735751715, 1107.2304748200086, 18825.717614235797, 19031.858088514735, 19156.23375064982, 19423.611527769364, 19517.707234391495, 980.3382716666364, 998.7153661206667, 1023.2683631203726, 1024.635808794043, 1067.8558394616628, 10460.68617941463, 10703.518341674644, 10923.0, 10931.890681093088, 10954.616588419527, 463969.0, 473975.0, 480465.0, 481141.0, 483011.0, 85352.0, 88636.5568172155, 88864.5556772212, 89055.55472222598, 89708.0, 1032.5147180825, 1048.62249590149, 1053.4679986606714, 1074.693712291993, 1074.8065348237235, 16660.250288736792, 16877.557035313042, 17052.65894682124, 17161.0, 17545.122743863012, 38600.42099368568, 38711.61288387193, 39157.60842391539, 39177.0, 39470.0, 50173.74913125411, 55832.0, 55860.44139558553, 55921.44078559162, 56017.43982560122, 8865.113488651083, 8887.244584210415, 8900.465972041698, 8962.820743584962, 9211.953940230256, 10104.292699510963, 13717.657058573615, 13748.243846588133, 13934.372953216927, 14243.857561424667, 8671.176238257356, 11970.341631210018, 12052.0, 12272.26366417982, 12342.506299747909, 11587.8261826071, 11733.296002239893, 11847.289162650268, 11911.285322880654, 12023.4589443477, 12074.39628018578, 12193.146479746332, 12203.0, 12285.201461904948, 12510.249385036926, 8512.101415693809, 8644.308455323684, 8736.519491428033, 8945.552722363986, 8946.150115738994, 11157.832632510681, 11535.250208736405, 11847.940760296144, 11978.281303121841, 12279.0], "value": 9066.361564435234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.159811715795, 1535.7158925598765, 1552.8369521200273, 1734.1589329175347, 1866.9813301866986, 8335.54154521501, 8783.297336213103, 8802.647894084237, 9043.95478022609, 9066.048064953184, 8817.867731984026, 9010.549472526363, 9024.23294020009, 9027.503487308195, 9028.097190280969, 2000.699895015752, 2261.7851304126166, 2331.5570041692067, 2359.834811563191, 2367.4199821043867, 2363.161077817376, 2367.3253122859987, 2369.4194922243987, 2375.798057165143, 2380.7976322012564, 2302.0561569756405, 2319.35058183708, 2347.1315613223132, 2348.3307257431634, 2350.059976009601, 1971.122850331603, 2232.174095584628, 2246.359787460574, 2296.517731276417, 2301.5396920615945, 2229.2420577003895, 2244.652078927769, 2247.752747197807, 2249.1116009176285, 2250.44864008319, 8999.955000225022, 9068.138526839939, 9074.77313067172, 9079.81840363189, 9085.636574537011, 5321.680699158062, 5461.836144915659, 5465.207544905967, 5471.37079235889, 5473.698946557938, 3350.430426827445, 3406.67636574525, 3459.3600183966046, 3528.1179705073732, 3536.328097661436, 1148.7702459508048, 1162.4768854015726, 1188.3761025461615, 1192.8389667394965, 1207.879212078794, 12642.74714505714, 12729.618111456579, 12745.681357966032, 12751.36243187837, 12765.106442549026, 4528.207563676344, 4577.5880170784785, 4653.813847446064, 4666.556677115668, 4683.1336202802595, 10084.596616135419, 10091.545880435398, 10103.949480252551, 10105.696829095139, 10126.44304563256, 5319.973400133052, 5390.299261096033, 5401.540869026177, 5403.0, 5405.351357837085, 4353.804078816461, 4719.3628860103445, 4833.830815921497, 4834.178189707688, 4899.387576552931, 3669.6697297243377, 3730.981345093257, 3811.7712937223855, 3819.3698039823676, 3840.6543411093135, 1100.158378840172, 1125.9662210133708, 1131.5643477261315, 1153.0487347937985, 1156.1213477756964, 946.6733976778, 976.4043933200742, 979.6326377608397, 982.7690492734201, 991.4646091110719, 5628.352739434936, 5727.398623144593, 5753.309602847685, 5881.470667639933, 5906.0, 432.10985370137615, 443.7825465521871, 444.012073137267, 444.7487169749146, 1001.814230746234, 3855.20968201518, 3937.704672149543, 3950.288947989332, 3995.4805875236616, 4032.3749818778138, 11148.219624626361, 11218.270812397168, 11405.08759299254, 11444.14168937333, 11444.942775286238, 11089.667309980714, 11147.331160130418, 11149.386783726974, 11194.888051119384, 11290.604828830952, 7874.6850125994315, 8184.304334131546, 8193.180681931759, 8519.701810436605, 8660.30717542595, 5933.3769954154195, 6031.788887388921, 6111.877762444815, 6123.84690382744, 6163.753449861955, 10421.791564168523, 10597.0, 10664.84002739944, 10691.518881650189, 10702.946485267836, 9686.467244301632, 10143.137833284254, 10150.187984961332, 10155.070536598023, 10552.314099583502, 7085.291470852873, 7830.060392752906, 8000.119986801564, 8126.0, 8147.837043258983, 9058.864117038382, 9085.77285567866, 9106.134917182857, 9160.908390916005, 9164.450132992042, 7861.1352751198465, 8188.2630563249595, 8220.219079187467, 8330.666773329, 8342.082370939313, 7963.562004089831, 8035.517868927883, 8078.6364613593705, 8131.974190210521, 8233.094359620556, 7187.460940429384, 7285.708571657075, 7295.489315747846, 7368.37368823656, 7437.628118593941, 4990.451050384382, 5049.990001999541, 5088.796448142033, 5130.538251557377, 5218.947810521846, 5197.402298735543, 5197.948020519746, 5264.052470555337, 5384.300040994645, 5389.676619402849], "value": 4615.294302046068, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.90372888133555, 324.43548226086614, 329.7049141018787, 331.98506067226987, 345.87029863801075, 5149.922751158726, 5258.868528286795, 5396.379416367119, 5418.512333889949, 5442.482964118412, 5297.099493086175, 5316.5215130638235, 5318.441563635821, 5326.813561525348, 5357.249985002103, 4167.437395951538, 4202.726822756526, 4213.683973701977, 4230.17511585241, 4235.491740991085, 3912.941305880414, 3995.6403923646867, 4100.302948498747, 4261.318189089746, 4263.4225336625495, 4101.159262351226, 4137.1725654869, 4146.129312844291, 4155.252054630166, 4172.019575399779, 4091.2635725569385, 4105.055837157471, 4108.897277568055, 4113.424120623085, 4117.702923579063, 3471.1842716961496, 3653.6894363979095, 3656.926861462756, 3660.2679464107287, 3664.175560498893, 5135.537801597837, 5149.407818100892, 5165.845024649267, 5171.560417364529, 5178.14560597501, 4769.523047695237, 4801.15979703554, 4808.326834243208, 4822.42130944289, 4823.155947709172, 5289.920651190235, 5444.475546846889, 5500.092484740013, 5540.36285827127, 5562.805301814417, 3926.2540117377894, 3938.5667576566557, 3947.1908258806875, 3953.4267531207815, 3964.4251583520227, 5744.253247077895, 5746.2529871116485, 5768.221290125864, 5770.538356931435, 5808.186853840466, 3915.9636988765683, 4021.9195616087513, 4041.333180025322, 4043.8180281887385, 4080.204360149742, 4138.213739389566, 4149.37759336102, 4151.730137541111, 4152.896177595584, 4161.9375709364385, 4711.246200607955, 4720.622350211975, 4736.242201247784, 4746.311784791186, 4750.7387093709485, 5448.264484294648, 5537.667739935617, 5567.526760225426, 5593.636413633101, 5631.521320687705, 1409.7955796409462, 1417.2771886338041, 1427.5360507834996, 1428.39293300349, 1428.8785453236592, 886.609891647673, 897.7979954510314, 901.2474583722534, 905.2441211588266, 906.6282824042111, 4716.410448693913, 4754.480125533472, 4791.0, 4791.928121078186, 4827.782749776268, 5066.746662666926, 5075.325142702899, 5082.390113186368, 5085.7202853842655, 5105.642605017613, 4772.689775164603, 4800.159972004955, 4805.687630304019, 4820.879478013007, 4967.875803104879, 3083.5683004378957, 3085.768567357457, 3097.132802815215, 3104.3480869017308, 3116.376724655078, 5944.0, 5955.974968510727, 5958.553108516879, 5972.611780234271, 5974.910376344358, 5632.464915832989, 5870.82583483305, 5872.383399743051, 5892.646441213541, 5901.557383196277, 5909.911351329733, 5922.437368449991, 5941.881162376815, 5946.643201407929, 5990.7903223386975, 5571.275734154534, 5718.628289161191, 5767.653940763567, 5848.210491583752, 5875.6474611523445, 5671.914921276101, 5673.262475878109, 5677.233573467529, 5706.686132262766, 5707.429257074259, 5924.851878703067, 5933.347331793413, 5945.64326140433, 5975.940240597538, 5976.133460648095, 3887.8833634990997, 4040.797960101924, 4061.614146656063, 4073.246449406869, 4096.242195193899, 5673.801416950387, 5681.573881958787, 5690.118031705092, 5733.426657334233, 5784.768609255582, 5623.297087864017, 5641.182028605747, 5648.435156484319, 5671.376148623565, 5671.695510032798, 5393.67854875558, 5599.300087489064, 5610.579206559606, 5610.691411972218, 5627.986962346817, 5509.201165831012, 5555.333359996826, 5570.470805273492, 5570.885822835368, 5602.9719851402115, 5355.928814237246, 5614.736684246012, 5671.631343962629, 5703.543716502752, 5705.22979397776, 5533.557315414677, 5571.164325351229, 5571.888562228652, 5580.330360356621, 5590.776368945197], "value": 4218.437407919218, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.7447216890594, 841.928436082933, 852.8592782190939, 862.9309655227582, 878.1087196495554, 13749.106308089968, 14825.851741482595, 14902.105873647588, 15000.699986000274, 15109.77335339968, 14365.497207597737, 14394.640133996629, 14396.784048239258, 14404.855951440482, 14424.783628245585, 694.4895501806182, 803.618281316373, 819.573821612761, 825.471698113208, 835.8328334333128, 831.8918540589746, 837.4975014991018, 840.2437805974641, 840.5671079394117, 840.6637345061963, 884.6992022712277, 885.1414128295576, 885.8626912828522, 885.9468431894074, 886.5035580075146, 738.1658725640019, 863.5595846118493, 879.2658130461073, 879.846026945282, 883.1036497954581, 640.0591131037368, 640.7565125252374, 641.4291280760127, 641.5445034025847, 641.6759536434117, 14431.206283654396, 14482.203478808662, 14492.927535362362, 14494.927525362411, 14509.492167774182, 13930.233837138954, 14001.78997315031, 14008.649783755385, 14177.36201870908, 14275.928620356935, 11599.0, 12111.212771169845, 12290.0, 12487.562935297312, 12813.167144135601, 4471.3740076389, 4478.955210447886, 4570.565796249351, 4593.586577208034, 4621.168189725848, 55574.44425555733, 56907.14639280414, 57050.714746426005, 57323.0, 57649.13526297151, 10938.398388088572, 11128.610498632508, 11368.147388945863, 11589.24669896454, 11686.298822070703, 19893.60212795736, 20056.69064604353, 20069.29757458482, 20072.397828065183, 20076.0, 8076.555789431638, 8081.676732930617, 8428.32573394127, 8449.105195542494, 8522.957385213034, 4523.751193684379, 4693.342931989524, 4695.81216751333, 4743.573078422958, 4944.233643785219, 3594.4608308753373, 3676.3750162472443, 3689.169936764207, 3699.0382500549513, 3704.1850792825535, 671.2180309938964, 682.7234969837224, 684.0662495693343, 696.3697853442643, 706.9010338552607, 693.7225109956058, 717.3973861955982, 722.5267449820376, 759.3583422008394, 770.1643716567474, 9768.560414781352, 9851.852222216672, 9908.20734341251, 9938.155256803107, 9949.850752238723, 699.8005568412977, 714.7998560403096, 737.1412304665005, 750.7297372945735, 757.144426797715, 4601.539846015372, 4635.142498637762, 4669.369635099286, 4686.461056978491, 4693.718376897397, 67237.0, 67292.0, 69667.30332696608, 70244.64877675578, 70508.0, 60301.57285844207, 63435.36564634387, 63853.0, 63949.0, 64585.67707161528, 53460.0, 54484.182737258976, 56172.0, 56675.14987275194, 57024.71487642535, 9089.136532029446, 9089.909210894735, 9137.63449462014, 9160.954195228982, 9282.396644218104, 36736.26527469382, 37095.25809483741, 37209.62790372062, 37809.432858506596, 37858.43212351872, 45360.31959520676, 49044.2643360357, 49062.79217435295, 49315.26027109524, 49903.251451228985, 10931.945340273247, 11311.71720706956, 11394.145439091935, 11414.94292528532, 11759.118066145244, 12326.198797078161, 12357.629271121881, 12416.565420210249, 12624.936875315932, 12879.549215777402, 11152.275102118336, 11616.419179041182, 11937.0, 11991.160618756952, 12542.749145016865, 11874.584389546324, 11967.940160299142, 12217.205881617667, 12415.813762793385, 12618.936905315415, 12044.578439754567, 12045.976092032275, 12072.154949153826, 12441.44013519412, 12502.624921252376, 10000.399976001463, 10090.596376144871, 10381.636642717469, 10425.530851111567, 10427.374357538572, 9930.900690992998, 10099.29304948676, 10144.340617859816, 10187.235957303381, 10202.081812636898], "value": 6963.6845625047235, "unit": "score"}], "name": "dromaeo_css", "value": 7158.968478325275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 105.0, 108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 131.0, 147.0, 215.0, 132.0, 154.0, 147.0, 132.0, 175.0, 123.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 165.0, 162.0, 163.0, 170.0, 162.0, 160.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 155.0, 75.0, 74.0, 76.0, 75.0, 143.0, 77.0], "value": 90.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 92.0, 91.0, 91.0, 122.0, 91.0, 90.0, 124.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 54.0, 56.0, 55.0, 54.0, 107.0, 53.0, 54.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 78.0, 79.0, 78.0, 84.0, 78.0, 81.0, 79.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 119.0, 118.0, 118.0, 120.0, 117.0, 116.0, 200.0, 132.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 165.0, 159.0, 161.0, 168.0, 161.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 63.0, 65.0, 64.0, 63.0, 63.0, 62.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1528.6, "alertThreshold": 2.0}]} 11:31:05 INFO - Return code: 0 11:31:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:31:05 ERROR - # TBPL SUCCESS # 11:31:05 INFO - Running post-action listener: _resource_record_post_action 11:31:05 INFO - ##### 11:31:05 INFO - ##### Finished run-tests step (success) 11:31:05 INFO - ##### 11:31:05 INFO - Running post-run listener: _resource_record_post_run 11:31:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538238976; Read time: 88; Write time: 465376 11:31:05 INFO - TinderboxPrint: CPU usage
13.1% 11:31:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 88 11:31:05 INFO - TinderboxPrint: I/O write bytes / time
538,238,976 / 465,376 11:31:05 INFO - TinderboxPrint: CPU idle
8,274.4 (86.9%) 11:31:05 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 11:31:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:31:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246489088; Read time: 0; Write time: 284644 11:31:05 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291749888; Read time: 88; Write time: 180732 11:31:06 INFO - Running post-run listener: _upload_blobber_files 11:31:06 INFO - Blob upload gear active. 11:31:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:31:06 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 11:31:06 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:31:06 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:31:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:12 INFO - (blobuploader) - INFO - Done attempting. 11:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:12 INFO - (blobuploader) - INFO - Done attempting. 11:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:31:14 INFO - (blobuploader) - INFO - Done attempting. 11:31:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:31:14 INFO - Return code: 0 11:31:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:31:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:31:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2938838558d641e61d83912a533da7c17c3016efb1038ea1bb432c07aa83271b0da740edf320c43119f7cea21d676ee75dc0dd33ea4269e2820df81520fb8d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7484e5f960ef3e182890f0fdf8a371577a0acb5e64bf94512c1f1898ace6b0154c18d763ece24254c0e95121da433e3edac163d3f46e63c4cf215f498e543c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ddb1d9956ce1a31e2b33b10f93315f9350e343b7be1d29dd75518652be88217738ac935e0b80615ca8b0f909b6f16ff81558cc10bf3dd2eb82b45c35471f999"} 11:31:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:31:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:31:14 INFO - Contents: 11:31:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2938838558d641e61d83912a533da7c17c3016efb1038ea1bb432c07aa83271b0da740edf320c43119f7cea21d676ee75dc0dd33ea4269e2820df81520fb8d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7484e5f960ef3e182890f0fdf8a371577a0acb5e64bf94512c1f1898ace6b0154c18d763ece24254c0e95121da433e3edac163d3f46e63c4cf215f498e543c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ddb1d9956ce1a31e2b33b10f93315f9350e343b7be1d29dd75518652be88217738ac935e0b80615ca8b0f909b6f16ff81558cc10bf3dd2eb82b45c35471f999"} 11:31:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:31:14 INFO - Copying logs to upload dir... 11:31:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:31:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.715539 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-16 11:31:11.709006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 11:31:11.712903) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289 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/sha512/2938838558d641e61d83912a533da7c17c3016efb1038ea1bb432c07aa83271b0da740edf320c43119f7cea21d676ee75dc0dd33ea4269e2820df81520fb8d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7484e5f960ef3e182890f0fdf8a371577a0acb5e64bf94512c1f1898ace6b0154c18d763ece24254c0e95121da433e3edac163d3f46e63c4cf215f498e543c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ddb1d9956ce1a31e2b33b10f93315f9350e343b7be1d29dd75518652be88217738ac935e0b80615ca8b0f909b6f16ff81558cc10bf3dd2eb82b45c35471f999"} build_url:https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/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/sha512/2938838558d641e61d83912a533da7c17c3016efb1038ea1bb432c07aa83271b0da740edf320c43119f7cea21d676ee75dc0dd33ea4269e2820df81520fb8d43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7484e5f960ef3e182890f0fdf8a371577a0acb5e64bf94512c1f1898ace6b0154c18d763ece24254c0e95121da433e3edac163d3f46e63c4cf215f498e543c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ddb1d9956ce1a31e2b33b10f93315f9350e343b7be1d29dd75518652be88217738ac935e0b80615ca8b0f909b6f16ff81558cc10bf3dd2eb82b45c35471f999"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 11:31:11.741707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:31:11.742417) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463422027.893115-631542289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:31:11.823770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 11:31:11.824134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 11:31:11.824486) ========= ========= Total master_lag: 0.16 =========