builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1463510037.18 results: success (0) buildid: 20160517083026 builduid: de5b4b4985bf481eafb55018c2b7c499 revision: e51df628d6f718ec8c76085e9a7ecab1ee1c3bb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.184251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.184788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.185112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.277400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.277787) ========= 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=920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 11:33:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.5M=0s 2016-05-17 11:33:57 (41.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.412384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.412784) ========= 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=920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.462306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:57.462873) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e51df628d6f718ec8c76085e9a7ecab1ee1c3bb8 --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 e51df628d6f718ec8c76085e9a7ecab1ee1c3bb8 --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=920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 11:33:57,828 truncating revision to first 12 chars 2016-05-17 11:33:57,828 Setting DEBUG logging. 2016-05-17 11:33:57,828 attempt 1/10 2016-05-17 11:33:57,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e51df628d6f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 11:33:58,228 unpacking tar archive at: fx-team-e51df628d6f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691717 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:58.167857) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:58.168230) ========= script_repo_revision: e51df628d6f718ec8c76085e9a7ecab1ee1c3bb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:58.168704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:58.169015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:33:58.178974) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-17 11:33:58.179283) ========= /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=920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:58 INFO - MultiFileLogger online at 20160517 11:33:58 in /builds/slave/test 11:33:58 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:33:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:58 INFO - {'append_to_log': False, 11:33:58 INFO - 'base_work_dir': '/builds/slave/test', 11:33:58 INFO - 'blob_upload_branch': 'Fx-Team', 11:33:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:58 INFO - 'branch': 'Fx-Team', 11:33:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:58 INFO - 'config_files': ('talos/linux_config.py',), 11:33:58 INFO - 'default_actions': ('clobber', 11:33:58 INFO - 'read-buildbot-config', 11:33:58 INFO - 'download-and-extract', 11:33:58 INFO - 'populate-webroot', 11:33:58 INFO - 'create-virtualenv', 11:33:58 INFO - 'install', 11:33:58 INFO - 'run-tests'), 11:33:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:58 INFO - 'download_minidump_stackwalk': True, 11:33:58 INFO - 'download_symbols': 'ondemand', 11:33:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:33:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:33:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:33:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:33:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:58 INFO - 'installer_path': 'installer.exe', 11:33:58 INFO - 'log_level': 'info', 11:33:58 INFO - 'log_name': 'talos', 11:33:58 INFO - 'log_to_console': True, 11:33:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:58 INFO - 'opt_config_files': (), 11:33:58 INFO - 'pip_index': False, 11:33:58 INFO - 'sps_profile': False, 11:33:58 INFO - 'sps_profile_interval': 0, 11:33:58 INFO - 'suite': 'dromaeojs', 11:33:58 INFO - 'system_bits': '32', 11:33:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:58 INFO - 'title': 'talos-linux64-ix-053', 11:33:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:58 INFO - 'use_talos_json': True, 11:33:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:58 INFO - 'work_dir': 'build'} 11:33:58 INFO - ##### 11:33:58 INFO - ##### Running clobber step. 11:33:58 INFO - ##### 11:33:58 INFO - Running pre-action listener: _resource_record_pre_action 11:33:58 INFO - Running main action method: clobber 11:33:58 INFO - rmtree: /builds/slave/test/build 11:33:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:33:59 INFO - Running post-action listener: _resource_record_post_action 11:33:59 INFO - ##### 11:33:59 INFO - ##### Finished clobber step (success) 11:33:59 INFO - ##### 11:33:59 INFO - ##### 11:33:59 INFO - ##### Running read-buildbot-config step. 11:33:59 INFO - ##### 11:33:59 INFO - Running pre-action listener: _resource_record_pre_action 11:33:59 INFO - Running main action method: read_buildbot_config 11:33:59 INFO - Using buildbot properties: 11:33:59 INFO - { 11:33:59 INFO - "project": "", 11:33:59 INFO - "product": "firefox", 11:33:59 INFO - "script_repo_revision": "production", 11:33:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:33:59 INFO - "repository": "", 11:33:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:33:59 INFO - "buildid": "20160517083026", 11:33:59 INFO - "pgo_build": "True", 11:33:59 INFO - "basedir": "/builds/slave/test", 11:33:59 INFO - "buildnumber": 690, 11:33:59 INFO - "slavename": "talos-linux64-ix-053", 11:33:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:33:59 INFO - "platform": "ubuntu64_hw", 11:33:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:33:59 INFO - "branch": "fx-team", 11:33:59 INFO - "repo_path": "integration/fx-team", 11:33:59 INFO - "revision": "e51df628d6f718ec8c76085e9a7ecab1ee1c3bb8", 11:33:59 INFO - "stage_platform": "linux64-pgo", 11:33:59 INFO - "builduid": "de5b4b4985bf481eafb55018c2b7c499", 11:33:59 INFO - "slavebuilddir": "test" 11:33:59 INFO - } 11:33:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:33:59 INFO - Running post-action listener: _resource_record_post_action 11:33:59 INFO - ##### 11:33:59 INFO - ##### Finished read-buildbot-config step (success) 11:33:59 INFO - ##### 11:33:59 INFO - ##### 11:33:59 INFO - ##### Running download-and-extract step. 11:33:59 INFO - ##### 11:33:59 INFO - Running pre-action listener: _resource_record_pre_action 11:33:59 INFO - Running main action method: download_and_extract 11:33:59 INFO - mkdir: /builds/slave/test/build/tests 11:33: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:33:59 INFO - https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:33:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:33:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:33:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:33:59 INFO - Downloaded 1361 bytes. 11:33:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:33:59 INFO - Using the following test package requirements: 11:33:59 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:33:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:33:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'jsshell-linux-x86_64.zip'], 11:33:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:33:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:33:59 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:33:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:33:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:33:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:33: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:33:59 INFO - https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:33:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:33:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:33:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:34:00 INFO - Downloaded 24023288 bytes. 11:34:00 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:34:00 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:34:02 INFO - Return code: 0 11:34:02 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:34: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:34:02 INFO - https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:34:03 INFO - Downloaded 24023288 bytes. 11:34:03 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:34:03 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:34:04 INFO - Return code: 0 11:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:04 INFO - https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:34:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:34:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:34:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:34:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:34:05 INFO - Downloaded 10840194 bytes. 11:34:05 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:34:05 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:34:05 INFO - Return code: 0 11:34:05 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:34:05 INFO - https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:34:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:34:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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:34:07 INFO - Downloaded 58393469 bytes. 11:34:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:07 INFO - mkdir: /builds/slave/test/properties 11:34:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:34:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:34:07 INFO - Contents: 11:34:07 INFO - build_url:https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:34:07 INFO - Running post-action listener: _resource_record_post_action 11:34:07 INFO - Running post-action listener: set_extra_try_arguments 11:34:07 INFO - ##### 11:34:07 INFO - ##### Finished download-and-extract step (success) 11:34:07 INFO - ##### 11:34:07 INFO - ##### 11:34:07 INFO - ##### Running populate-webroot step. 11:34:07 INFO - ##### 11:34:07 INFO - Running pre-action listener: _resource_record_pre_action 11:34:07 INFO - Running main action method: populate_webroot 11:34:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:34:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:34:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:34:07 INFO - '--tppagecycles', 11:34:07 INFO - '7'], 11:34:07 INFO - 'tests': ['tsvgm']}}, 11:34:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:34:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:34:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:34:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:34:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['damp', 'tps']}, 11:34:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'tests': ['damp', 'tps']}, 11:34:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['dromaeo_dom']}, 11:34:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:34:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['a11yr', 11:34:07 INFO - 'ts_paint', 11:34:07 INFO - 'tpaint', 11:34:07 INFO - 'sessionrestore', 11:34:07 INFO - 'sessionrestore_no_auto_restore', 11:34:07 INFO - 'tabpaint']}, 11:34:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:34:07 INFO - 'ts_paint', 11:34:07 INFO - 'tpaint', 11:34:07 INFO - 'sessionrestore', 11:34:07 INFO - 'sessionrestore_no_auto_restore', 11:34:07 INFO - 'tabpaint']}, 11:34:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:34:07 INFO - 'ts_paint', 11:34:07 INFO - 'tpaint', 11:34:07 INFO - 'sessionrestore', 11:34:07 INFO - 'sessionrestore_no_auto_restore', 11:34:07 INFO - 'tabpaint']}, 11:34:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:34:07 INFO - 'ts_paint', 11:34:07 INFO - 'tpaint', 11:34:07 INFO - 'sessionrestore', 11:34:07 INFO - 'sessionrestore_no_auto_restore', 11:34:07 INFO - 'tabpaint']}, 11:34:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['a11yr', 11:34:07 INFO - 'ts_paint', 11:34:07 INFO - 'tpaint', 11:34:07 INFO - 'sessionrestore', 11:34:07 INFO - 'sessionrestore_no_auto_restore', 11:34:07 INFO - 'tabpaint']}, 11:34:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['a11yr', 11:34:07 INFO - 'ts_paint', 11:34:07 INFO - 'tpaint', 11:34:07 INFO - 'sessionrestore', 11:34:07 INFO - 'sessionrestore_no_auto_restore', 11:34:07 INFO - 'tabpaint']}, 11:34:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['tsvgx', 11:34:07 INFO - 'tsvgr_opacity', 11:34:07 INFO - 'tart', 11:34:07 INFO - 'tscrollx', 11:34:07 INFO - 'cart']}, 11:34:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:34:07 INFO - 'tsvgr_opacity', 11:34:07 INFO - 'tart', 11:34:07 INFO - 'tscrollx', 11:34:07 INFO - 'cart']}, 11:34:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'talos_options': ['--disable-e10s'], 11:34:07 INFO - 'tests': ['tp5o']}, 11:34:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'tests': ['tp5o']}, 11:34:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'talos_options': ['--disable-e10s', 11:34:07 INFO - '--xperf_path', 11:34:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:07 INFO - 'tests': ['tp5n']}, 11:34:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:07 INFO - 'talos_options': ['--xperf_path', 11:34:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:07 INFO - 'tests': ['tp5n']}}, 11:34:07 INFO - 'talos.zip': {'path': '', 11:34:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:34:07 INFO - Running post-action listener: _resource_record_post_action 11:34:07 INFO - ##### 11:34:07 INFO - ##### Finished populate-webroot step (success) 11:34:07 INFO - ##### 11:34:07 INFO - ##### 11:34:07 INFO - ##### Running create-virtualenv step. 11:34:07 INFO - ##### 11:34:07 INFO - Running pre-action listener: _resource_record_pre_action 11:34:07 INFO - Running main action method: create_virtualenv 11:34:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:34:07 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:34:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:34:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:34:07 INFO - Using real prefix '/usr' 11:34:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:34:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:34:10 INFO - Installing pip.................done. 11:34:10 INFO - Return code: 0 11:34:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:34:10 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:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:10 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:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:10 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:10 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:34:10 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:34:10 INFO - Using env: {'DISPLAY': ':0', 11:34:10 INFO - 'HOME': '/home/cltbld', 11:34:10 INFO - 'LANG': 'en_US.UTF-8', 11:34:10 INFO - 'LANGUAGE': 'en_US:en', 11:34:10 INFO - 'LOGNAME': 'cltbld', 11:34:10 INFO - 'MAIL': '/var/mail/cltbld', 11:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:10 INFO - 'MOZ_NO_REMOTE': '1', 11:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:10 INFO - 'NO_EM_RESTART': '1', 11:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:10 INFO - 'PWD': '/builds/slave/test', 11:34:10 INFO - 'SHELL': '/bin/bash', 11:34:10 INFO - 'SHLVL': '1', 11:34:10 INFO - 'TERM': 'linux', 11:34:10 INFO - 'TMOUT': '86400', 11:34:10 INFO - 'USER': 'cltbld', 11:34:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:10 INFO - '_': '/tools/buildbot/bin/python'} 11:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:10 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:34:10 INFO - Cleaning up... 11:34:10 INFO - Return code: 0 11:34:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:34:10 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:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:10 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:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:10 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:10 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:34:10 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:34:10 INFO - Using env: {'DISPLAY': ':0', 11:34:10 INFO - 'HOME': '/home/cltbld', 11:34:10 INFO - 'LANG': 'en_US.UTF-8', 11:34:10 INFO - 'LANGUAGE': 'en_US:en', 11:34:10 INFO - 'LOGNAME': 'cltbld', 11:34:10 INFO - 'MAIL': '/var/mail/cltbld', 11:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:10 INFO - 'MOZ_NO_REMOTE': '1', 11:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:10 INFO - 'NO_EM_RESTART': '1', 11:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:10 INFO - 'PWD': '/builds/slave/test', 11:34:10 INFO - 'SHELL': '/bin/bash', 11:34:10 INFO - 'SHLVL': '1', 11:34:10 INFO - 'TERM': 'linux', 11:34:10 INFO - 'TMOUT': '86400', 11:34:10 INFO - 'USER': 'cltbld', 11:34:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:10 INFO - '_': '/tools/buildbot/bin/python'} 11:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:10 INFO - Downloading/unpacking psutil>=3.1.1 11:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:34:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:12 INFO - Installing collected packages: psutil 11:34:12 INFO - Running setup.py install for psutil 11:34:13 INFO - building 'psutil._psutil_linux' extension 11:34:13 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:34:13 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:34:13 INFO - building 'psutil._psutil_posix' extension 11:34:13 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:34:13 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:34:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:13 INFO - Successfully installed psutil 11:34:13 INFO - Cleaning up... 11:34:13 INFO - Return code: 0 11:34:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:13 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:13 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:34:13 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:34:13 INFO - Using env: {'DISPLAY': ':0', 11:34:13 INFO - 'HOME': '/home/cltbld', 11:34:13 INFO - 'LANG': 'en_US.UTF-8', 11:34:13 INFO - 'LANGUAGE': 'en_US:en', 11:34:13 INFO - 'LOGNAME': 'cltbld', 11:34:13 INFO - 'MAIL': '/var/mail/cltbld', 11:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:13 INFO - 'MOZ_NO_REMOTE': '1', 11:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:13 INFO - 'NO_EM_RESTART': '1', 11:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:13 INFO - 'PWD': '/builds/slave/test', 11:34:13 INFO - 'SHELL': '/bin/bash', 11:34:13 INFO - 'SHLVL': '1', 11:34:13 INFO - 'TERM': 'linux', 11:34:13 INFO - 'TMOUT': '86400', 11:34:13 INFO - 'USER': 'cltbld', 11:34:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:13 INFO - '_': '/tools/buildbot/bin/python'} 11:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:34:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:34:15 INFO - Installing collected packages: mozsystemmonitor 11:34:15 INFO - Running setup.py install for mozsystemmonitor 11:34:15 INFO - Successfully installed mozsystemmonitor 11:34:15 INFO - Cleaning up... 11:34:15 INFO - Return code: 0 11:34:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:15 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:15 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:34:15 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:34:15 INFO - Using env: {'DISPLAY': ':0', 11:34:15 INFO - 'HOME': '/home/cltbld', 11:34:15 INFO - 'LANG': 'en_US.UTF-8', 11:34:15 INFO - 'LANGUAGE': 'en_US:en', 11:34:15 INFO - 'LOGNAME': 'cltbld', 11:34:15 INFO - 'MAIL': '/var/mail/cltbld', 11:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:15 INFO - 'MOZ_NO_REMOTE': '1', 11:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:15 INFO - 'NO_EM_RESTART': '1', 11:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:15 INFO - 'PWD': '/builds/slave/test', 11:34:15 INFO - 'SHELL': '/bin/bash', 11:34:15 INFO - 'SHLVL': '1', 11:34:15 INFO - 'TERM': 'linux', 11:34:15 INFO - 'TMOUT': '86400', 11:34:15 INFO - 'USER': 'cltbld', 11:34:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:15 INFO - '_': '/tools/buildbot/bin/python'} 11:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:15 INFO - Downloading/unpacking blobuploader==1.2.4 11:34:15 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:34:15 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:34:15 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:34:15 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:34:15 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:34:15 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:34:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:34:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:34:17 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:34:17 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:34:17 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:34:17 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:34:17 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:34:17 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:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:34:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:34:18 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:34:18 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:34:18 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:34:18 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:34:18 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:34:18 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:34:18 INFO - Downloading docopt-0.6.1.tar.gz 11:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:34:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:34:18 INFO - Running setup.py install for blobuploader 11:34:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:34:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:34:18 INFO - Running setup.py install for requests 11:34:19 INFO - Running setup.py install for docopt 11:34:19 INFO - Successfully installed blobuploader requests docopt 11:34:19 INFO - Cleaning up... 11:34:19 INFO - Return code: 0 11:34:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:19 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:19 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:34:19 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:34:19 INFO - Using env: {'DISPLAY': ':0', 11:34:19 INFO - 'HOME': '/home/cltbld', 11:34:19 INFO - 'LANG': 'en_US.UTF-8', 11:34:19 INFO - 'LANGUAGE': 'en_US:en', 11:34:19 INFO - 'LOGNAME': 'cltbld', 11:34:19 INFO - 'MAIL': '/var/mail/cltbld', 11:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:19 INFO - 'MOZ_NO_REMOTE': '1', 11:34:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:19 INFO - 'NO_EM_RESTART': '1', 11:34:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:19 INFO - 'PWD': '/builds/slave/test', 11:34:19 INFO - 'SHELL': '/bin/bash', 11:34:19 INFO - 'SHLVL': '1', 11:34:19 INFO - 'TERM': 'linux', 11:34:19 INFO - 'TMOUT': '86400', 11:34:19 INFO - 'USER': 'cltbld', 11:34:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:19 INFO - '_': '/tools/buildbot/bin/python'} 11:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:19 INFO - Running setup.py (path:/tmp/pip-eqVHKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:19 INFO - Running setup.py (path:/tmp/pip-wpRS8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:19 INFO - Running setup.py (path:/tmp/pip-zbt4n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:19 INFO - Running setup.py (path:/tmp/pip-As7inT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:19 INFO - Running setup.py (path:/tmp/pip-JS1BOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:19 INFO - Running setup.py (path:/tmp/pip-6pwp9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:19 INFO - Running setup.py (path:/tmp/pip-1izsoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:19 INFO - Running setup.py (path:/tmp/pip-aetVz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:20 INFO - Running setup.py (path:/tmp/pip-kKf4nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:20 INFO - Running setup.py (path:/tmp/pip-qRenjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:20 INFO - Running setup.py (path:/tmp/pip-R3_aQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:20 INFO - Running setup.py (path:/tmp/pip-rFH3jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:20 INFO - Running setup.py (path:/tmp/pip-7AOWNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:20 INFO - Running setup.py (path:/tmp/pip-Njd2jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:20 INFO - Running setup.py (path:/tmp/pip-tN_Xq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:20 INFO - Running setup.py (path:/tmp/pip-FrtfR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:20 INFO - Running setup.py (path:/tmp/pip-HGFB0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:34:20 INFO - Running setup.py install for manifestparser 11:34:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:34:20 INFO - Running setup.py install for mozcrash 11:34:20 INFO - Running setup.py install for mozdebug 11:34:20 INFO - Running setup.py install for mozdevice 11:34:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Running setup.py install for mozfile 11:34:21 INFO - Running setup.py install for mozhttpd 11:34:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Running setup.py install for mozinfo 11:34:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Running setup.py install for mozInstall 11:34:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Running setup.py install for mozleak 11:34:21 INFO - Running setup.py install for mozlog 11:34:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Running setup.py install for moznetwork 11:34:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:34:21 INFO - Running setup.py install for mozprocess 11:34:21 INFO - Running setup.py install for mozprofile 11:34:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:34:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:34:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:34:22 INFO - Running setup.py install for mozrunner 11:34:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:34:22 INFO - Running setup.py install for mozscreenshot 11:34:22 INFO - Running setup.py install for moztest 11:34:22 INFO - Running setup.py install for mozversion 11:34:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:34:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:34:22 INFO - Cleaning up... 11:34:22 INFO - Return code: 0 11:34:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:22 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:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:22 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:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:22 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:22 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:34:22 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:34:22 INFO - Using env: {'DISPLAY': ':0', 11:34:22 INFO - 'HOME': '/home/cltbld', 11:34:22 INFO - 'LANG': 'en_US.UTF-8', 11:34:22 INFO - 'LANGUAGE': 'en_US:en', 11:34:22 INFO - 'LOGNAME': 'cltbld', 11:34:22 INFO - 'MAIL': '/var/mail/cltbld', 11:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:22 INFO - 'MOZ_NO_REMOTE': '1', 11:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:22 INFO - 'NO_EM_RESTART': '1', 11:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:22 INFO - 'PWD': '/builds/slave/test', 11:34:22 INFO - 'SHELL': '/bin/bash', 11:34:22 INFO - 'SHLVL': '1', 11:34:22 INFO - 'TERM': 'linux', 11:34:22 INFO - 'TMOUT': '86400', 11:34:22 INFO - 'USER': 'cltbld', 11:34:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:22 INFO - '_': '/tools/buildbot/bin/python'} 11:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:22 INFO - Running setup.py (path:/tmp/pip-YY1_4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:22 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:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:22 INFO - Running setup.py (path:/tmp/pip-5W0m81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:22 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:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:22 INFO - Running setup.py (path:/tmp/pip-NND4dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:22 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:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:22 INFO - Running setup.py (path:/tmp/pip-DuklHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:22 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:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:22 INFO - Running setup.py (path:/tmp/pip-2KeT6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:23 INFO - Running setup.py (path:/tmp/pip-IzHzF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:23 INFO - Running setup.py (path:/tmp/pip-g11SXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:23 INFO - Running setup.py (path:/tmp/pip-YgBIfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:23 INFO - Running setup.py (path:/tmp/pip-uRqObm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:23 INFO - Running setup.py (path:/tmp/pip-qqbt4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:23 INFO - Running setup.py (path:/tmp/pip-1Wk55u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:23 INFO - Running setup.py (path:/tmp/pip-EVBFg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:23 INFO - Running setup.py (path:/tmp/pip-Pa1O8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:23 INFO - Running setup.py (path:/tmp/pip-7EKqEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:23 INFO - Running setup.py (path:/tmp/pip-lHEsYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:23 INFO - Running setup.py (path:/tmp/pip-hc3QRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:23 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:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:23 INFO - Running setup.py (path:/tmp/pip-ixeZLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:23 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:34:23 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:34:23 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:34:23 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:34:23 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:34:23 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:34:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:34:23 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:34:23 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:34:23 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:34:23 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:34:23 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:34:23 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:34:25 INFO - Downloading blessings-1.6.tar.gz 11:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:34:25 INFO - Installing collected packages: blessings 11:34:25 INFO - Running setup.py install for blessings 11:34:26 INFO - Successfully installed blessings 11:34:26 INFO - Cleaning up... 11:34:26 INFO - Return code: 0 11:34:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:26 INFO - Reading from file tmpfile_stdout 11:34:26 INFO - Current package versions: 11:34:26 INFO - argparse == 1.2.1 11:34:26 INFO - blessings == 1.6 11:34:26 INFO - blobuploader == 1.2.4 11:34:26 INFO - docopt == 0.6.1 11:34:26 INFO - manifestparser == 1.1 11:34:26 INFO - mozInstall == 1.12 11:34:26 INFO - mozcrash == 0.17 11:34:26 INFO - mozdebug == 0.1 11:34:26 INFO - mozdevice == 0.48 11:34:26 INFO - mozfile == 1.2 11:34:26 INFO - mozhttpd == 0.7 11:34:26 INFO - mozinfo == 0.9 11:34:26 INFO - mozleak == 0.1 11:34:26 INFO - mozlog == 3.2 11:34:26 INFO - moznetwork == 0.27 11:34:26 INFO - mozprocess == 0.22 11:34:26 INFO - mozprofile == 0.28 11:34:26 INFO - mozrunner == 6.11 11:34:26 INFO - mozscreenshot == 0.1 11:34:26 INFO - mozsystemmonitor == 0.3 11:34:26 INFO - moztest == 0.7 11:34:26 INFO - mozversion == 1.4 11:34:26 INFO - psutil == 3.1.1 11:34:26 INFO - requests == 1.2.3 11:34:26 INFO - wsgiref == 0.1.2 11:34:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:26 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:26 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:34:26 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:34:26 INFO - Using env: {'DISPLAY': ':0', 11:34:26 INFO - 'HOME': '/home/cltbld', 11:34:26 INFO - 'LANG': 'en_US.UTF-8', 11:34:26 INFO - 'LANGUAGE': 'en_US:en', 11:34:26 INFO - 'LOGNAME': 'cltbld', 11:34:26 INFO - 'MAIL': '/var/mail/cltbld', 11:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:26 INFO - 'MOZ_NO_REMOTE': '1', 11:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:26 INFO - 'NO_EM_RESTART': '1', 11:34:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:26 INFO - 'PWD': '/builds/slave/test', 11:34:26 INFO - 'SHELL': '/bin/bash', 11:34:26 INFO - 'SHLVL': '1', 11:34:26 INFO - 'TERM': 'linux', 11:34:26 INFO - 'TMOUT': '86400', 11:34:26 INFO - 'USER': 'cltbld', 11:34:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:26 INFO - '_': '/tools/buildbot/bin/python'} 11:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 INFO - Cleaning up... 11:34:26 INFO - Return code: 0 11:34:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:26 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:26 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:34:26 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:34:26 INFO - Using env: {'DISPLAY': ':0', 11:34:26 INFO - 'HOME': '/home/cltbld', 11:34:26 INFO - 'LANG': 'en_US.UTF-8', 11:34:26 INFO - 'LANGUAGE': 'en_US:en', 11:34:26 INFO - 'LOGNAME': 'cltbld', 11:34:26 INFO - 'MAIL': '/var/mail/cltbld', 11:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:26 INFO - 'MOZ_NO_REMOTE': '1', 11:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:26 INFO - 'NO_EM_RESTART': '1', 11:34:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:26 INFO - 'PWD': '/builds/slave/test', 11:34:26 INFO - 'SHELL': '/bin/bash', 11:34:26 INFO - 'SHLVL': '1', 11:34:26 INFO - 'TERM': 'linux', 11:34:26 INFO - 'TMOUT': '86400', 11:34:26 INFO - 'USER': 'cltbld', 11:34:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:26 INFO - '_': '/tools/buildbot/bin/python'} 11:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:26 INFO - Downloading/unpacking jsonschema 11:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:26 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:34:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:34:28 INFO - Downloading/unpacking functools32 (from jsonschema) 11:34:28 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:34:28 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:34:28 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:34:28 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:34:28 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:34:28 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:34:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:34:28 INFO - warning: no files found matching '*.txt' 11:34:28 INFO - no previously-included directories found matching 'build' 11:34:28 INFO - no previously-included directories found matching 'dist' 11:34:28 INFO - no previously-included directories found matching '.git*' 11:34:28 INFO - Installing collected packages: jsonschema, functools32 11:34:28 INFO - Running setup.py install for functools32 11:34:29 INFO - warning: no files found matching '*.txt' 11:34:29 INFO - no previously-included directories found matching 'build' 11:34:29 INFO - no previously-included directories found matching 'dist' 11:34:29 INFO - no previously-included directories found matching '.git*' 11:34:29 INFO - Successfully installed jsonschema functools32 11:34:29 INFO - Cleaning up... 11:34:29 INFO - Return code: 0 11:34:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:34: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:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34: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:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:29 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 0x7fb949982f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, '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': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', '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:34:29 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:34:29 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:34:29 INFO - Using env: {'DISPLAY': ':0', 11:34:29 INFO - 'HOME': '/home/cltbld', 11:34:29 INFO - 'LANG': 'en_US.UTF-8', 11:34:29 INFO - 'LANGUAGE': 'en_US:en', 11:34:29 INFO - 'LOGNAME': 'cltbld', 11:34:29 INFO - 'MAIL': '/var/mail/cltbld', 11:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:29 INFO - 'MOZ_NO_REMOTE': '1', 11:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:29 INFO - 'NO_EM_RESTART': '1', 11:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:29 INFO - 'PWD': '/builds/slave/test', 11:34:29 INFO - 'SHELL': '/bin/bash', 11:34:29 INFO - 'SHLVL': '1', 11:34:29 INFO - 'TERM': 'linux', 11:34:29 INFO - 'TMOUT': '86400', 11:34:29 INFO - 'USER': 'cltbld', 11:34:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:29 INFO - '_': '/tools/buildbot/bin/python'} 11:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:29 INFO - Downloading/unpacking flake8 11:34:29 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:34:29 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:34:29 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:34:29 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:34:29 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:34:29 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:34:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:34:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:34:31 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:34:31 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:34:31 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:34:31 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:34:31 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:34:31 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:34:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:34:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:34:31 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:34:31 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:34:31 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:34:31 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:34:31 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:34:31 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:34:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:34:31 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:34:31 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:34:31 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:34:31 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:34:31 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:34:31 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:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:34:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:34:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:34:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:34:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:34:31 INFO - no previously-included directories found matching 'docs/_build' 11:34:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:34:31 INFO - Running setup.py install for pep8 11:34:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:34:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:34:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:34:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:34:32 INFO - no previously-included directories found matching 'docs/_build' 11:34:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:34:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:34:32 INFO - Cleaning up... 11:34:32 INFO - Return code: 0 11:34:32 INFO - Running post-action listener: _resource_record_post_action 11:34:32 INFO - Running post-action listener: _start_resource_monitoring 11:34:32 INFO - Starting resource monitoring. 11:34:32 INFO - ##### 11:34:32 INFO - ##### Finished create-virtualenv step (success) 11:34:32 INFO - ##### 11:34:32 INFO - ##### 11:34:32 INFO - ##### Running install step. 11:34:32 INFO - ##### 11:34:32 INFO - Running pre-action listener: _resource_record_pre_action 11:34:32 INFO - Running main action method: install 11:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:32 INFO - Reading from file tmpfile_stdout 11:34:32 INFO - Detecting whether we're running mozinstall >=1.0... 11:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:34:32 INFO - Reading from file tmpfile_stdout 11:34:32 INFO - Output received: 11:34:32 INFO - Usage: mozinstall [options] installer 11:34:32 INFO - Options: 11:34:32 INFO - -h, --help show this help message and exit 11:34:32 INFO - -d DEST, --destination=DEST 11:34:32 INFO - Directory to install application into. [default: 11:34:32 INFO - "/builds/slave/test"] 11:34:32 INFO - --app=APP Application being installed. [default: firefox] 11:34:32 INFO - mkdir: /builds/slave/test/build/application 11:34:32 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:34:32 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:34:49 INFO - Reading from file tmpfile_stdout 11:34:49 INFO - Output received: 11:34:49 INFO - /builds/slave/test/build/application/firefox/firefox 11:34:49 INFO - Running post-action listener: _resource_record_post_action 11:34:49 INFO - ##### 11:34:49 INFO - ##### Finished install step (success) 11:34:49 INFO - ##### 11:34:49 INFO - ##### 11:34:49 INFO - ##### Running run-tests step. 11:34:49 INFO - ##### 11:34:49 INFO - Running pre-action listener: _resource_record_pre_action 11:34:49 INFO - Running main action method: run_tests 11:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:34:49 INFO - Python 2.7.3 11:34:49 INFO - Return code: 0 11:34:49 INFO - grabbing minidump binary from tooltool 11:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:49 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 0x215a9c0>, '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 0x215b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:34:49 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:34:49 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:34:49 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:34:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:34:49 INFO - Return code: 0 11:34:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:34:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:34:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:34:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:34:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:34:50 INFO - Return code: 0 11:34:50 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/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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:34:50 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/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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:34:50 INFO - Using env: {'DISPLAY': ':0', 11:34:50 INFO - 'HOME': '/home/cltbld', 11:34:50 INFO - 'LANG': 'en_US.UTF-8', 11:34:50 INFO - 'LANGUAGE': 'en_US:en', 11:34:50 INFO - 'LOGNAME': 'cltbld', 11:34:50 INFO - 'MAIL': '/var/mail/cltbld', 11:34:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:50 INFO - 'MOZ_NO_REMOTE': '1', 11:34:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:50 INFO - 'NO_EM_RESTART': '1', 11:34:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:50 INFO - 'PWD': '/builds/slave/test', 11:34:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:50 INFO - 'SHELL': '/bin/bash', 11:34:50 INFO - 'SHLVL': '1', 11:34:50 INFO - 'TERM': 'linux', 11:34:50 INFO - 'TMOUT': '86400', 11:34:50 INFO - 'USER': 'cltbld', 11:34:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942', 11:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:50 INFO - '_': '/tools/buildbot/bin/python'} 11:34:50 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/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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:34:50 INFO - mozversion application_buildid: 20160517083026 11:34:50 INFO - mozversion application_changeset: e51df628d6f718ec8c76085e9a7ecab1ee1c3bb8 11:34:50 INFO - mozversion application_display_name: Nightly 11:34:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:34:50 INFO - mozversion application_name: Firefox 11:34:50 INFO - mozversion application_remotingname: firefox 11:34:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:34:50 INFO - mozversion application_vendor: Mozilla 11:34:50 INFO - mozversion application_version: 49.0a1 11:34:50 INFO - mozversion platform_buildid: 20160517083026 11:34:50 INFO - mozversion platform_changeset: e51df628d6f718ec8c76085e9a7ecab1ee1c3bb8 11:34:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:34:50 INFO - mozversion platform_version: 49.0a1 11:34:50 INFO - using testdate: 1463510090 11:34:50 INFO - actual date: 1463510090 11:34:50 INFO - starting webserver on 'localhost:44511' 11:34:50 INFO - SUITE-START | Running 2 tests 11:34:50 INFO - TEST-START | dromaeo_css 11:34:50 INFO - operating with platform_type : linux_ 11:34:50 INFO - Initialising browser for dromaeo_css test... 11:34:50 INFO - TEST-INFO | started process 29227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sFn4u/profile http://localhost:44511/getInfo.html) 11:34:54 INFO - PROCESS | 29227 | __metrics Screen width/height:1600/1200 11:34:54 INFO - PROCESS | 29227 | colorDepth:24 11:34:54 INFO - PROCESS | 29227 | Browser inner width/height: 1024/697 11:34:54 INFO - PROCESS | 29227 | __metrics 11:34:55 ERROR - PROCESS | 29227 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:34:56 INFO - TEST-INFO | 29227: exit 0 11:34:56 INFO - Browser initialized. 11:34:56 INFO - Running cycle 1/1 for dromaeo_css test... 11:34:56 INFO - TEST-INFO | started process 29308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sFn4u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:08 INFO - PROCESS | 29308 | RSS: Main: 152895488 11:35:08 INFO - PROCESS | 29308 | 11:35:59 INFO - PROCESS | 29308 | 1463510159664 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:38:07 INFO - PROCESS | 29308 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44511/tests/dromaeo/cssquery-ext.html) 11:38:08 INFO - PROCESS | 29308 | RSS: Main: 250834944 11:38:08 INFO - PROCESS | 29308 | 11:41:11 INFO - PROCESS | 29308 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-ext.html (next: http://localhost:44511/tests/dromaeo/cssquery-jquery.html) 11:41:11 INFO - PROCESS | 29308 | RSS: Main: 231964672 11:41:11 INFO - PROCESS | 29308 | 11:44:13 INFO - PROCESS | 29308 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44511/tests/dromaeo/cssquery-mootools.html) 11:44:14 INFO - PROCESS | 29308 | RSS: Main: 238202880 11:44:14 INFO - PROCESS | 29308 | 11:47:16 INFO - PROCESS | 29308 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44511/tests/dromaeo/cssquery-prototype.html) 11:47:16 INFO - PROCESS | 29308 | RSS: Main: 231067648 11:47:16 INFO - PROCESS | 29308 | 11:50:19 INFO - PROCESS | 29308 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44511/tests/dromaeo/cssquery-yui.html) 11:50:19 INFO - PROCESS | 29308 | RSS: Main: 212279296 11:50:19 INFO - PROCESS | 29308 | 11:53:22 INFO - PROCESS | 29308 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-yui.html (next: http://localhost:44511/tests/dromaeo/cssquery-dojo.html) 11:53:23 INFO - PROCESS | 29308 | RSS: Main: 289071104 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | __start_tp_report 11:53:23 INFO - PROCESS | 29308 | _x_x_mozilla_page_load 11:53:23 INFO - PROCESS | 29308 | _x_x_mozilla_page_load_details 11:53:23 INFO - PROCESS | 29308 | |i|pagename|runs| 11:53:23 INFO - PROCESS | 29308 | |0;dojo.html;3187.7927934684244;3203.6796320367953;3224.7258982986446;3237.4010808000507;3273.5089736539517;5348.384935732392;5392.838214853556;5397.919031214525;5398.64908780929;5459.099248623982;5410.810621628244;5425.83722488326;5449.536789372898;5496.477834605706;5518.806841760539;4869.440014398345;4916.606671466292;4961.6278779091535;4976.154053810861;5151.716655583941;5059.11465493539;5068.518490743373;5103.055934652083;5117.513836185556;5127.5128862758165;4860.465348811628;4880.219164933629;4889.804407823683;4912.238603016538;4943.011397720452;4896.143174944406;4898.510148985109;4954;4957.5786058185095;4992.825251116194;4817.61459083276;4922.483139270361;4933.901321973576;4938.432080310774;4951.504849515056;5276;5357.464253574651;5359.678419294854;5420.864478388072;5424.213489044067;5838.591298609099;5849.707514624294;5871.677057761822;5891.528677705774;5899.970500147472;5738.885222295531;5835.328937172237;5906.763729450817;5949.077892926603;5954.940450595482;5477.20580515823;5522.696251706195;5523.143912693539;5524.33707955044;5579.581531385122;6050.122732203894;6060.515158787286;6066.848328791815;6067.302260240041;6070.2108725865355;5560.221568980346;5690.857728556819;5726.513246374022;5859.619124756877;5871.32479764824;5853.619514731614;5855.355910849803;5858.677772722541;5875.6474611523445;5912.320083190488;5751.482366587027;5787.681677507693;5805.303363596311;5807.970960145257;5832.854178645568;5606.046972014768;5778.797742079007;5784.797532086357;5846.093855452412;5848.4151584841175;4441.956140307026;4446.933296000562;4457.286834106528;4458.242098843204;4494.685372023927;3966.206758648224;3981.1042515434374;3990.0423898264207;4000.979995100064;4024.1348110156455;5343.625946183807;5397.514223719884;5418.4039755626845;5450.345958484928;5497.038018346853;5898.233229680114;5911.261092363455;5915.142304365929;5918.260217472816;5930;5542.667439953616;5543.057680194376;5551.72241387929;5552.500274975271;5555.694436806015;4725.763711814396;4818.132736107465;4833.637477189225;4868.099401610713;4922;6115.052166914135;6121.938780612226;6124.142620033199;6128.693565321716;6132.478739307209;5898.203742494708;5906.084556893688;5916.319623243382;5917.378675239038;5918.053111502139;5926.051831706906;6002.159697642421;6032.426919442822;6050.788222412194;6117.663528505796;5755.942440575708;5791.565632577658;5795.7391917362975;5801.82594522165;5805;5683.545316374597;5854.326752423526;5897.970510147422;5904.704764761831;5910.438508341701;5676.262085928968;5693.918155550432;5705.914411283917;5743.684097374685;5765.538756899522;5732.7706891723865;5733.31200255972;5737.426257374229;5743.10981797822;5749.223854779551;5437.564994800327;5487.506124448659;5569.44305569456;5573.693446860461;5575.553955683617;5704.486596206361;5809.24479817621;5816.854578635568;5817.9127313091185;5823.79616713413;5604.187392827936;5610.7194640268635;5612.466815652507;5613.522850557748;5626 11:53:23 INFO - PROCESS | 29308 | |1;ext.html;609.481940350702;639.7409049335021;646.4957333280041;647.0391468669026;657.014478282576;33827.492587611174;37154.25691486169;37182.25635487289;43868.78065609675;44830.77584612081;46129.07741845161;46330;46472.76763616186;46484.302735458914;46493.30260046102;9000.324975626821;9160.679376221833;9165.816683666322;9166.358354915159;9178.724638260863;8194.713185038525;9072.274218062572;10324.328918620266;10525.473726313692;10526;10930.070943969773;10996;10996.12031037519;11009.504572294227;11014.118870490342;8134.877976830352;10833.187510936672;10891.618793342195;10892.727681807939;10906.127509799197;10352.896471035268;10681.198910081697;10692.572297108107;10987.39569323687;10993.670189894316;44004.77997609991;44480.3327950081;44491;44513.77743111296;44526.10947781026;3492.2840817632323;3587.712982961357;3653.342398368319;3736.869209577652;4355.063661312833;32502.18744531382;32559.83720081408;32737.690492380276;32787.65224402844;33391.33217335664;4161.4382058422025;4166.729162604452;4185.434966279574;4203.453551038346;4350.825966961318;367205;367738;368450;369638;369726;36037.81981090078;36821.63178368236;65126;65378;65499.67250163814;38578.80710596429;38696.41955370671;38712.61287387146;38738.6126138735;38824.41763373552;15055.924720376328;15123.924380378028;15129.01661392006;15132.697346053237;15136.621584460256;12285.788558059636;12462.252264864137;13655.931720341334;13747.656308592364;13751.587452376445;8488.278496327757;8658;8681.218690317775;8746.737597872074;8763.518006509703;3336.5328853960464;3355.647656996029;3379.121428428626;3388.3900897838134;3415.8292085395633;1082.8538147350007;1090.9018188363086;1098.0611577101622;1111.927724697892;1215.5684731920041;33134.502982455284;33252.97837403462;33382.16544586356;33450.49824252638;33526.832365838505;1141.7432470064095;1150.327058670687;1188.9346085965183;1204.163106640876;1252.1172573335778;17438.215280312415;17445.912770436065;17576.121193940253;17596.560085997953;17689.911550442164;573120;575192;575904;577967;581643;58336.70831645899;59794;59798;59822.40177598255;59953;1255.6923553729396;1323.2986517145928;1338.6318762340434;1421.2538417330984;1428.6356978970296;26732.19803405901;33931.321373572886;34125.488117677756;36184.63815361813;36476.98753137206;57340.71329643325;57854.132188016374;57918.710406447695;57964;58060.709696451246;468667;472005;473646;475121;475228;28496.145115646563;28690;29060.854695726386;29373.559396609497;29441.55837662394;48656.27015594698;49171;49548.50451495439;49735.50264497309;50880.74559627178;41062.38406423846;41284.79357603193;41469;41753.79123104365;42697.35953960631;40989.38515922323;41409.79295103505;41423.58576414197;41686.16627667369;41961;36301.273974519834;36876.446853296686;36918.44622330721;37051.25897482089;37354;34987.65012349946;35897.64102358943;36018.4597231047;36592.45111323279;36642.8167859159;28172.577411339254;28626.856865715537;28645.856770716015;28800.279993000342;28928.855355723088 11:53:23 INFO - PROCESS | 29308 | |2;jquery.html;411.29873565570705;411.60485933503816;412.1715352142193;413.1922092309535;424.2448441773642;17903.283868645256;19437.125329360177;19739.1117399717;19743.605127897452;19886.303979360724;18346.26614935401;18817.059147042626;19025.904870475628;19493.512662183417;19520.902395488003;5620.4660557247;5719.342275638292;5722.570807189478;5815.244018277639;5820.941790582104;5766.250387449647;5775.537956963454;5789.363170051291;5799.391063938289;5815.73829177688;5662.065759149756;5714.399988001242;5771.538276937835;5778.306603207621;5798.82603521895;5545.223668686387;5737.627054241461;5762.193292938992;5764.279465066867;5771.942280577204;5642.181883626892;5697.4302569742695;5727.198192253088;5733.197352370671;5735.827925162252;13799.310034498336;13838.446462141503;13902.374393152333;14442.855571444255;22526.21158259453;2279.851809632385;2618.9476210475873;2659.468106378732;2691.9730802692116;3041.9847900760574;10610.946945265301;10727.678169654922;12780.297083660394;14190.574282771533;14973.700525989529;1918.9616207675908;1972.3195497553465;2001.1995201919203;2038.1643526154205;2117.9788202117934;80751.596242019;82844.17155828424;84606;84917.57541212316;85720.57139714262;10603.628872989408;10688.51901664427;10822.567097316176;10981.39602321864;11099.223054386115;15203.543893683207;15226.086434813946;15283.312250948735;15288.617784555252;15290.311935962909;8326.45878017927;8452.197041281068;8468.153184681605;8646.178613031752;8648.654053837901;7932.444728868923;7953.602319883983;8093.514389136671;8125.75622731319;8132.878006829902;4610.9308360374625;4637.837675681335;4723.291506274018;4777.593904518086;4795.664303498722;1953.8925359105385;1956.9315073972343;1959.3338264989973;1966.8033196680503;2014.5668681233606;1007.29992655104;1012.9392236465835;1062.8140075486758;1084.1868598551087;1098.95050227033;18156.63686726258;19153.80846191548;19289.80710192908;19569.706454403196;19744.802551974582;990.1187942730975;1014.5890914179769;1033.4574348467115;1070.7269646240316;1104.9558017679203;10567.207459440573;10811.83782243267;10892.455377231106;10967.451627418597;10975.83536246957;475844;482634;484972;489921;505940;71960.64019679867;83510.58244708738;83678;94459;95370.52314738382;1071.3518321415588;1078.730317420645;1091.9617813376494;1106.164845541611;1109.5395410904384;17667.823321766617;17734.73397899058;17779.377721780194;17856.732149017516;18043.18805653775;39884.80057599693;42081.78959105185;42310.36534451924;42740.786296069564;43985.12029759451;57871;59307.703461482415;59741.402585973585;59915;60374;8300.83398332042;8548.829023419372;8597.570121493774;8610.44032137909;8726.214640682369;9965.35225210359;13696.060037523739;13745.900327973539;13904.235267060409;13926.721465570834;11934.164608477671;11992.340421276565;12072.309876617457;12078.901373283396;12402.317872517098;11781.293122412682;11791;11997.940010299893;12008.339541325311;12090.879091209326;11434.714132146762;12124.454399551865;12162;12302.200356976768;12317;7503.587302698404;7926.524408535506;8146.83706325882;8302.128276531119;8684.739457816275;11106.722331941766;11889.940550297193;12108.697282568006;12408.75182496363;12450.25298482094 11:53:23 INFO - PROCESS | 29308 | |3;mootools.html;1386.0505553695714;1534.4169215698032;1573.66166274251;1770.8848924819886;1873.9718904216431;8692.521911294876;8991.055939126396;9033.63865445383;9306.348555601111;9315.953420232889;9030.503322317287;9146.405483643559;9214.493202873857;9229.169374756271;9230.630774769;2000.9199632014702;2269.092363054783;2333.2416964486524;2391.5695174868515;2430.987845060772;2468.555894801543;2476.863772492512;2480.1691433369842;2481.627755836621;2482.8262021658493;2337.0534933351933;2374.620060790274;2379.6787433696404;2380.416797884512;2382.0233704181287;2006.3379084901946;2239.2946221940038;2264.954700905981;2301.4821665125214;2305.7924786769104;2366.7041619797524;2372.2883135059415;2394.05434853232;2394.3535245483795;2398.5802484565133;9188.494632795193;9239.076092390775;9245;9251.861222081674;9258.351915365927;5393.946060539383;5540.750666219989;5541.362743284533;5541.778328866841;5555.972220138914;3478.4608385700258;3530.5939816921127;3531.0819187011307;3574.4102223133414;3624.5469316335457;1134.5405110930087;1161.8663853656853;1174.1311429542163;1182.4442512019336;1229.9877001229963;12984.610461686165;13023.804642930458;13061.151025183428;13081.476740930351;13106.148100373444;4792.723456358202;4842.055799119208;4891.828785992473;4927.039227350704;4941.43173535048;11012.944935275433;11031.062359699356;11058.391788451552;11063.336199827874;11076.889231107747;5568.582356323292;5611.943880561143;5628.71856407178;5632.239647647515;5633.492985631231;4538.568835960578;5012.674176178537;5135.152699804565;5148.794048238028;5230.660007099603;4136.131412403369;4170.52039015511;4228.492580890313;4247.5752424757275;4266.573342665709;1302.8436587609547;1306.5361796562083;1314.8948084153244;1316.767336189652;1326.8341457317836;826.8263664630375;902.2150728865929;923.8891333039944;1008.1178968402647;1013.8023085498257;6261.373862613702;6278.780242691575;6353.396427339396;6387.552871298964;6397.232332120176;454.9681522293408;461.458727848986;473.08458133511766;476.1595783442227;485.4950851114872;4304.504981927056;4325.307950727868;4325.41606883073;4325.805338759764;4349.26062569364;11512.94243528777;11792.469338879771;11862.584809531625;11947.641570752892;11973.760524789455;11566.710832229262;11717.12121590884;11820.290782552902;11832;11836.526538938519;8287.792805179919;8319.916800831914;8573.442726222776;8577.614007369682;8800.207981281588;6352.650604216812;6502.772402965874;6587.9670601646685;6627.072209890523;6678.3989440950545;10595.576176952836;10739.355638661706;10907.509162087566;11022.669319920415;11023.44882755875;10824;11043.447827608748;11063.391513466837;11109.944450277697;11190.272632278877;7574.431917606312;8009.078955919911;8193.836123277382;8268.83462330762;8403.705870294754;8968.461892286483;9000.504972226328;9028.413153145024;9082.772930676785;9085.545722713705;8199.0980992092;8337.041240257447;8416.2004609562;8459.407841451039;8488.618012189343;8080.515169089874;8168.183181682022;8213.630386632496;8256.13310602402;8292.792680183044;7218.566885986647;7248.238934911758;7413.221611730691;7438.218987006287;7621.237876212334;5534.308211473566;5597.3001141496825;5611.915821262603;5637.830865074055;5734.254546908875;5476.123820188751;5551.8889622206525;5680.545556355564;5708.628939118944;5735.225744524436 11:53:23 INFO - PROCESS | 29308 | |4;prototype.html;330.8445030835508;339.6688228976748;345.4766029465359;345.7942524198102;347.99478007829873;5460.918086228709;5467.644603100795;5482.342118945722;5486.122220444725;5508.6779172998395;5412.646838290428;5427.240186373911;5462.371827239868;5468.562514998801;5480.314960629921;4011.538673052607;4245.702800803945;4248.511421186557;4311.267084595618;4331.30699088146;4178.97910510447;4225.894352641178;4237;4237.894052648678;4261.339492378671;4203.5165955915;4211.368294755795;4221.366794980762;4230.513490948534;4238.173556156551;4001.659858911996;4084.203580301857;4175.749455032677;4188.308929026707;4205.684573656958;3673.6326367363317;3674.3202507536193;3700.8149592520267;3701.148735790783;3711.3690672585726;4979.8008079676765;5254.737263136866;5268.710220937847;5300.9734951325;5311.893762124736;4639.443266808004;4779.211430114027;4782.115308667908;4796.760161991921;4837.250226214942;5671.744771485293;5681.801136960186;5693.202951586781;5719.971400143014;5741;3937.232239713257;4064.512258528966;4071.307877660805;4076.1847630473726;4096.938545921814;5860.384659610722;5867.178594996704;5896.933594530863;5899.312929419113;5918.112283157518;4092.447519584818;4113.25961326964;4125.051238215167;4130.855420060284;4144.191882582867;4022.7127319257556;4203.243416185116;4208.873733787991;4224.134052519226;4238.258304796648;4768.642351823627;4778.01712289396;4807.302941073524;4819.7108173509705;4834.589059929875;5656.632318899258;5667.489925906688;5676.8864622707315;5760.654360738369;5787;1431.1556181852757;1457.4461704552414;1458.555140682102;1459.496473716566;1464.809574755275;914.3416739947228;918.5636822509255;928.9256859451227;937.3860121620213;940.7394091916864;4847.594197682703;4856.902861942812;4868.829590964299;4898.559129678346;4917.704937703749;5227.764750586232;5263.842084737464;5272.762725677354;5290.8941821164135;5323.467653234646;4931.605471562267;5174.172132458863;5266.789328426897;5412.457449626838;5519.834404967857;3092.752579793611;3117.360941007088;3120.4553745895473;3143.732782713449;3155.1323386069016;5906.822795316148;6074.908876366858;6098.817035488943;6118.785842495491;6151.784687535915;5934.970325148433;5943.910841337383;5953.226080609493;5953.910691339634;5972.372900845436;6118.571699980958;6124.78563250293;6127.417895299939;6160.44555989963;6164.352742961924;5628.577856660685;5851.736671849691;5852.795152169653;5897.882042359043;5909.468147866713;5732.312122545154;5788.189653448605;5835.665733706382;5849.268841394825;5852.356240813422;5988.371221021905;6011.248593925759;6055;6099.969500152471;6110.450059494667;4233.280342341748;4249.91500170001;4253.510846252597;4257.382679511516;4257.723247988871;5773.3072031356505;5799.188113664175;5822;5823.359430462561;5916.37299742557;5511.0080185566985;5708.257926469532;5725.255716756795;5726.885462290647;5802.897449484584;5687.322239939311;5702.0042984954935;5715.8571035724435;5722.971385143048;5732.5413966881715;5177.974110129576;5500.4499550044675;5559.72201389937;5599.860003499945;5610.102383618601;5648.519875810438;5672.5461963042035;5684.7441865117;5783.566232532661;5783.987802134526;5376.650517716336;5583.413741557078;5602.551795856403;5609.148980836396;5619.80330688424 11:53:23 INFO - PROCESS | 29308 | |5;yui.html;816.5672193737321;850.1668365002298;855.7903313688143;878.6397576993434;907.9228265597424;13821.447142114315;14047.15717056976;14190.858091419082;14205.79250763685;14217.71564568708;13634;14103.929480352585;14313.78529322061;14326.64183395413;14359.78460323096;701.1551080947446;844.7592436155712;859.0979471554842;859.7807559072428;860.3418384935529;729.8941653460245;734.7758933525273;734.8824188129901;833.7540425574471;857.6998050682274;904.2630256341093;906.7053207707488;907.6732376344511;909.9181073703365;910.3036177324352;899.757065592293;900.0009988912302;903.029243563169;903.5166186090443;903.575319599787;530.986725331866;643.1703102997128;655.367570294668;656.3174298729316;659.0345144363482;13096.672583185402;13100.60698179056;13124.2125472471;13155.144915580457;13253.536126235633;12784.872151278461;13072.281024543647;13358.599242022754;13579.964378463868;13669.658258543517;12370.690732731664;12570.560030398892;12592.68518287041;12645.43095560702;12690.492380304777;4545.5908968193025;4572.268437050056;4594.839180628695;4615.653825963032;4741.241401375798;59542.702286488726;59934.10098848565;60553.697231514;60726.69636651833;60925;11224.55101795919;11281.266717663326;11410;11422.885771142348;11550.249233799776;19673.606527869364;19737.210511579662;19751.802481974995;19762.50593735168;19766.70349944752;8494.53280069602;8505.74482765518;8670.566471676517;8821.735347939572;8940.46357218569;4681.7190968542;4746.976265118652;4841;4851.126797176542;4915.4347250065985;3620.637936206358;3689.741718079709;3705.888823335304;3707.3697471429923;3710.8144592770254;677.0859339891206;681.7647911470634;688.0642326436043;690.7384558972894;692.6259819697408;675.7769935921134;724.5296520468721;733.2520828754747;739.9408047356198;777.9494332868345;9236.445813251092;9707.611695532241;9745.756356091155;9815.607375705034;9886.30795844284;611.7063809371526;638.3393188050345;656.2289310060755;713.0195980526776;762.3558093411059;4474.709143905701;4622.745748983838;4732.407219128017;4734.337192793012;4737.360456338351;68410.65794671094;69690.65154674194;71658.28341716621;71902.2809771906;72005.6399717998;59632.40367596355;60136.69931650401;61086.389136108955;61657;62667.05999410013;49774.50225497771;50453.24320135201;51588.74205628948;54550.72724636431;58770;9468.337216394786;9624.278179136452;9709.854352184582;9906.603735850485;9912.75218119524;36618;37128.257434851694;37640;37846;38252.6174738249;47353.76323118362;49963.50036499734;51214.74392628013;51436.22845657243;51929.740351298;12010.33943133136;12146.514139434325;12693.301868397326;13010.21938683682;13052.975703990045;13764.65588360299;14187.858121418654;14521.346539405964;14683.55949321522;14692.559223223321;12825.615231543068;13173.143745656502;13266.469341226242;13384.866151338361;13409;13344.599662010156;13497.527586534425;14024.579262622137;14035.719285614436;14069.437222510986;13135.802962955373;13288.136271142344;13306.667333316744;13767.518136865161;13830.861691382957;10899.29154604948;11218.102551796;11252.718682033015;11360;11836.76326473483;11235.71910702239;11517;11535.250208736405;11560.710982225512;11613.709657258636 11:53:23 INFO - PROCESS | 29308 | __end_tp_report 11:53:23 INFO - PROCESS | 29308 | __start_cc_report 11:53:23 INFO - PROCESS | 29308 | _x_x_mozilla_cycle_collect,827 11:53:23 INFO - PROCESS | 29308 | __end_cc_report 11:53:23 INFO - PROCESS | 29308 | __startTimestamp1463511203044__endTimestamp 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | ------- Summary: start ------- 11:53:23 INFO - PROCESS | 29308 | Number of tests: 6 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | [#0] dojo.html Cycles:165 Average:5425.96 Median:5606.05 stddev:623.30 (11.1%) stddev-sans-first:599.97 11:53:23 INFO - PROCESS | 29308 | Values: 3187.8 3203.7 3224.7 3237.4 3273.5 5348.4 5392.8 5397.9 5398.6 5459.1 5410.8 5425.8 5449.5 5496.5 5518.8 4869.4 4916.6 4961.6 4976.2 5151.7 5059.1 5068.5 5103.1 5117.5 5127.5 4860.5 4880.2 4889.8 4912.2 4943.0 4896.1 4898.5 4954.0 4957.6 4992.8 4817.6 4922.5 4933.9 4938.4 4951.5 5276.0 5357.5 5359.7 5420.9 5424.2 5838.6 5849.7 5871.7 5891.5 5900.0 5738.9 5835.3 5906.8 5949.1 5954.9 5477.2 5522.7 5523.1 5524.3 5579.6 6050.1 6060.5 6066.8 6067.3 6070.2 5560.2 5690.9 5726.5 5859.6 5871.3 5853.6 5855.4 5858.7 5875.6 5912.3 5751.5 5787.7 5805.3 5808.0 5832.9 5606.0 5778.8 5784.8 5846.1 5848.4 4442.0 4446.9 4457.3 4458.2 4494.7 3966.2 3981.1 3990.0 4001.0 4024.1 5343.6 5397.5 5418.4 5450.3 5497.0 5898.2 5911.3 5915.1 5918.3 5930.0 5542.7 5543.1 5551.7 5552.5 5555.7 4725.8 4818.1 4833.6 4868.1 4922.0 6115.1 6121.9 6124.1 6128.7 6132.5 5898.2 5906.1 5916.3 5917.4 5918.1 5926.1 6002.2 6032.4 6050.8 6117.7 5755.9 5791.6 5795.7 5801.8 5805.0 5683.5 5854.3 5898.0 5904.7 5910.4 5676.3 5693.9 5705.9 5743.7 5765.5 5732.8 5733.3 5737.4 5743.1 5749.2 5437.6 5487.5 5569.4 5573.7 5575.6 5704.5 5809.2 5816.9 5817.9 5823.8 5604.2 5610.7 5612.5 5613.5 5626.0 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | [#1] ext.html Cycles:180 Average:62286.35 Median:202635.82 stddev:127786.77 (63.1%) stddev-sans-first:128061.34 11:53:23 INFO - PROCESS | 29308 | Values: 609.5 639.7 646.5 647.0 657.0 33827.5 37154.3 37182.3 43868.8 44830.8 46129.1 46330.0 46472.8 46484.3 46493.3 9000.3 9160.7 9165.8 9166.4 9178.7 8194.7 9072.3 10324.3 10525.5 10526.0 10930.1 10996.0 10996.1 11009.5 11014.1 8134.9 10833.2 10891.6 10892.7 10906.1 10352.9 10681.2 10692.6 10987.4 10993.7 44004.8 44480.3 44491.0 44513.8 44526.1 3492.3 3587.7 3653.3 3736.9 4355.1 32502.2 32559.8 32737.7 32787.7 33391.3 4161.4 4166.7 4185.4 4203.5 4350.8 367205.0 367738.0 368450.0 369638.0 369726.0 36037.8 36821.6 65126.0 65378.0 65499.7 38578.8 38696.4 38712.6 38738.6 38824.4 15055.9 15123.9 15129.0 15132.7 15136.6 12285.8 12462.3 13655.9 13747.7 13751.6 8488.3 8658.0 8681.2 8746.7 8763.5 3336.5 3355.6 3379.1 3388.4 3415.8 1082.9 1090.9 1098.1 1111.9 1215.6 33134.5 33253.0 33382.2 33450.5 33526.8 1141.7 1150.3 1188.9 1204.2 1252.1 17438.2 17445.9 17576.1 17596.6 17689.9 573120.0 575192.0 575904.0 577967.0 581643.0 58336.7 59794.0 59798.0 59822.4 59953.0 1255.7 1323.3 1338.6 1421.3 1428.6 26732.2 33931.3 34125.5 36184.6 36477.0 57340.7 57854.1 57918.7 57964.0 58060.7 468667.0 472005.0 473646.0 475121.0 475228.0 28496.1 28690.0 29060.9 29373.6 29441.6 48656.3 49171.0 49548.5 49735.5 50880.7 41062.4 41284.8 41469.0 41753.8 42697.4 40989.4 41409.8 41423.6 41686.2 41961.0 36301.3 36876.4 36918.4 37051.3 37354.0 34987.7 35897.6 36018.5 36592.5 36642.8 28172.6 28626.9 28645.9 28800.3 28928.9 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | [#2] jquery.html Cycles:180 Average:28826.67 Median:2078.07 stddev:80416.82 (3869.8%) stddev-sans-first:80614.11 11:53:23 INFO - PROCESS | 29308 | Values: 411.3 411.6 412.2 413.2 424.2 17903.3 19437.1 19739.1 19743.6 19886.3 18346.3 18817.1 19025.9 19493.5 19520.9 5620.5 5719.3 5722.6 5815.2 5820.9 5766.3 5775.5 5789.4 5799.4 5815.7 5662.1 5714.4 5771.5 5778.3 5798.8 5545.2 5737.6 5762.2 5764.3 5771.9 5642.2 5697.4 5727.2 5733.2 5735.8 13799.3 13838.4 13902.4 14442.9 22526.2 2279.9 2618.9 2659.5 2692.0 3042.0 10610.9 10727.7 12780.3 14190.6 14973.7 1919.0 1972.3 2001.2 2038.2 2118.0 80751.6 82844.2 84606.0 84917.6 85720.6 10603.6 10688.5 10822.6 10981.4 11099.2 15203.5 15226.1 15283.3 15288.6 15290.3 8326.5 8452.2 8468.2 8646.2 8648.7 7932.4 7953.6 8093.5 8125.8 8132.9 4610.9 4637.8 4723.3 4777.6 4795.7 1953.9 1956.9 1959.3 1966.8 2014.6 1007.3 1012.9 1062.8 1084.2 1099.0 18156.6 19153.8 19289.8 19569.7 19744.8 990.1 1014.6 1033.5 1070.7 1105.0 10567.2 10811.8 10892.5 10967.5 10975.8 475844.0 482634.0 484972.0 489921.0 505940.0 71960.6 83510.6 83678.0 94459.0 95370.5 1071.4 1078.7 1092.0 1106.2 1109.5 17667.8 17734.7 17779.4 17856.7 18043.2 39884.8 42081.8 42310.4 42740.8 43985.1 57871.0 59307.7 59741.4 59915.0 60374.0 8300.8 8548.8 8597.6 8610.4 8726.2 9965.4 13696.1 13745.9 13904.2 13926.7 11934.2 11992.3 12072.3 12078.9 12402.3 11781.3 11791.0 11997.9 12008.3 12090.9 11434.7 12124.5 12162.0 12302.2 12317.0 7503.6 7926.5 8146.8 8302.1 8684.7 11106.7 11889.9 12108.7 12408.8 12450.3 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | [#3] mootools.html Cycles:180 Average:6143.52 Median:474.62 stddev:3568.30 (751.8%) stddev-sans-first:3560.40 11:53:23 INFO - PROCESS | 29308 | Values: 1386.1 1534.4 1573.7 1770.9 1874.0 8692.5 8991.1 9033.6 9306.3 9316.0 9030.5 9146.4 9214.5 9229.2 9230.6 2000.9 2269.1 2333.2 2391.6 2431.0 2468.6 2476.9 2480.2 2481.6 2482.8 2337.1 2374.6 2379.7 2380.4 2382.0 2006.3 2239.3 2265.0 2301.5 2305.8 2366.7 2372.3 2394.1 2394.4 2398.6 9188.5 9239.1 9245.0 9251.9 9258.4 5393.9 5540.8 5541.4 5541.8 5556.0 3478.5 3530.6 3531.1 3574.4 3624.5 1134.5 1161.9 1174.1 1182.4 1230.0 12984.6 13023.8 13061.2 13081.5 13106.1 4792.7 4842.1 4891.8 4927.0 4941.4 11012.9 11031.1 11058.4 11063.3 11076.9 5568.6 5611.9 5628.7 5632.2 5633.5 4538.6 5012.7 5135.2 5148.8 5230.7 4136.1 4170.5 4228.5 4247.6 4266.6 1302.8 1306.5 1314.9 1316.8 1326.8 826.8 902.2 923.9 1008.1 1013.8 6261.4 6278.8 6353.4 6387.6 6397.2 455.0 461.5 473.1 476.2 485.5 4304.5 4325.3 4325.4 4325.8 4349.3 11512.9 11792.5 11862.6 11947.6 11973.8 11566.7 11717.1 11820.3 11832.0 11836.5 8287.8 8319.9 8573.4 8577.6 8800.2 6352.7 6502.8 6588.0 6627.1 6678.4 10595.6 10739.4 10907.5 11022.7 11023.4 10824.0 11043.4 11063.4 11109.9 11190.3 7574.4 8009.1 8193.8 8268.8 8403.7 8968.5 9000.5 9028.4 9082.8 9085.5 8199.1 8337.0 8416.2 8459.4 8488.6 8080.5 8168.2 8213.6 8256.1 8292.8 7218.6 7248.2 7413.2 7438.2 7621.2 5534.3 5597.3 5611.9 5637.8 5734.3 5476.1 5551.9 5680.5 5708.6 5735.2 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | [#4] prototype.html Cycles:180 Average:4756.67 Median:5412.55 stddev:1404.65 (26.0%) stddev-sans-first:1368.75 11:53:23 INFO - PROCESS | 29308 | Values: 330.8 339.7 345.5 345.8 348.0 5460.9 5467.6 5482.3 5486.1 5508.7 5412.6 5427.2 5462.4 5468.6 5480.3 4011.5 4245.7 4248.5 4311.3 4331.3 4179.0 4225.9 4237.0 4237.9 4261.3 4203.5 4211.4 4221.4 4230.5 4238.2 4001.7 4084.2 4175.7 4188.3 4205.7 3673.6 3674.3 3700.8 3701.1 3711.4 4979.8 5254.7 5268.7 5301.0 5311.9 4639.4 4779.2 4782.1 4796.8 4837.3 5671.7 5681.8 5693.2 5720.0 5741.0 3937.2 4064.5 4071.3 4076.2 4096.9 5860.4 5867.2 5896.9 5899.3 5918.1 4092.4 4113.3 4125.1 4130.9 4144.2 4022.7 4203.2 4208.9 4224.1 4238.3 4768.6 4778.0 4807.3 4819.7 4834.6 5656.6 5667.5 5676.9 5760.7 5787.0 1431.2 1457.4 1458.6 1459.5 1464.8 914.3 918.6 928.9 937.4 940.7 4847.6 4856.9 4868.8 4898.6 4917.7 5227.8 5263.8 5272.8 5290.9 5323.5 4931.6 5174.2 5266.8 5412.5 5519.8 3092.8 3117.4 3120.5 3143.7 3155.1 5906.8 6074.9 6098.8 6118.8 6151.8 5935.0 5943.9 5953.2 5953.9 5972.4 6118.6 6124.8 6127.4 6160.4 6164.4 5628.6 5851.7 5852.8 5897.9 5909.5 5732.3 5788.2 5835.7 5849.3 5852.4 5988.4 6011.2 6055.0 6100.0 6110.5 4233.3 4249.9 4253.5 4257.4 4257.7 5773.3 5799.2 5822.0 5823.4 5916.4 5511.0 5708.3 5725.3 5726.9 5802.9 5687.3 5702.0 5715.9 5723.0 5732.5 5178.0 5500.4 5559.7 5599.9 5610.1 5648.5 5672.5 5684.7 5783.6 5784.0 5376.7 5583.4 5602.6 5609.1 5619.8 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - PROCESS | 29308 | [#5] yui.html Cycles:180 Average:15957.44 Median:4739.30 stddev:18998.75 (400.9%) stddev-sans-first:19018.02 11:53:23 INFO - PROCESS | 29308 | Values: 816.6 850.2 855.8 878.6 907.9 13821.4 14047.2 14190.9 14205.8 14217.7 13634.0 14103.9 14313.8 14326.6 14359.8 701.2 844.8 859.1 859.8 860.3 729.9 734.8 734.9 833.8 857.7 904.3 906.7 907.7 909.9 910.3 899.8 900.0 903.0 903.5 903.6 531.0 643.2 655.4 656.3 659.0 13096.7 13100.6 13124.2 13155.1 13253.5 12784.9 13072.3 13358.6 13580.0 13669.7 12370.7 12570.6 12592.7 12645.4 12690.5 4545.6 4572.3 4594.8 4615.7 4741.2 59542.7 59934.1 60553.7 60726.7 60925.0 11224.6 11281.3 11410.0 11422.9 11550.2 19673.6 19737.2 19751.8 19762.5 19766.7 8494.5 8505.7 8670.6 8821.7 8940.5 4681.7 4747.0 4841.0 4851.1 4915.4 3620.6 3689.7 3705.9 3707.4 3710.8 677.1 681.8 688.1 690.7 692.6 675.8 724.5 733.3 739.9 777.9 9236.4 9707.6 9745.8 9815.6 9886.3 611.7 638.3 656.2 713.0 762.4 4474.7 4622.7 4732.4 4734.3 4737.4 68410.7 69690.7 71658.3 71902.3 72005.6 59632.4 60136.7 61086.4 61657.0 62667.1 49774.5 50453.2 51588.7 54550.7 58770.0 9468.3 9624.3 9709.9 9906.6 9912.8 36618.0 37128.3 37640.0 37846.0 38252.6 47353.8 49963.5 51214.7 51436.2 51929.7 12010.3 12146.5 12693.3 13010.2 13053.0 13764.7 14187.9 14521.3 14683.6 14692.6 12825.6 13173.1 13266.5 13384.9 13409.0 13344.6 13497.5 14024.6 14035.7 14069.4 13135.8 13288.1 13306.7 13767.5 13830.9 10899.3 11218.1 11252.7 11360.0 11836.8 11235.7 11517.0 11535.3 11560.7 11613.7 11:53:23 INFO - PROCESS | 29308 | -------- Summary: end -------- 11:53:23 INFO - PROCESS | 29308 | 11:53:23 INFO - TEST-INFO | 29308: exit 0 11:53:23 INFO - TEST-OK | dromaeo_css | took 1113473ms 11:53:23 INFO - TEST-START | kraken 11:53:23 INFO - operating with platform_type : linux_ 11:53:23 INFO - Initialising browser for kraken test... 11:53:23 INFO - TEST-INFO | started process 29492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz2JEbY/profile http://localhost:44511/getInfo.html) 11:53:28 INFO - PROCESS | 29492 | __metrics Screen width/height:1600/1200 11:53:28 INFO - PROCESS | 29492 | colorDepth:24 11:53:28 INFO - PROCESS | 29492 | Browser inner width/height: 1024/697 11:53:28 INFO - PROCESS | 29492 | __metrics 11:53:29 ERROR - PROCESS | 29492 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:53:29 INFO - TEST-INFO | 29492: exit 0 11:53:29 INFO - Browser initialized. 11:53:29 INFO - Running cycle 1/1 for kraken test... 11:53:29 INFO - TEST-INFO | started process 29574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz2JEbY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:41 INFO - PROCESS | 29574 | RSS: Main: 152313856 11:53:41 INFO - PROCESS | 29574 | 11:53:44 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:45 INFO - PROCESS | 29574 | RSS: Main: 208490496 11:53:45 INFO - PROCESS | 29574 | 11:53:47 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-dft) 11:53:48 INFO - PROCESS | 29574 | RSS: Main: 197017600 11:53:48 INFO - PROCESS | 29574 | 11:53:51 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-fft) 11:53:52 INFO - PROCESS | 29574 | RSS: Main: 265613312 11:53:52 INFO - PROCESS | 29574 | 11:53:54 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-oscillator) 11:53:55 INFO - PROCESS | 29574 | RSS: Main: 175153152 11:53:55 INFO - PROCESS | 29574 | 11:53:57 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:53:58 INFO - PROCESS | 29574 | RSS: Main: 179113984 11:53:58 INFO - PROCESS | 29574 | 11:54:01 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44511/tests/kraken/driver.html?testName=imaging-darkroom) 11:54:01 INFO - PROCESS | 29574 | RSS: Main: 215023616 11:54:01 INFO - PROCESS | 29574 | 11:54:05 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44511/tests/kraken/driver.html?testName=imaging-desaturate) 11:54:05 INFO - PROCESS | 29574 | RSS: Main: 211836928 11:54:05 INFO - PROCESS | 29574 | 11:54:08 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44511/tests/kraken/driver.html?testName=json-parse-financial) 11:54:09 INFO - PROCESS | 29574 | RSS: Main: 213676032 11:54:09 INFO - PROCESS | 29574 | 11:54:11 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:54:11 INFO - PROCESS | 29574 | RSS: Main: 202063872 11:54:11 INFO - PROCESS | 29574 | 11:54:13 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:54:14 INFO - PROCESS | 29574 | RSS: Main: 207716352 11:54:14 INFO - PROCESS | 29574 | 11:54:16 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:54:17 INFO - PROCESS | 29574 | RSS: Main: 217427968 11:54:17 INFO - PROCESS | 29574 | 11:54:19 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:54:20 INFO - PROCESS | 29574 | RSS: Main: 223375360 11:54:20 INFO - PROCESS | 29574 | 11:54:22 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:54:23 INFO - PROCESS | 29574 | RSS: Main: 217989120 11:54:23 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44511/tests/kraken/driver.html?testName=ai-astar) 11:54:25 INFO - PROCESS | 29574 | RSS: Main: 263712768 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | __start_tp_report 11:54:25 INFO - PROCESS | 29574 | _x_x_mozilla_page_load 11:54:25 INFO - PROCESS | 29574 | _x_x_mozilla_page_load_details 11:54:25 INFO - PROCESS | 29574 | |i|pagename|runs| 11:54:25 INFO - PROCESS | 29574 | |0;ai-astar;111;106;113;112;111;111;111;111;109;111 11:54:25 INFO - PROCESS | 29574 | |1;audio-beat-detection;151;122;149;205;125;151;147;124;178;124 11:54:25 INFO - PROCESS | 29574 | |2;audio-dft;160;161;160;160;159;162;159;161;161;161 11:54:25 INFO - PROCESS | 29574 | |3;audio-fft;74;76;76;154;76;75;76;73;134;75 11:54:25 INFO - PROCESS | 29574 | |4;audio-oscillator;91;91;143;92;91;91;144;92;91;129 11:54:25 INFO - PROCESS | 29574 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;117;117;117 11:54:25 INFO - PROCESS | 29574 | |6;imaging-darkroom;146;145;146;145;145;146;146;146;147;146 11:54:25 INFO - PROCESS | 29574 | |7;imaging-desaturate;95;95;95;95;97;95;94;94;95;95 11:54:25 INFO - PROCESS | 29574 | |8;json-parse-financial;56;54;56;53;54;58;57;114;52;55 11:54:25 INFO - PROCESS | 29574 | |9;json-stringify-tinderbox;60;60;60;60;60;60;60;60;60;59 11:54:25 INFO - PROCESS | 29574 | |10;stanford-crypto-aes;77;78;82;79;81;77;78;78;78;78 11:54:25 INFO - PROCESS | 29574 | |11;stanford-crypto-ccm;123;120;134;126;117;117;131;117;200;121 11:54:25 INFO - PROCESS | 29574 | |12;stanford-crypto-pbkdf2;162;161;158;165;159;165;160;160;157;161 11:54:25 INFO - PROCESS | 29574 | |13;stanford-crypto-sha256-iterative;63;70;63;65;63;62;63;64;62;62 11:54:25 INFO - PROCESS | 29574 | __end_tp_report 11:54:25 INFO - PROCESS | 29574 | __start_cc_report 11:54:25 INFO - PROCESS | 29574 | _x_x_mozilla_cycle_collect,1889 11:54:25 INFO - PROCESS | 29574 | __end_cc_report 11:54:25 INFO - PROCESS | 29574 | __startTimestamp1463511265533__endTimestamp 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | ------- Summary: start ------- 11:54:25 INFO - PROCESS | 29574 | Number of tests: 14 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 11:54:25 INFO - PROCESS | 29574 | Values: 111.0 106.0 113.0 112.0 111.0 111.0 111.0 111.0 109.0 111.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:150.00 stddev:26.92 (17.9%) stddev-sans-first:28.53 11:54:25 INFO - PROCESS | 29574 | Values: 151.0 122.0 149.0 205.0 125.0 151.0 147.0 124.0 178.0 124.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 11:54:25 INFO - PROCESS | 29574 | Values: 160.0 161.0 160.0 160.0 159.0 162.0 159.0 161.0 161.0 161.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.50 stddev:29.44 (39.0%) stddev-sans-first:30.73 11:54:25 INFO - PROCESS | 29574 | Values: 74.0 76.0 76.0 154.0 76.0 75.0 76.0 73.0 134.0 75.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:91.00 stddev:23.23 (25.5%) stddev-sans-first:24.04 11:54:25 INFO - PROCESS | 29574 | Values: 91.0 91.0 143.0 92.0 91.0 91.0 144.0 92.0 91.0 129.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:54:25 INFO - PROCESS | 29574 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 11:54:25 INFO - PROCESS | 29574 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 147.0 146.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 11:54:25 INFO - PROCESS | 29574 | Values: 95.0 95.0 95.0 95.0 97.0 95.0 94.0 94.0 95.0 95.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:55.50 stddev:18.75 (33.8%) stddev-sans-first:19.80 11:54:25 INFO - PROCESS | 29574 | Values: 56.0 54.0 56.0 53.0 54.0 58.0 57.0 114.0 52.0 55.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:54:25 INFO - PROCESS | 29574 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 59.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.00 stddev:1.65 (2.1%) stddev-sans-first:1.64 11:54:25 INFO - PROCESS | 29574 | Values: 77.0 78.0 82.0 79.0 81.0 77.0 78.0 78.0 78.0 78.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:124.50 stddev:25.09 (20.2%) stddev-sans-first:26.46 11:54:25 INFO - PROCESS | 29574 | Values: 123.0 120.0 134.0 126.0 117.0 117.0 131.0 117.0 200.0 121.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:2.66 (1.7%) stddev-sans-first:2.78 11:54:25 INFO - PROCESS | 29574 | Values: 162.0 161.0 158.0 165.0 159.0 165.0 160.0 160.0 157.0 161.0 11:54:25 INFO - PROCESS | 29574 | 11:54:25 INFO - PROCESS | 29574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:2.41 (3.8%) stddev-sans-first:2.54 11:54:25 INFO - PROCESS | 29574 | Values: 63.0 70.0 63.0 65.0 63.0 62.0 63.0 64.0 62.0 62.0 11:54:25 INFO - PROCESS | 29574 | -------- Summary: end -------- 11:54:25 INFO - PROCESS | 29574 | 11:54:26 INFO - TEST-INFO | 29574: exit 0 11:54:26 INFO - TEST-OK | kraken | took 62750ms 11:54:26 INFO - SUITE-END | took 1176s 11:54:26 INFO - Completed test suite (00:19:36) 11:54:26 INFO - javascript benchmark 11:54:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.7927934684244, 3203.6796320367953, 3224.7258982986446, 3237.4010808000507, 3273.5089736539517, 5348.384935732392, 5392.838214853556, 5397.919031214525, 5398.64908780929, 5459.099248623982, 5410.810621628244, 5425.83722488326, 5449.536789372898, 5496.477834605706, 5518.806841760539, 4869.440014398345, 4916.606671466292, 4961.6278779091535, 4976.154053810861, 5151.716655583941, 5059.11465493539, 5068.518490743373, 5103.055934652083, 5117.513836185556, 5127.5128862758165, 4860.465348811628, 4880.219164933629, 4889.804407823683, 4912.238603016538, 4943.011397720452, 4896.143174944406, 4898.510148985109, 4954.0, 4957.5786058185095, 4992.825251116194, 4817.61459083276, 4922.483139270361, 4933.901321973576, 4938.432080310774, 4951.504849515056, 5276.0, 5357.464253574651, 5359.678419294854, 5420.864478388072, 5424.213489044067, 5838.591298609099, 5849.707514624294, 5871.677057761822, 5891.528677705774, 5899.970500147472, 5738.885222295531, 5835.328937172237, 5906.763729450817, 5949.077892926603, 5954.940450595482, 5477.20580515823, 5522.696251706195, 5523.143912693539, 5524.33707955044, 5579.581531385122, 6050.122732203894, 6060.515158787286, 6066.848328791815, 6067.302260240041, 6070.2108725865355, 5560.221568980346, 5690.857728556819, 5726.513246374022, 5859.619124756877, 5871.32479764824, 5853.619514731614, 5855.355910849803, 5858.677772722541, 5875.6474611523445, 5912.320083190488, 5751.482366587027, 5787.681677507693, 5805.303363596311, 5807.970960145257, 5832.854178645568, 5606.046972014768, 5778.797742079007, 5784.797532086357, 5846.093855452412, 5848.4151584841175, 4441.956140307026, 4446.933296000562, 4457.286834106528, 4458.242098843204, 4494.685372023927, 3966.206758648224, 3981.1042515434374, 3990.0423898264207, 4000.979995100064, 4024.1348110156455, 5343.625946183807, 5397.514223719884, 5418.4039755626845, 5450.345958484928, 5497.038018346853, 5898.233229680114, 5911.261092363455, 5915.142304365929, 5918.260217472816, 5930.0, 5542.667439953616, 5543.057680194376, 5551.72241387929, 5552.500274975271, 5555.694436806015, 4725.763711814396, 4818.132736107465, 4833.637477189225, 4868.099401610713, 4922.0, 6115.052166914135, 6121.938780612226, 6124.142620033199, 6128.693565321716, 6132.478739307209, 5898.203742494708, 5906.084556893688, 5916.319623243382, 5917.378675239038, 5918.053111502139, 5926.051831706906, 6002.159697642421, 6032.426919442822, 6050.788222412194, 6117.663528505796, 5755.942440575708, 5791.565632577658, 5795.7391917362975, 5801.82594522165, 5805.0, 5683.545316374597, 5854.326752423526, 5897.970510147422, 5904.704764761831, 5910.438508341701, 5676.262085928968, 5693.918155550432, 5705.914411283917, 5743.684097374685, 5765.538756899522, 5732.7706891723865, 5733.31200255972, 5737.426257374229, 5743.10981797822, 5749.223854779551, 5437.564994800327, 5487.506124448659, 5569.44305569456, 5573.693446860461, 5575.553955683617, 5704.486596206361, 5809.24479817621, 5816.854578635568, 5817.9127313091185, 5823.79616713413, 5604.187392827936, 5610.7194640268635, 5612.466815652507, 5613.522850557748, 5626.0], "value": 5384.088415160332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.481940350702, 639.7409049335021, 646.4957333280041, 647.0391468669026, 657.014478282576, 33827.492587611174, 37154.25691486169, 37182.25635487289, 43868.78065609675, 44830.77584612081, 46129.07741845161, 46330.0, 46472.76763616186, 46484.302735458914, 46493.30260046102, 9000.324975626821, 9160.679376221833, 9165.816683666322, 9166.358354915159, 9178.724638260863, 8194.713185038525, 9072.274218062572, 10324.328918620266, 10525.473726313692, 10526.0, 10930.070943969773, 10996.0, 10996.12031037519, 11009.504572294227, 11014.118870490342, 8134.877976830352, 10833.187510936672, 10891.618793342195, 10892.727681807939, 10906.127509799197, 10352.896471035268, 10681.198910081697, 10692.572297108107, 10987.39569323687, 10993.670189894316, 44004.77997609991, 44480.3327950081, 44491.0, 44513.77743111296, 44526.10947781026, 3492.2840817632323, 3587.712982961357, 3653.342398368319, 3736.869209577652, 4355.063661312833, 32502.18744531382, 32559.83720081408, 32737.690492380276, 32787.65224402844, 33391.33217335664, 4161.4382058422025, 4166.729162604452, 4185.434966279574, 4203.453551038346, 4350.825966961318, 367205.0, 367738.0, 368450.0, 369638.0, 369726.0, 36037.81981090078, 36821.63178368236, 65126.0, 65378.0, 65499.67250163814, 38578.80710596429, 38696.41955370671, 38712.61287387146, 38738.6126138735, 38824.41763373552, 15055.924720376328, 15123.924380378028, 15129.01661392006, 15132.697346053237, 15136.621584460256, 12285.788558059636, 12462.252264864137, 13655.931720341334, 13747.656308592364, 13751.587452376445, 8488.278496327757, 8658.0, 8681.218690317775, 8746.737597872074, 8763.518006509703, 3336.5328853960464, 3355.647656996029, 3379.121428428626, 3388.3900897838134, 3415.8292085395633, 1082.8538147350007, 1090.9018188363086, 1098.0611577101622, 1111.927724697892, 1215.5684731920041, 33134.502982455284, 33252.97837403462, 33382.16544586356, 33450.49824252638, 33526.832365838505, 1141.7432470064095, 1150.327058670687, 1188.9346085965183, 1204.163106640876, 1252.1172573335778, 17438.215280312415, 17445.912770436065, 17576.121193940253, 17596.560085997953, 17689.911550442164, 573120.0, 575192.0, 575904.0, 577967.0, 581643.0, 58336.70831645899, 59794.0, 59798.0, 59822.40177598255, 59953.0, 1255.6923553729396, 1323.2986517145928, 1338.6318762340434, 1421.2538417330984, 1428.6356978970296, 26732.19803405901, 33931.321373572886, 34125.488117677756, 36184.63815361813, 36476.98753137206, 57340.71329643325, 57854.132188016374, 57918.710406447695, 57964.0, 58060.709696451246, 468667.0, 472005.0, 473646.0, 475121.0, 475228.0, 28496.145115646563, 28690.0, 29060.854695726386, 29373.559396609497, 29441.55837662394, 48656.27015594698, 49171.0, 49548.50451495439, 49735.50264497309, 50880.74559627178, 41062.38406423846, 41284.79357603193, 41469.0, 41753.79123104365, 42697.35953960631, 40989.38515922323, 41409.79295103505, 41423.58576414197, 41686.16627667369, 41961.0, 36301.273974519834, 36876.446853296686, 36918.44622330721, 37051.25897482089, 37354.0, 34987.65012349946, 35897.64102358943, 36018.4597231047, 36592.45111323279, 36642.8167859159, 28172.577411339254, 28626.856865715537, 28645.856770716015, 28800.279993000342, 28928.855355723088], "value": 19718.00058730042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.29873565570705, 411.60485933503816, 412.1715352142193, 413.1922092309535, 424.2448441773642, 17903.283868645256, 19437.125329360177, 19739.1117399717, 19743.605127897452, 19886.303979360724, 18346.26614935401, 18817.059147042626, 19025.904870475628, 19493.512662183417, 19520.902395488003, 5620.4660557247, 5719.342275638292, 5722.570807189478, 5815.244018277639, 5820.941790582104, 5766.250387449647, 5775.537956963454, 5789.363170051291, 5799.391063938289, 5815.73829177688, 5662.065759149756, 5714.399988001242, 5771.538276937835, 5778.306603207621, 5798.82603521895, 5545.223668686387, 5737.627054241461, 5762.193292938992, 5764.279465066867, 5771.942280577204, 5642.181883626892, 5697.4302569742695, 5727.198192253088, 5733.197352370671, 5735.827925162252, 13799.310034498336, 13838.446462141503, 13902.374393152333, 14442.855571444255, 22526.21158259453, 2279.851809632385, 2618.9476210475873, 2659.468106378732, 2691.9730802692116, 3041.9847900760574, 10610.946945265301, 10727.678169654922, 12780.297083660394, 14190.574282771533, 14973.700525989529, 1918.9616207675908, 1972.3195497553465, 2001.1995201919203, 2038.1643526154205, 2117.9788202117934, 80751.596242019, 82844.17155828424, 84606.0, 84917.57541212316, 85720.57139714262, 10603.628872989408, 10688.51901664427, 10822.567097316176, 10981.39602321864, 11099.223054386115, 15203.543893683207, 15226.086434813946, 15283.312250948735, 15288.617784555252, 15290.311935962909, 8326.45878017927, 8452.197041281068, 8468.153184681605, 8646.178613031752, 8648.654053837901, 7932.444728868923, 7953.602319883983, 8093.514389136671, 8125.75622731319, 8132.878006829902, 4610.9308360374625, 4637.837675681335, 4723.291506274018, 4777.593904518086, 4795.664303498722, 1953.8925359105385, 1956.9315073972343, 1959.3338264989973, 1966.8033196680503, 2014.5668681233606, 1007.29992655104, 1012.9392236465835, 1062.8140075486758, 1084.1868598551087, 1098.95050227033, 18156.63686726258, 19153.80846191548, 19289.80710192908, 19569.706454403196, 19744.802551974582, 990.1187942730975, 1014.5890914179769, 1033.4574348467115, 1070.7269646240316, 1104.9558017679203, 10567.207459440573, 10811.83782243267, 10892.455377231106, 10967.451627418597, 10975.83536246957, 475844.0, 482634.0, 484972.0, 489921.0, 505940.0, 71960.64019679867, 83510.58244708738, 83678.0, 94459.0, 95370.52314738382, 1071.3518321415588, 1078.730317420645, 1091.9617813376494, 1106.164845541611, 1109.5395410904384, 17667.823321766617, 17734.73397899058, 17779.377721780194, 17856.732149017516, 18043.18805653775, 39884.80057599693, 42081.78959105185, 42310.36534451924, 42740.786296069564, 43985.12029759451, 57871.0, 59307.703461482415, 59741.402585973585, 59915.0, 60374.0, 8300.83398332042, 8548.829023419372, 8597.570121493774, 8610.44032137909, 8726.214640682369, 9965.35225210359, 13696.060037523739, 13745.900327973539, 13904.235267060409, 13926.721465570834, 11934.164608477671, 11992.340421276565, 12072.309876617457, 12078.901373283396, 12402.317872517098, 11781.293122412682, 11791.0, 11997.940010299893, 12008.339541325311, 12090.879091209326, 11434.714132146762, 12124.454399551865, 12162.0, 12302.200356976768, 12317.0, 7503.587302698404, 7926.524408535506, 8146.83706325882, 8302.128276531119, 8684.739457816275, 11106.722331941766, 11889.940550297193, 12108.697282568006, 12408.75182496363, 12450.25298482094], "value": 9318.70108506326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.0505553695714, 1534.4169215698032, 1573.66166274251, 1770.8848924819886, 1873.9718904216431, 8692.521911294876, 8991.055939126396, 9033.63865445383, 9306.348555601111, 9315.953420232889, 9030.503322317287, 9146.405483643559, 9214.493202873857, 9229.169374756271, 9230.630774769, 2000.9199632014702, 2269.092363054783, 2333.2416964486524, 2391.5695174868515, 2430.987845060772, 2468.555894801543, 2476.863772492512, 2480.1691433369842, 2481.627755836621, 2482.8262021658493, 2337.0534933351933, 2374.620060790274, 2379.6787433696404, 2380.416797884512, 2382.0233704181287, 2006.3379084901946, 2239.2946221940038, 2264.954700905981, 2301.4821665125214, 2305.7924786769104, 2366.7041619797524, 2372.2883135059415, 2394.05434853232, 2394.3535245483795, 2398.5802484565133, 9188.494632795193, 9239.076092390775, 9245.0, 9251.861222081674, 9258.351915365927, 5393.946060539383, 5540.750666219989, 5541.362743284533, 5541.778328866841, 5555.972220138914, 3478.4608385700258, 3530.5939816921127, 3531.0819187011307, 3574.4102223133414, 3624.5469316335457, 1134.5405110930087, 1161.8663853656853, 1174.1311429542163, 1182.4442512019336, 1229.9877001229963, 12984.610461686165, 13023.804642930458, 13061.151025183428, 13081.476740930351, 13106.148100373444, 4792.723456358202, 4842.055799119208, 4891.828785992473, 4927.039227350704, 4941.43173535048, 11012.944935275433, 11031.062359699356, 11058.391788451552, 11063.336199827874, 11076.889231107747, 5568.582356323292, 5611.943880561143, 5628.71856407178, 5632.239647647515, 5633.492985631231, 4538.568835960578, 5012.674176178537, 5135.152699804565, 5148.794048238028, 5230.660007099603, 4136.131412403369, 4170.52039015511, 4228.492580890313, 4247.5752424757275, 4266.573342665709, 1302.8436587609547, 1306.5361796562083, 1314.8948084153244, 1316.767336189652, 1326.8341457317836, 826.8263664630375, 902.2150728865929, 923.8891333039944, 1008.1178968402647, 1013.8023085498257, 6261.373862613702, 6278.780242691575, 6353.396427339396, 6387.552871298964, 6397.232332120176, 454.9681522293408, 461.458727848986, 473.08458133511766, 476.1595783442227, 485.4950851114872, 4304.504981927056, 4325.307950727868, 4325.41606883073, 4325.805338759764, 4349.26062569364, 11512.94243528777, 11792.469338879771, 11862.584809531625, 11947.641570752892, 11973.760524789455, 11566.710832229262, 11717.12121590884, 11820.290782552902, 11832.0, 11836.526538938519, 8287.792805179919, 8319.916800831914, 8573.442726222776, 8577.614007369682, 8800.207981281588, 6352.650604216812, 6502.772402965874, 6587.9670601646685, 6627.072209890523, 6678.3989440950545, 10595.576176952836, 10739.355638661706, 10907.509162087566, 11022.669319920415, 11023.44882755875, 10824.0, 11043.447827608748, 11063.391513466837, 11109.944450277697, 11190.272632278877, 7574.431917606312, 8009.078955919911, 8193.836123277382, 8268.83462330762, 8403.705870294754, 8968.461892286483, 9000.504972226328, 9028.413153145024, 9082.772930676785, 9085.545722713705, 8199.0980992092, 8337.041240257447, 8416.2004609562, 8459.407841451039, 8488.618012189343, 8080.515169089874, 8168.183181682022, 8213.630386632496, 8256.13310602402, 8292.792680183044, 7218.566885986647, 7248.238934911758, 7413.221611730691, 7438.218987006287, 7621.237876212334, 5534.308211473566, 5597.3001141496825, 5611.915821262603, 5637.830865074055, 5734.254546908875, 5476.123820188751, 5551.8889622206525, 5680.545556355564, 5708.628939118944, 5735.225744524436], "value": 4783.750538034868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.8445030835508, 339.6688228976748, 345.4766029465359, 345.7942524198102, 347.99478007829873, 5460.918086228709, 5467.644603100795, 5482.342118945722, 5486.122220444725, 5508.6779172998395, 5412.646838290428, 5427.240186373911, 5462.371827239868, 5468.562514998801, 5480.314960629921, 4011.538673052607, 4245.702800803945, 4248.511421186557, 4311.267084595618, 4331.30699088146, 4178.97910510447, 4225.894352641178, 4237.0, 4237.894052648678, 4261.339492378671, 4203.5165955915, 4211.368294755795, 4221.366794980762, 4230.513490948534, 4238.173556156551, 4001.659858911996, 4084.203580301857, 4175.749455032677, 4188.308929026707, 4205.684573656958, 3673.6326367363317, 3674.3202507536193, 3700.8149592520267, 3701.148735790783, 3711.3690672585726, 4979.8008079676765, 5254.737263136866, 5268.710220937847, 5300.9734951325, 5311.893762124736, 4639.443266808004, 4779.211430114027, 4782.115308667908, 4796.760161991921, 4837.250226214942, 5671.744771485293, 5681.801136960186, 5693.202951586781, 5719.971400143014, 5741.0, 3937.232239713257, 4064.512258528966, 4071.307877660805, 4076.1847630473726, 4096.938545921814, 5860.384659610722, 5867.178594996704, 5896.933594530863, 5899.312929419113, 5918.112283157518, 4092.447519584818, 4113.25961326964, 4125.051238215167, 4130.855420060284, 4144.191882582867, 4022.7127319257556, 4203.243416185116, 4208.873733787991, 4224.134052519226, 4238.258304796648, 4768.642351823627, 4778.01712289396, 4807.302941073524, 4819.7108173509705, 4834.589059929875, 5656.632318899258, 5667.489925906688, 5676.8864622707315, 5760.654360738369, 5787.0, 1431.1556181852757, 1457.4461704552414, 1458.555140682102, 1459.496473716566, 1464.809574755275, 914.3416739947228, 918.5636822509255, 928.9256859451227, 937.3860121620213, 940.7394091916864, 4847.594197682703, 4856.902861942812, 4868.829590964299, 4898.559129678346, 4917.704937703749, 5227.764750586232, 5263.842084737464, 5272.762725677354, 5290.8941821164135, 5323.467653234646, 4931.605471562267, 5174.172132458863, 5266.789328426897, 5412.457449626838, 5519.834404967857, 3092.752579793611, 3117.360941007088, 3120.4553745895473, 3143.732782713449, 3155.1323386069016, 5906.822795316148, 6074.908876366858, 6098.817035488943, 6118.785842495491, 6151.784687535915, 5934.970325148433, 5943.910841337383, 5953.226080609493, 5953.910691339634, 5972.372900845436, 6118.571699980958, 6124.78563250293, 6127.417895299939, 6160.44555989963, 6164.352742961924, 5628.577856660685, 5851.736671849691, 5852.795152169653, 5897.882042359043, 5909.468147866713, 5732.312122545154, 5788.189653448605, 5835.665733706382, 5849.268841394825, 5852.356240813422, 5988.371221021905, 6011.248593925759, 6055.0, 6099.969500152471, 6110.450059494667, 4233.280342341748, 4249.91500170001, 4253.510846252597, 4257.382679511516, 4257.723247988871, 5773.3072031356505, 5799.188113664175, 5822.0, 5823.359430462561, 5916.37299742557, 5511.0080185566985, 5708.257926469532, 5725.255716756795, 5726.885462290647, 5802.897449484584, 5687.322239939311, 5702.0042984954935, 5715.8571035724435, 5722.971385143048, 5732.5413966881715, 5177.974110129576, 5500.4499550044675, 5559.72201389937, 5599.860003499945, 5610.102383618601, 5648.519875810438, 5672.5461963042035, 5684.7441865117, 5783.566232532661, 5783.987802134526, 5376.650517716336, 5583.413741557078, 5602.551795856403, 5609.148980836396, 5619.80330688424], "value": 4309.008791507567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.5672193737321, 850.1668365002298, 855.7903313688143, 878.6397576993434, 907.9228265597424, 13821.447142114315, 14047.15717056976, 14190.858091419082, 14205.79250763685, 14217.71564568708, 13634.0, 14103.929480352585, 14313.78529322061, 14326.64183395413, 14359.78460323096, 701.1551080947446, 844.7592436155712, 859.0979471554842, 859.7807559072428, 860.3418384935529, 729.8941653460245, 734.7758933525273, 734.8824188129901, 833.7540425574471, 857.6998050682274, 904.2630256341093, 906.7053207707488, 907.6732376344511, 909.9181073703365, 910.3036177324352, 899.757065592293, 900.0009988912302, 903.029243563169, 903.5166186090443, 903.575319599787, 530.986725331866, 643.1703102997128, 655.367570294668, 656.3174298729316, 659.0345144363482, 13096.672583185402, 13100.60698179056, 13124.2125472471, 13155.144915580457, 13253.536126235633, 12784.872151278461, 13072.281024543647, 13358.599242022754, 13579.964378463868, 13669.658258543517, 12370.690732731664, 12570.560030398892, 12592.68518287041, 12645.43095560702, 12690.492380304777, 4545.5908968193025, 4572.268437050056, 4594.839180628695, 4615.653825963032, 4741.241401375798, 59542.702286488726, 59934.10098848565, 60553.697231514, 60726.69636651833, 60925.0, 11224.55101795919, 11281.266717663326, 11410.0, 11422.885771142348, 11550.249233799776, 19673.606527869364, 19737.210511579662, 19751.802481974995, 19762.50593735168, 19766.70349944752, 8494.53280069602, 8505.74482765518, 8670.566471676517, 8821.735347939572, 8940.46357218569, 4681.7190968542, 4746.976265118652, 4841.0, 4851.126797176542, 4915.4347250065985, 3620.637936206358, 3689.741718079709, 3705.888823335304, 3707.3697471429923, 3710.8144592770254, 677.0859339891206, 681.7647911470634, 688.0642326436043, 690.7384558972894, 692.6259819697408, 675.7769935921134, 724.5296520468721, 733.2520828754747, 739.9408047356198, 777.9494332868345, 9236.445813251092, 9707.611695532241, 9745.756356091155, 9815.607375705034, 9886.30795844284, 611.7063809371526, 638.3393188050345, 656.2289310060755, 713.0195980526776, 762.3558093411059, 4474.709143905701, 4622.745748983838, 4732.407219128017, 4734.337192793012, 4737.360456338351, 68410.65794671094, 69690.65154674194, 71658.28341716621, 71902.2809771906, 72005.6399717998, 59632.40367596355, 60136.69931650401, 61086.389136108955, 61657.0, 62667.05999410013, 49774.50225497771, 50453.24320135201, 51588.74205628948, 54550.72724636431, 58770.0, 9468.337216394786, 9624.278179136452, 9709.854352184582, 9906.603735850485, 9912.75218119524, 36618.0, 37128.257434851694, 37640.0, 37846.0, 38252.6174738249, 47353.76323118362, 49963.50036499734, 51214.74392628013, 51436.22845657243, 51929.740351298, 12010.33943133136, 12146.514139434325, 12693.301868397326, 13010.21938683682, 13052.975703990045, 13764.65588360299, 14187.858121418654, 14521.346539405964, 14683.55949321522, 14692.559223223321, 12825.615231543068, 13173.143745656502, 13266.469341226242, 13384.866151338361, 13409.0, 13344.599662010156, 13497.527586534425, 14024.579262622137, 14035.719285614436, 14069.437222510986, 13135.802962955373, 13288.136271142344, 13306.667333316744, 13767.518136865161, 13830.861691382957, 10899.29154604948, 11218.102551796, 11252.718682033015, 11360.0, 11836.76326473483, 11235.71910702239, 11517.0, 11535.250208736405, 11560.710982225512, 11613.709657258636], "value": 7103.511026173357, "unit": "score"}], "name": "dromaeo_css", "value": 7247.117553483081, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 113.0, 112.0, 111.0, 111.0, 111.0, 111.0, 109.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 149.0, 205.0, 125.0, 151.0, 147.0, 124.0, 178.0, 124.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 159.0, 162.0, 159.0, 161.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 154.0, 76.0, 75.0, 76.0, 73.0, 134.0, 75.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 143.0, 92.0, 91.0, 91.0, 144.0, 92.0, 91.0, 129.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 53.0, 54.0, 58.0, 57.0, 114.0, 52.0, 55.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 82.0, 79.0, 81.0, 77.0, 78.0, 78.0, 78.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 134.0, 126.0, 117.0, 117.0, 131.0, 117.0, 200.0, 121.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 158.0, 165.0, 159.0, 165.0, 160.0, 160.0, 157.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 63.0, 65.0, 63.0, 62.0, 63.0, 64.0, 62.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1525.0, "alertThreshold": 2.0}]} 11:54:26 INFO - Return code: 0 11:54:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:54:26 ERROR - # TBPL SUCCESS # 11:54:26 INFO - Running post-action listener: _resource_record_post_action 11:54:26 INFO - ##### 11:54:26 INFO - ##### Finished run-tests step (success) 11:54:26 INFO - ##### 11:54:26 INFO - Running post-run listener: _resource_record_post_run 11:54:26 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535756800; Read time: 24; Write time: 495704 11:54:26 INFO - TinderboxPrint: CPU usage
13.1% 11:54:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 11:54:26 INFO - TinderboxPrint: I/O write bytes / time
535,756,800 / 495,704 11:54:26 INFO - TinderboxPrint: CPU idle
8,279.2 (86.9%) 11:54:26 INFO - TinderboxPrint: CPU user
1,205.1 (12.6%) 11:54:26 INFO - TinderboxPrint: Swap in / out
0 / 0 11:54:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246169600; Read time: 0; Write time: 227216 11:54:26 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289587200; Read time: 24; Write time: 268488 11:54:27 INFO - Running post-run listener: _upload_blobber_files 11:54:27 INFO - Blob upload gear active. 11:54:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:54:27 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:54:27 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:54:27 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:54:27 INFO - (blobuploader) - INFO - Open directory for files ... 11:54:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:54:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:54:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:28 INFO - (blobuploader) - INFO - Done attempting. 11:54:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:54:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:32 INFO - (blobuploader) - INFO - Done attempting. 11:54:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:54:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:32 INFO - (blobuploader) - INFO - Done attempting. 11:54:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:54:32 INFO - Return code: 0 11:54:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:54:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:54:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/447e7604af6829edf3a868a9eacac872f576d0deb0db2a3b378d809b95c131c9703588270fc43a27ef6c9e529cb4cec7d2793e1bd26c10e9c8e2d19801d55923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a31984e22583465a41975d9d8915627fc72efa94a37e29d4725ad54c8ee177defe37f130175c3cff74d628d7ec92d9b1ff1da79e7e0de2c592e7287bf454919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29146ce2a03721711da86984cc7fd9d9557f48ebd0b233be1ecf7087b52b61c3ac06394e7441a37138f4ed039978a916e112eee86b9122675868190e3e28be85"} 11:54:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:54:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:54:32 INFO - Contents: 11:54:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/447e7604af6829edf3a868a9eacac872f576d0deb0db2a3b378d809b95c131c9703588270fc43a27ef6c9e529cb4cec7d2793e1bd26c10e9c8e2d19801d55923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a31984e22583465a41975d9d8915627fc72efa94a37e29d4725ad54c8ee177defe37f130175c3cff74d628d7ec92d9b1ff1da79e7e0de2c592e7287bf454919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29146ce2a03721711da86984cc7fd9d9557f48ebd0b233be1ecf7087b52b61c3ac06394e7441a37138f4ed039978a916e112eee86b9122675868190e3e28be85"} 11:54:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:54:32 INFO - Copying logs to upload dir... 11:54:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:54:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.525636 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-17 11:54:32.797725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:54:32.800915) ========= 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=920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942 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/447e7604af6829edf3a868a9eacac872f576d0deb0db2a3b378d809b95c131c9703588270fc43a27ef6c9e529cb4cec7d2793e1bd26c10e9c8e2d19801d55923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a31984e22583465a41975d9d8915627fc72efa94a37e29d4725ad54c8ee177defe37f130175c3cff74d628d7ec92d9b1ff1da79e7e0de2c592e7287bf454919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29146ce2a03721711da86984cc7fd9d9557f48ebd0b233be1ecf7087b52b61c3ac06394e7441a37138f4ed039978a916e112eee86b9122675868190e3e28be85"} build_url:https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/FhwnTkN9RcqdH0d0jO5MCg/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/447e7604af6829edf3a868a9eacac872f576d0deb0db2a3b378d809b95c131c9703588270fc43a27ef6c9e529cb4cec7d2793e1bd26c10e9c8e2d19801d55923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a31984e22583465a41975d9d8915627fc72efa94a37e29d4725ad54c8ee177defe37f130175c3cff74d628d7ec92d9b1ff1da79e7e0de2c592e7287bf454919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29146ce2a03721711da86984cc7fd9d9557f48ebd0b233be1ecf7087b52b61c3ac06394e7441a37138f4ed039978a916e112eee86b9122675868190e3e28be85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:54:32.824824) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:54:32.825112) ========= 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=920470bf432669ad7e3a5387000001ca-1463510036.856632-520227942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:54:32.909225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:54:32.909551) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:54:32.909867) ========= ========= Total master_lag: 0.25 =========