builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1464620697.17 results: success (0) buildid: 20160530053004 builduid: e15448c5eb5545f1a0b00fdcc6fc0c62 revision: 00dccad34edae14b16de663c884a36ef2ec575b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.171313) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.172007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.172399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.189871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.190526) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 08:04: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% 70.7M=0s 2016-05-30 08:04:57 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133105 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.340884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.341396) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.391532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:57.391898) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 00dccad34edae14b16de663c884a36ef2ec575b4 --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 00dccad34edae14b16de663c884a36ef2ec575b4 --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=4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 08:04:57,715 truncating revision to first 12 chars 2016-05-30 08:04:57,715 Setting DEBUG logging. 2016-05-30 08:04:57,715 attempt 1/10 2016-05-30 08:04:57,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/00dccad34eda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 08:04:58,052 unpacking tar archive at: fx-team-00dccad34eda/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655028 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:58.060984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:58.061503) ========= script_repo_revision: 00dccad34edae14b16de663c884a36ef2ec575b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:58.062112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:58.062523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:04:58.074597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 08:04:58.075213) ========= /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=4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:58 INFO - MultiFileLogger online at 20160530 08:04:58 in /builds/slave/test 08:04: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 08:04:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:58 INFO - {'append_to_log': False, 08:04:58 INFO - 'base_work_dir': '/builds/slave/test', 08:04:58 INFO - 'blob_upload_branch': 'Fx-Team', 08:04:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:58 INFO - 'branch': 'Fx-Team', 08:04:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:58 INFO - 'config_files': ('talos/linux_config.py',), 08:04:58 INFO - 'default_actions': ('clobber', 08:04:58 INFO - 'read-buildbot-config', 08:04:58 INFO - 'download-and-extract', 08:04:58 INFO - 'populate-webroot', 08:04:58 INFO - 'create-virtualenv', 08:04:58 INFO - 'install', 08:04:58 INFO - 'run-tests'), 08:04:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:58 INFO - 'download_minidump_stackwalk': True, 08:04:58 INFO - 'download_symbols': 'ondemand', 08:04:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:58 INFO - 'installer_path': 'installer.exe', 08:04:58 INFO - 'log_level': 'info', 08:04:58 INFO - 'log_name': 'talos', 08:04:58 INFO - 'log_to_console': True, 08:04:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:04:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:58 INFO - 'opt_config_files': (), 08:04:58 INFO - 'pip_index': False, 08:04:58 INFO - 'sps_profile': False, 08:04:58 INFO - 'sps_profile_interval': 0, 08:04:58 INFO - 'suite': 'dromaeojs', 08:04:58 INFO - 'system_bits': '32', 08:04:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:58 INFO - 'title': 'talos-linux64-ix-030', 08:04:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:58 INFO - 'use_talos_json': True, 08:04:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:58 INFO - 'work_dir': 'build'} 08:04:58 INFO - ##### 08:04:58 INFO - ##### Running clobber step. 08:04:58 INFO - ##### 08:04:58 INFO - Running pre-action listener: _resource_record_pre_action 08:04:58 INFO - Running main action method: clobber 08:04:58 INFO - rmtree: /builds/slave/test/build 08:04:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:59 INFO - Running post-action listener: _resource_record_post_action 08:04:59 INFO - ##### 08:04:59 INFO - ##### Finished clobber step (success) 08:04:59 INFO - ##### 08:04:59 INFO - ##### 08:04:59 INFO - ##### Running read-buildbot-config step. 08:04:59 INFO - ##### 08:04:59 INFO - Running pre-action listener: _resource_record_pre_action 08:04:59 INFO - Running main action method: read_buildbot_config 08:04:59 INFO - Using buildbot properties: 08:04:59 INFO - { 08:04:59 INFO - "project": "", 08:04:59 INFO - "product": "firefox", 08:04:59 INFO - "script_repo_revision": "production", 08:04:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:04:59 INFO - "repository": "", 08:04:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:04:59 INFO - "buildid": "20160530053004", 08:04:59 INFO - "pgo_build": "True", 08:04:59 INFO - "basedir": "/builds/slave/test", 08:04:59 INFO - "buildnumber": 735, 08:04:59 INFO - "slavename": "talos-linux64-ix-030", 08:04:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:04:59 INFO - "platform": "ubuntu64_hw", 08:04:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:04:59 INFO - "branch": "fx-team", 08:04:59 INFO - "repo_path": "integration/fx-team", 08:04:59 INFO - "revision": "00dccad34edae14b16de663c884a36ef2ec575b4", 08:04:59 INFO - "stage_platform": "linux64-pgo", 08:04:59 INFO - "builduid": "e15448c5eb5545f1a0b00fdcc6fc0c62", 08:04:59 INFO - "slavebuilddir": "test" 08:04:59 INFO - } 08:04:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:04:59 INFO - Running post-action listener: _resource_record_post_action 08:04:59 INFO - ##### 08:04:59 INFO - ##### Finished read-buildbot-config step (success) 08:04:59 INFO - ##### 08:04:59 INFO - ##### 08:04:59 INFO - ##### Running download-and-extract step. 08:04:59 INFO - ##### 08:04:59 INFO - Running pre-action listener: _resource_record_pre_action 08:04:59 INFO - Running main action method: download_and_extract 08:04:59 INFO - mkdir: /builds/slave/test/build/tests 08:04: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')]} 08:04:59 INFO - https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:04:59 INFO - Downloaded 1361 bytes. 08:04:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:04:59 INFO - Using the following test package requirements: 08:04:59 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:04:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'jsshell-linux-x86_64.zip'], 08:04:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:59 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04: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')]} 08:04:59 INFO - https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:05:00 INFO - Downloaded 24411182 bytes. 08:05: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'] 08:05: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 08:05:02 INFO - Return code: 0 08:05: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 08:05: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')]} 08:05:02 INFO - https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:05:03 INFO - Downloaded 24411182 bytes. 08:05: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'] 08:05: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 08:05:04 INFO - Return code: 0 08:05: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')]} 08:05:04 INFO - https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:05:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:05:06 INFO - Downloaded 10834034 bytes. 08:05:06 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'] 08:05:06 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 08:05:06 INFO - Return code: 0 08:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:06 INFO - https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:05:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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 08:05:07 INFO - Downloaded 58761087 bytes. 08:05:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:07 INFO - mkdir: /builds/slave/test/properties 08:05:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:07 INFO - Contents: 08:05:07 INFO - build_url:https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:05:08 INFO - Running post-action listener: _resource_record_post_action 08:05:08 INFO - Running post-action listener: set_extra_try_arguments 08:05:08 INFO - ##### 08:05:08 INFO - ##### Finished download-and-extract step (success) 08:05:08 INFO - ##### 08:05:08 INFO - ##### 08:05:08 INFO - ##### Running populate-webroot step. 08:05:08 INFO - ##### 08:05:08 INFO - Running pre-action listener: _resource_record_pre_action 08:05:08 INFO - Running main action method: populate_webroot 08:05:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:08 INFO - '--tppagecycles', 08:05:08 INFO - '7'], 08:05:08 INFO - 'tests': ['tsvgm']}}, 08:05:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['damp', 'tps']}, 08:05:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'tests': ['damp', 'tps']}, 08:05:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['dromaeo_dom']}, 08:05:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['a11yr', 08:05:08 INFO - 'ts_paint', 08:05:08 INFO - 'tpaint', 08:05:08 INFO - 'sessionrestore', 08:05:08 INFO - 'sessionrestore_no_auto_restore', 08:05:08 INFO - 'tabpaint']}, 08:05:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:08 INFO - 'ts_paint', 08:05:08 INFO - 'tpaint', 08:05:08 INFO - 'sessionrestore', 08:05:08 INFO - 'sessionrestore_no_auto_restore', 08:05:08 INFO - 'tabpaint']}, 08:05:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:08 INFO - 'ts_paint', 08:05:08 INFO - 'tpaint', 08:05:08 INFO - 'sessionrestore', 08:05:08 INFO - 'sessionrestore_no_auto_restore', 08:05:08 INFO - 'tabpaint']}, 08:05:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:08 INFO - 'ts_paint', 08:05:08 INFO - 'tpaint', 08:05:08 INFO - 'sessionrestore', 08:05:08 INFO - 'sessionrestore_no_auto_restore', 08:05:08 INFO - 'tabpaint']}, 08:05:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['a11yr', 08:05:08 INFO - 'ts_paint', 08:05:08 INFO - 'tpaint', 08:05:08 INFO - 'sessionrestore', 08:05:08 INFO - 'sessionrestore_no_auto_restore', 08:05:08 INFO - 'tabpaint']}, 08:05:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['a11yr', 08:05:08 INFO - 'ts_paint', 08:05:08 INFO - 'tpaint', 08:05:08 INFO - 'sessionrestore', 08:05:08 INFO - 'sessionrestore_no_auto_restore', 08:05:08 INFO - 'tabpaint']}, 08:05:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['tsvgx', 08:05:08 INFO - 'tsvgr_opacity', 08:05:08 INFO - 'tart', 08:05:08 INFO - 'tscrollx', 08:05:08 INFO - 'cart']}, 08:05:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:08 INFO - 'tsvgr_opacity', 08:05:08 INFO - 'tart', 08:05:08 INFO - 'tscrollx', 08:05:08 INFO - 'cart']}, 08:05:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'talos_options': ['--disable-e10s'], 08:05:08 INFO - 'tests': ['tp5o']}, 08:05:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'tests': ['tp5o']}, 08:05:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'talos_options': ['--disable-e10s', 08:05:08 INFO - '--xperf_path', 08:05:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:08 INFO - 'tests': ['tp5n']}, 08:05:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:08 INFO - 'talos_options': ['--xperf_path', 08:05:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:08 INFO - 'tests': ['tp5n']}}, 08:05:08 INFO - 'talos.zip': {'path': '', 08:05:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:08 INFO - Running post-action listener: _resource_record_post_action 08:05:08 INFO - ##### 08:05:08 INFO - ##### Finished populate-webroot step (success) 08:05:08 INFO - ##### 08:05:08 INFO - ##### 08:05:08 INFO - ##### Running create-virtualenv step. 08:05:08 INFO - ##### 08:05:08 INFO - Running pre-action listener: _resource_record_pre_action 08:05:08 INFO - Running main action method: create_virtualenv 08:05:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:08 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 08:05:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:08 INFO - Using real prefix '/usr' 08:05:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:11 INFO - Installing pip.................done. 08:05:11 INFO - Return code: 0 08:05:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:11 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')]} 08:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:11 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')]} 08:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:11 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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05:11 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 08:05:11 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 08:05:11 INFO - Using env: {'DISPLAY': ':0', 08:05:11 INFO - 'HOME': '/home/cltbld', 08:05:11 INFO - 'LANG': 'en_US.UTF-8', 08:05:11 INFO - 'LANGUAGE': 'en_US:en', 08:05:11 INFO - 'LOGNAME': 'cltbld', 08:05:11 INFO - 'MAIL': '/var/mail/cltbld', 08:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:11 INFO - 'MOZ_NO_REMOTE': '1', 08:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:11 INFO - 'NO_EM_RESTART': '1', 08:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:11 INFO - 'PWD': '/builds/slave/test', 08:05:11 INFO - 'SHELL': '/bin/bash', 08:05:11 INFO - 'SHLVL': '1', 08:05:11 INFO - 'TERM': 'linux', 08:05:11 INFO - 'TMOUT': '86400', 08:05:11 INFO - 'USER': 'cltbld', 08:05:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:11 INFO - '_': '/tools/buildbot/bin/python'} 08:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:11 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 08:05:11 INFO - Cleaning up... 08:05:11 INFO - Return code: 0 08:05:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:11 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')]} 08:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:11 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')]} 08:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:11 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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05:11 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 08:05:11 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 08:05:11 INFO - Using env: {'DISPLAY': ':0', 08:05:11 INFO - 'HOME': '/home/cltbld', 08:05:11 INFO - 'LANG': 'en_US.UTF-8', 08:05:11 INFO - 'LANGUAGE': 'en_US:en', 08:05:11 INFO - 'LOGNAME': 'cltbld', 08:05:11 INFO - 'MAIL': '/var/mail/cltbld', 08:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:11 INFO - 'MOZ_NO_REMOTE': '1', 08:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:11 INFO - 'NO_EM_RESTART': '1', 08:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:11 INFO - 'PWD': '/builds/slave/test', 08:05:11 INFO - 'SHELL': '/bin/bash', 08:05:11 INFO - 'SHLVL': '1', 08:05:11 INFO - 'TERM': 'linux', 08:05:11 INFO - 'TMOUT': '86400', 08:05:11 INFO - 'USER': 'cltbld', 08:05:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:11 INFO - '_': '/tools/buildbot/bin/python'} 08:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:11 INFO - Downloading/unpacking psutil>=3.1.1 08:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:13 INFO - Installing collected packages: psutil 08:05:13 INFO - Running setup.py install for psutil 08:05:13 INFO - building 'psutil._psutil_linux' extension 08:05: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 08:05: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 08:05:13 INFO - building 'psutil._psutil_posix' extension 08:05: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 08:05:14 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 08:05:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:14 INFO - Successfully installed psutil 08:05:14 INFO - Cleaning up... 08:05:14 INFO - Return code: 0 08:05:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:14 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')]} 08:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:14 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')]} 08:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:14 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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05:14 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 08:05:14 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 08:05:14 INFO - Using env: {'DISPLAY': ':0', 08:05:14 INFO - 'HOME': '/home/cltbld', 08:05:14 INFO - 'LANG': 'en_US.UTF-8', 08:05:14 INFO - 'LANGUAGE': 'en_US:en', 08:05:14 INFO - 'LOGNAME': 'cltbld', 08:05:14 INFO - 'MAIL': '/var/mail/cltbld', 08:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:14 INFO - 'MOZ_NO_REMOTE': '1', 08:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:14 INFO - 'NO_EM_RESTART': '1', 08:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:14 INFO - 'PWD': '/builds/slave/test', 08:05:14 INFO - 'SHELL': '/bin/bash', 08:05:14 INFO - 'SHLVL': '1', 08:05:14 INFO - 'TERM': 'linux', 08:05:14 INFO - 'TMOUT': '86400', 08:05:14 INFO - 'USER': 'cltbld', 08:05:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:14 INFO - '_': '/tools/buildbot/bin/python'} 08:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:14 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 08:05:14 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 08:05:14 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 08:05:14 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 08:05:14 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 08:05:14 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 08:05:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:16 INFO - Installing collected packages: mozsystemmonitor 08:05:16 INFO - Running setup.py install for mozsystemmonitor 08:05:16 INFO - Successfully installed mozsystemmonitor 08:05:16 INFO - Cleaning up... 08:05:16 INFO - Return code: 0 08:05:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:16 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')]} 08:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:16 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')]} 08:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:16 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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05:16 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 08:05:16 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 08:05:16 INFO - Using env: {'DISPLAY': ':0', 08:05:16 INFO - 'HOME': '/home/cltbld', 08:05:16 INFO - 'LANG': 'en_US.UTF-8', 08:05:16 INFO - 'LANGUAGE': 'en_US:en', 08:05:16 INFO - 'LOGNAME': 'cltbld', 08:05:16 INFO - 'MAIL': '/var/mail/cltbld', 08:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:16 INFO - 'MOZ_NO_REMOTE': '1', 08:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:16 INFO - 'NO_EM_RESTART': '1', 08:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:16 INFO - 'PWD': '/builds/slave/test', 08:05:16 INFO - 'SHELL': '/bin/bash', 08:05:16 INFO - 'SHLVL': '1', 08:05:16 INFO - 'TERM': 'linux', 08:05:16 INFO - 'TMOUT': '86400', 08:05:16 INFO - 'USER': 'cltbld', 08:05:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:16 INFO - '_': '/tools/buildbot/bin/python'} 08:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:16 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:16 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 08:05:16 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 08:05:16 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 08:05:16 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 08:05:16 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 08:05:16 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 08:05:18 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:19 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 08:05:19 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 08:05:19 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 08:05:19 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 08:05:19 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 08:05:19 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 08:05:19 INFO - Downloading docopt-0.6.1.tar.gz 08:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:19 INFO - Running setup.py install for blobuploader 08:05:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:19 INFO - Running setup.py install for requests 08:05:19 INFO - Running setup.py install for docopt 08:05:19 INFO - Successfully installed blobuploader requests docopt 08:05:19 INFO - Cleaning up... 08:05:19 INFO - Return code: 0 08:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05: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 08:05: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 08:05:19 INFO - Using env: {'DISPLAY': ':0', 08:05:19 INFO - 'HOME': '/home/cltbld', 08:05:19 INFO - 'LANG': 'en_US.UTF-8', 08:05:19 INFO - 'LANGUAGE': 'en_US:en', 08:05:19 INFO - 'LOGNAME': 'cltbld', 08:05:19 INFO - 'MAIL': '/var/mail/cltbld', 08:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:19 INFO - 'MOZ_NO_REMOTE': '1', 08:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:19 INFO - 'NO_EM_RESTART': '1', 08:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:19 INFO - 'PWD': '/builds/slave/test', 08:05:19 INFO - 'SHELL': '/bin/bash', 08:05:19 INFO - 'SHLVL': '1', 08:05:19 INFO - 'TERM': 'linux', 08:05:19 INFO - 'TMOUT': '86400', 08:05:19 INFO - 'USER': 'cltbld', 08:05:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:19 INFO - '_': '/tools/buildbot/bin/python'} 08:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:20 INFO - Running setup.py (path:/tmp/pip-gQLdk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:20 INFO - Running setup.py (path:/tmp/pip-s_QxVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:20 INFO - Running setup.py (path:/tmp/pip-Eiv6sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:20 INFO - Running setup.py (path:/tmp/pip-j8QcgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:20 INFO - Running setup.py (path:/tmp/pip-ZmqPQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:20 INFO - Running setup.py (path:/tmp/pip-rXB4ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:20 INFO - Running setup.py (path:/tmp/pip-tTsMDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:20 INFO - Running setup.py (path:/tmp/pip-meZMDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:20 INFO - Running setup.py (path:/tmp/pip-RhNjJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:20 INFO - Running setup.py (path:/tmp/pip-wf8beb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:20 INFO - Running setup.py (path:/tmp/pip-Skypxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:20 INFO - Running setup.py (path:/tmp/pip-376X8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:21 INFO - Running setup.py (path:/tmp/pip-jQmNpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:21 INFO - Running setup.py (path:/tmp/pip-oHatn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:21 INFO - Running setup.py (path:/tmp/pip-1DJmrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:21 INFO - Running setup.py (path:/tmp/pip-DUvs9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:21 INFO - Running setup.py (path:/tmp/pip-QsaopA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:21 INFO - Running setup.py install for manifestparser 08:05:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:21 INFO - Running setup.py install for mozcrash 08:05:21 INFO - Running setup.py install for mozdebug 08:05:21 INFO - Running setup.py install for mozdevice 08:05:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:21 INFO - Running setup.py install for mozfile 08:05:21 INFO - Running setup.py install for mozhttpd 08:05:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:21 INFO - Running setup.py install for mozinfo 08:05:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Running setup.py install for mozInstall 08:05:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Running setup.py install for mozleak 08:05:22 INFO - Running setup.py install for mozlog 08:05:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Running setup.py install for moznetwork 08:05:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Running setup.py install for mozprocess 08:05:22 INFO - Running setup.py install for mozprofile 08:05:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Running setup.py install for mozrunner 08:05:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:22 INFO - Running setup.py install for mozscreenshot 08:05:22 INFO - Running setup.py install for moztest 08:05:23 INFO - Running setup.py install for mozversion 08:05:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:23 INFO - Cleaning up... 08:05:23 INFO - Return code: 0 08:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:23 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')]} 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:23 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')]} 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:23 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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05:23 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 08:05:23 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 08:05:23 INFO - Using env: {'DISPLAY': ':0', 08:05:23 INFO - 'HOME': '/home/cltbld', 08:05:23 INFO - 'LANG': 'en_US.UTF-8', 08:05:23 INFO - 'LANGUAGE': 'en_US:en', 08:05:23 INFO - 'LOGNAME': 'cltbld', 08:05:23 INFO - 'MAIL': '/var/mail/cltbld', 08:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:23 INFO - 'MOZ_NO_REMOTE': '1', 08:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:23 INFO - 'NO_EM_RESTART': '1', 08:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:23 INFO - 'PWD': '/builds/slave/test', 08:05:23 INFO - 'SHELL': '/bin/bash', 08:05:23 INFO - 'SHLVL': '1', 08:05:23 INFO - 'TERM': 'linux', 08:05:23 INFO - 'TMOUT': '86400', 08:05:23 INFO - 'USER': 'cltbld', 08:05:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:23 INFO - '_': '/tools/buildbot/bin/python'} 08:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:23 INFO - Running setup.py (path:/tmp/pip-iDc6Ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:23 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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:23 INFO - Running setup.py (path:/tmp/pip-zTGV5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:23 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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:23 INFO - Running setup.py (path:/tmp/pip-E81mil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:23 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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:23 INFO - Running setup.py (path:/tmp/pip-xf5JyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:23 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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:23 INFO - Running setup.py (path:/tmp/pip-7yqYoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05: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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:23 INFO - Running setup.py (path:/tmp/pip-co9Y_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05: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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:23 INFO - Running setup.py (path:/tmp/pip-43BQJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05: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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:23 INFO - Running setup.py (path:/tmp/pip-Uv5OTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05: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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:23 INFO - Running setup.py (path:/tmp/pip-LxkI6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05: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)) 08:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:23 INFO - Running setup.py (path:/tmp/pip-zV9ccz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:24 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)) 08:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:24 INFO - Running setup.py (path:/tmp/pip-0Ie8kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:24 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)) 08:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:24 INFO - Running setup.py (path:/tmp/pip-x_jy7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:24 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)) 08:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:24 INFO - Running setup.py (path:/tmp/pip-pRz4TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:24 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)) 08:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:24 INFO - Running setup.py (path:/tmp/pip-ysWgaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:24 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)) 08:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:24 INFO - Running setup.py (path:/tmp/pip-n1zDrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:24 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)) 08:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:24 INFO - Running setup.py (path:/tmp/pip-01PC_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:24 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)) 08:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:24 INFO - Running setup.py (path:/tmp/pip-Y65yjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:24 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)) 08:05:24 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)) 08:05:24 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)) 08:05:24 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)) 08:05:24 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)) 08:05:24 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)) 08:05:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:24 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 08:05:24 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 08:05:24 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 08:05:24 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 08:05:24 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 08:05:24 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 08:05:26 INFO - Downloading blessings-1.6.tar.gz 08:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:26 INFO - Installing collected packages: blessings 08:05:26 INFO - Running setup.py install for blessings 08:05:26 INFO - Successfully installed blessings 08:05:26 INFO - Cleaning up... 08:05:26 INFO - Return code: 0 08:05:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:26 INFO - Reading from file tmpfile_stdout 08:05:26 INFO - Current package versions: 08:05:26 INFO - argparse == 1.2.1 08:05:26 INFO - blessings == 1.6 08:05:26 INFO - blobuploader == 1.2.4 08:05:26 INFO - docopt == 0.6.1 08:05:26 INFO - manifestparser == 1.1 08:05:26 INFO - mozInstall == 1.12 08:05:26 INFO - mozcrash == 0.17 08:05:26 INFO - mozdebug == 0.1 08:05:26 INFO - mozdevice == 0.48 08:05:26 INFO - mozfile == 1.2 08:05:26 INFO - mozhttpd == 0.7 08:05:26 INFO - mozinfo == 0.9 08:05:26 INFO - mozleak == 0.1 08:05:26 INFO - mozlog == 3.2 08:05:26 INFO - moznetwork == 0.27 08:05:26 INFO - mozprocess == 0.22 08:05:26 INFO - mozprofile == 0.28 08:05:26 INFO - mozrunner == 6.11 08:05:26 INFO - mozscreenshot == 0.1 08:05:26 INFO - mozsystemmonitor == 0.3 08:05:26 INFO - moztest == 0.7 08:05:26 INFO - mozversion == 1.4 08:05:26 INFO - psutil == 3.1.1 08:05:26 INFO - requests == 1.2.3 08:05:26 INFO - wsgiref == 0.1.2 08:05:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05: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 08:05: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 08:05:26 INFO - Using env: {'DISPLAY': ':0', 08:05:26 INFO - 'HOME': '/home/cltbld', 08:05:26 INFO - 'LANG': 'en_US.UTF-8', 08:05:26 INFO - 'LANGUAGE': 'en_US:en', 08:05:26 INFO - 'LOGNAME': 'cltbld', 08:05:26 INFO - 'MAIL': '/var/mail/cltbld', 08:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:26 INFO - 'MOZ_NO_REMOTE': '1', 08:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:26 INFO - 'NO_EM_RESTART': '1', 08:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:26 INFO - 'PWD': '/builds/slave/test', 08:05:26 INFO - 'SHELL': '/bin/bash', 08:05:26 INFO - 'SHLVL': '1', 08:05:26 INFO - 'TERM': 'linux', 08:05:26 INFO - 'TMOUT': '86400', 08:05:26 INFO - 'USER': 'cltbld', 08:05:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:26 INFO - '_': '/tools/buildbot/bin/python'} 08:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 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)) 08:05:27 INFO - Cleaning up... 08:05:27 INFO - Return code: 0 08:05:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:27 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')]} 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:27 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')]} 08:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:27 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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05:27 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 08:05:27 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 08:05:27 INFO - Using env: {'DISPLAY': ':0', 08:05:27 INFO - 'HOME': '/home/cltbld', 08:05:27 INFO - 'LANG': 'en_US.UTF-8', 08:05:27 INFO - 'LANGUAGE': 'en_US:en', 08:05:27 INFO - 'LOGNAME': 'cltbld', 08:05:27 INFO - 'MAIL': '/var/mail/cltbld', 08:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:27 INFO - 'MOZ_NO_REMOTE': '1', 08:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:27 INFO - 'NO_EM_RESTART': '1', 08:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:27 INFO - 'PWD': '/builds/slave/test', 08:05:27 INFO - 'SHELL': '/bin/bash', 08:05:27 INFO - 'SHLVL': '1', 08:05:27 INFO - 'TERM': 'linux', 08:05:27 INFO - 'TMOUT': '86400', 08:05:27 INFO - 'USER': 'cltbld', 08:05:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:27 INFO - '_': '/tools/buildbot/bin/python'} 08:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:27 INFO - Downloading/unpacking jsonschema 08:05:27 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 08:05:27 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 08:05:27 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 08:05:27 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 08:05:27 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 08:05:27 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 08:05:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:29 INFO - Downloading/unpacking functools32 (from jsonschema) 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:29 INFO - warning: no files found matching '*.txt' 08:05:29 INFO - no previously-included directories found matching 'build' 08:05:29 INFO - no previously-included directories found matching 'dist' 08:05:29 INFO - no previously-included directories found matching '.git*' 08:05:29 INFO - Installing collected packages: jsonschema, functools32 08:05:29 INFO - Running setup.py install for functools32 08:05:29 INFO - warning: no files found matching '*.txt' 08:05:29 INFO - no previously-included directories found matching 'build' 08:05:29 INFO - no previously-included directories found matching 'dist' 08:05:29 INFO - no previously-included directories found matching '.git*' 08:05:29 INFO - Successfully installed jsonschema functools32 08:05:29 INFO - Cleaning up... 08:05:29 INFO - Return code: 0 08:05:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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 0x7f3ec3537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', '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 08:05: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 08:05: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 08:05:29 INFO - Using env: {'DISPLAY': ':0', 08:05:29 INFO - 'HOME': '/home/cltbld', 08:05:29 INFO - 'LANG': 'en_US.UTF-8', 08:05:29 INFO - 'LANGUAGE': 'en_US:en', 08:05:29 INFO - 'LOGNAME': 'cltbld', 08:05:29 INFO - 'MAIL': '/var/mail/cltbld', 08:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:29 INFO - 'MOZ_NO_REMOTE': '1', 08:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:29 INFO - 'NO_EM_RESTART': '1', 08:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:29 INFO - 'PWD': '/builds/slave/test', 08:05:29 INFO - 'SHELL': '/bin/bash', 08:05:29 INFO - 'SHLVL': '1', 08:05:29 INFO - 'TERM': 'linux', 08:05:29 INFO - 'TMOUT': '86400', 08:05:29 INFO - 'USER': 'cltbld', 08:05:29 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:29 INFO - '_': '/tools/buildbot/bin/python'} 08:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:30 INFO - Downloading/unpacking flake8 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:05:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:05:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:05:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:32 INFO - no previously-included directories found matching 'docs/_build' 08:05:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:05:32 INFO - Running setup.py install for pep8 08:05:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:32 INFO - no previously-included directories found matching 'docs/_build' 08:05:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:05:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:05:32 INFO - Cleaning up... 08:05:32 INFO - Return code: 0 08:05:32 INFO - Running post-action listener: _resource_record_post_action 08:05:32 INFO - Running post-action listener: _start_resource_monitoring 08:05:33 INFO - Starting resource monitoring. 08:05:33 INFO - ##### 08:05:33 INFO - ##### Finished create-virtualenv step (success) 08:05:33 INFO - ##### 08:05:33 INFO - ##### 08:05:33 INFO - ##### Running install step. 08:05:33 INFO - ##### 08:05:33 INFO - Running pre-action listener: _resource_record_pre_action 08:05:33 INFO - Running main action method: install 08:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:33 INFO - Reading from file tmpfile_stdout 08:05:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:33 INFO - Reading from file tmpfile_stdout 08:05:33 INFO - Output received: 08:05:33 INFO - Usage: mozinstall [options] installer 08:05:33 INFO - Options: 08:05:33 INFO - -h, --help show this help message and exit 08:05:33 INFO - -d DEST, --destination=DEST 08:05:33 INFO - Directory to install application into. [default: 08:05:33 INFO - "/builds/slave/test"] 08:05:33 INFO - --app=APP Application being installed. [default: firefox] 08:05:33 INFO - mkdir: /builds/slave/test/build/application 08:05:33 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'] 08:05:33 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 08:05:50 INFO - Reading from file tmpfile_stdout 08:05:50 INFO - Output received: 08:05:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:50 INFO - Running post-action listener: _resource_record_post_action 08:05:50 INFO - ##### 08:05:50 INFO - ##### Finished install step (success) 08:05:50 INFO - ##### 08:05:50 INFO - ##### 08:05:50 INFO - ##### Running run-tests step. 08:05:50 INFO - ##### 08:05:50 INFO - Running pre-action listener: _resource_record_pre_action 08:05:50 INFO - Running main action method: run_tests 08:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:50 INFO - Python 2.7.3 08:05:50 INFO - Return code: 0 08:05:50 INFO - grabbing minidump binary from tooltool 08:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:50 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 0x261e9c0>, '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 0x261f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:50 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 08:05:50 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 08:05:50 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 08:05:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:50 INFO - Return code: 0 08:05:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:05:51 INFO - Return code: 0 08:05:51 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/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 08:05:51 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/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 08:05:51 INFO - Using env: {'DISPLAY': ':0', 08:05:51 INFO - 'HOME': '/home/cltbld', 08:05:51 INFO - 'LANG': 'en_US.UTF-8', 08:05:51 INFO - 'LANGUAGE': 'en_US:en', 08:05:51 INFO - 'LOGNAME': 'cltbld', 08:05:51 INFO - 'MAIL': '/var/mail/cltbld', 08:05:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:51 INFO - 'MOZ_NO_REMOTE': '1', 08:05:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:51 INFO - 'NO_EM_RESTART': '1', 08:05:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:51 INFO - 'PWD': '/builds/slave/test', 08:05:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:51 INFO - 'SHELL': '/bin/bash', 08:05:51 INFO - 'SHLVL': '1', 08:05:51 INFO - 'TERM': 'linux', 08:05:51 INFO - 'TMOUT': '86400', 08:05:51 INFO - 'USER': 'cltbld', 08:05:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435', 08:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:51 INFO - '_': '/tools/buildbot/bin/python'} 08:05:51 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/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 08:05:51 INFO - mozversion application_buildid: 20160530053004 08:05:51 INFO - mozversion application_changeset: 00dccad34edae14b16de663c884a36ef2ec575b4 08:05:51 INFO - mozversion application_display_name: Nightly 08:05:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:51 INFO - mozversion application_name: Firefox 08:05:51 INFO - mozversion application_remotingname: firefox 08:05:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:05:51 INFO - mozversion application_vendor: Mozilla 08:05:51 INFO - mozversion application_version: 49.0a1 08:05:51 INFO - mozversion platform_buildid: 20160530053004 08:05:51 INFO - mozversion platform_changeset: 00dccad34edae14b16de663c884a36ef2ec575b4 08:05:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:05:51 INFO - mozversion platform_version: 49.0a1 08:05:51 INFO - using testdate: 1464620751 08:05:51 INFO - actual date: 1464620751 08:05:51 INFO - starting webserver on 'localhost:58584' 08:05:51 INFO - SUITE-START | Running 2 tests 08:05:51 INFO - TEST-START | dromaeo_css 08:05:51 INFO - operating with platform_type : linux_ 08:05:51 INFO - Initialising browser for dromaeo_css test... 08:05:51 INFO - TEST-INFO | started process 27702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFiH9SF/profile http://localhost:58584/getInfo.html) 08:05:55 INFO - PROCESS | 27702 | __metrics Screen width/height:1600/1200 08:05:55 INFO - PROCESS | 27702 | colorDepth:24 08:05:55 INFO - PROCESS | 27702 | Browser inner width/height: 1024/697 08:05:55 INFO - PROCESS | 27702 | __metrics 08:05:56 ERROR - PROCESS | 27702 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:05:57 INFO - TEST-INFO | 27702: exit 0 08:05:57 INFO - Browser initialized. 08:05:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:57 INFO - TEST-INFO | started process 27784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFiH9SF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:09 INFO - PROCESS | 27784 | RSS: Main: 155844608 08:06:09 INFO - PROCESS | 27784 | 08:07:00 INFO - PROCESS | 27784 | 1464620820289 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] 08:09:08 INFO - PROCESS | 27784 | Cycle 1(1): loaded http://localhost:58584/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58584/tests/dromaeo/cssquery-ext.html) 08:09:09 INFO - PROCESS | 27784 | RSS: Main: 280641536 08:09:09 INFO - PROCESS | 27784 | 08:12:11 INFO - PROCESS | 27784 | Cycle 1(1): loaded http://localhost:58584/tests/dromaeo/cssquery-ext.html (next: http://localhost:58584/tests/dromaeo/cssquery-jquery.html) 08:12:12 INFO - PROCESS | 27784 | RSS: Main: 243589120 08:12:12 INFO - PROCESS | 27784 | 08:15:14 INFO - PROCESS | 27784 | Cycle 1(1): loaded http://localhost:58584/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58584/tests/dromaeo/cssquery-mootools.html) 08:15:14 INFO - PROCESS | 27784 | RSS: Main: 249298944 08:15:14 INFO - PROCESS | 27784 | 08:18:16 INFO - PROCESS | 27784 | Cycle 1(1): loaded http://localhost:58584/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58584/tests/dromaeo/cssquery-prototype.html) 08:18:17 INFO - PROCESS | 27784 | RSS: Main: 244572160 08:18:17 INFO - PROCESS | 27784 | 08:21:20 INFO - PROCESS | 27784 | Cycle 1(1): loaded http://localhost:58584/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58584/tests/dromaeo/cssquery-yui.html) 08:21:20 INFO - PROCESS | 27784 | RSS: Main: 200306688 08:21:20 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | Cycle 1(1): loaded http://localhost:58584/tests/dromaeo/cssquery-yui.html (next: http://localhost:58584/tests/dromaeo/cssquery-dojo.html) 08:24:23 INFO - PROCESS | 27784 | RSS: Main: 286928896 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | __start_tp_report 08:24:23 INFO - PROCESS | 27784 | _x_x_mozilla_page_load 08:24:23 INFO - PROCESS | 27784 | _x_x_mozilla_page_load_details 08:24:23 INFO - PROCESS | 27784 | |i|pagename|runs| 08:24:23 INFO - PROCESS | 27784 | |0;dojo.html;3180.8409579521026;3184.3631273745254;3199.3441344524376;3221.0175896351634;3236.093893709762;5272.92090618641;5360.035193665139;5478.233047373371;5562.749676264568;5587.580931430144;5342.786288548463;5348.438413966526;5493.7802487900535;5509.228707980886;5551.750171242294;4802.687825291345;4871.512848715136;4884.438289596706;4893.632977526682;5136.8972620547565;5000;5063.898722025558;5070.340855688755;5088.974555127219;5131.076406246874;4885.7312847793355;4956.876078098058;4969;4996;5010.398752149747;4922.433920099199;4927.852164435073;4932.112219800434;4939.53074457926;4998.40019197695;4949.975250123763;4976.129177393977;4984.451710311862;4996.975015124901;5025.949740502585;5231.555317797992;5267.920981185285;5405.594580406485;5466;5478.123500239943;5957.285125784891;5963.493103086243;5975.701214939279;5988.880222395571;5989.610675306091;6019.879602407971;6027.126066720345;6035.366286539938;6040.0939859021055;6042.972694641921;5351.866203344908;5459.69971651559;5505.3393592768325;5505.862353441116;5611.803586874481;6068.060272280922;6070.265262822343;6071.280667002622;6072.15346042105;6074.65454327936;5846.970765146232;5866.472017518444;5869.941300587025;5883.470487656132;5890.352061273256;5686.914696279559;5865.941340586625;5891;5906.557008224315;5988.131720900445;5870.794522191788;5904.350521442638;5904.763809447574;5913.970430147821;5920.822375328747;5881.294244690579;5928.525717942554;5938.2280303560265;5941.643501389931;5945.405459454107;4378.64970802335;4407.118576284692;4411.9558804411545;4468.352088947085;4493.775311234425;3992.580779018161;4000.7199496035;4010.498687664042;4042.9797851011144;4068.9796551017057;5652.85867853307;5663.235463212413;5666.206731057655;5674.943250567441;5715.971420142872;5684.8010319638615;5857.912131318034;5885.970570147122;5888.676122813286;5959.255093113361;5616.522595579339;5622.100463925753;5623.775048997994;5629.211910332557;5638.069718496402;5116.56509196715;5130.820421285312;5136.5890728741615;5140.254663073833;5186.40356359016;5908.675022873783;6112.047575716847;6121.5139442231075;6122.632642041492;6178.104174894615;5952.940470595412;5987.491063259497;5989.760409583568;5991.101334799815;6027.939720602738;5810.157527158453;6137.693115344304;6158.784442544489;6159.168512250968;6160.16837726919;5759.769609215752;5788.131780232999;5799.420057994167;5823.94176058234;5880.882382352414;5888.528917686489;5921.733521991435;5928.2293301872205;5935.762569497345;5948.910766338595;5620.971895140498;5832.387599302012;5840.532757379315;5844.181814545882;5848.883022339614;5728.140778883034;5728.255326807488;5729.1119876419225;5775.9133612996675;5777.884442311214;5634.52106570946;5636.746346414503;5639.887202256014;5641.8589535261945;5646.802361917313;5610.102383618601;5758.971205143947;5764.308283006066;5810.244668193108;5810.854728631818;5675.0636145035605;5697.6296540724725;5709.457601527848;5727.6849773262875;5766.135079738073 08:24:23 INFO - PROCESS | 27784 | |1;ext.html;571.6055921414223;626.793158257775;628.0986783965011;630.3633330336359;639.5619000984324;31745;32244;43616.56383436161;44502;44672.32991505122;42391.15217695644;45772.3134152988;46225.30662040064;46278.07443851129;46309;8777.16616921393;8997.640094396216;9000.414973026765;9004.189622933935;9005.099490050976;8797.692080777175;8951.283897288235;8955.37312388133;8958.28333733303;8962.910370896305;8982.595783189772;9059.094090590954;9061.184493395593;9061.957874844378;9066.365354425192;8914.777130571723;8977.775555611097;8981.506017169053;8990.370674052754;8991.955040224822;8831.735047948572;8901.688440904538;8916.910830891673;8917.108289171096;8920.776980575472;42694.35958460625;43137.568624313986;43241.351379729014;43247.78376108131;43264.35103473451;3733.831977561016;3806.695464362844;4111.6093971073;4171.436856024428;4240.279152544075;32624.6737532624;32845.343093138006;33051.3389732204;33061;33350.33299334024;4432.977835110803;4467.843625473125;4514.774261286922;4632;4654.557817007379;249777;252150;253142;253256.7337163321;254114;59904.70047649734;59942;60312.69843650753;60350.69824650849;60369.698151508965;62642;63002.36997629965;63073.369266307665;63084.68457657682;63108.05337919935;15773.132477713836;15922.920385397998;15937.601559961095;15943;15988.600284992735;12218;12259.448324825225;12281.815772763415;12282.447289871798;12282.508699651913;16705.498835034967;18268.90865545664;18433.446996590123;18483.075846207907;18513.90743046276;5768.307803063659;5780.21967034445;5904.077481646526;5916.556258280646;6010.9699451502465;994.955227014786;1057.4765491081964;1128.041165009735;1138.6014894786758;1142.440204299887;32545.674543254263;32792.67207327944;32815.343693126;33188.83405582957;33545.161370965434;1122.169594500064;1132.7111586545377;1139.515705825021;1146.1060372909144;1198.1672737447564;16822.24299906507;17094.658106838044;17098.743518847226;17359.785202863863;17456.30174792994;559256;565102;565401;566248;568567;59552.70223648941;59659;59660;59693;59719.402805972255;1248.7689777391213;1364.6110858405505;1381.1367895065584;1394.6792237785367;1412.4773833681397;32723.67276327206;34027.4895876567;34297.82851085729;34314.82842585771;34655;50830.74584627053;51091;51396.48603514067;51424.48575514197;51472.48527514677;393473;395734;395837;396240;396526;34246.828765856015;35538.46692299669;41951.58048419477;42543.53292904324;42879;47981.76009119932;48246.517534824205;48613;48669.756651216514;48887;38067.42898856464;41677.1664566713;41999.58000419957;42132.78933605312;42224;40898.59101408948;41049.384259235536;41251.793741031106;42256.36615450709;42275.15449690927;40119.598804011584;40672.38991415191;41056.58943410528;41742.58257417508;44881.55118448774;34482.65517344794;37458.87623371303;37739.81130094332;39034.804825976826;39342.62699817928;27566.862165689847;27794;27845.86077069683;27867.16398508048;28108.578371324038 08:24:23 INFO - PROCESS | 27784 | |2;jquery.html;394.49307639683;411.2166323154392;412.16330848377805;418.69226118802675;427.480611057565;13947.930260348685;17889.373871914486;20010.69983950242;20011.999400029996;20027.899860500696;14503.41986320546;18445.7233141503;18581.53546161347;19042.2383104676;19669.606607867834;5675.3757086720425;5774.97112514439;5815.941840581603;5819.156222347779;5874.412558744113;5775.884482310351;5789.131630255474;5822.068469044953;5832.445917637818;5840.707964601753;4318.07161460286;4508.774561271924;5711.514521265697;6344;6351.269603995554;6365.61806291624;6414.999999999976;6426.1003459515705;6479.416852483276;6481.41667249945;5554.222408862763;5680.517156041741;5689.516391106761;5691.544676425876;5726.026575482178;23215.88392058029;23299.301020969397;23565.29304120879;24027.50226104153;24288.878555607287;2390.6653068570413;2437.9390515237083;2495.75042495749;2519.7354277800932;3134.2164458885277;15093;15765.975211611209;15899.581589958214;16068.678626427523;16749.078800665957;1902.7156669248202;1984;1989.2142603671468;2056.9177232910665;2092.8221101206414;74628.62685686591;77892.61053694753;83453;87040;87514;16843.663126737396;17716.645667086585;17782.39958403724;17808.732869006973;18312.90843545774;32111.197220069684;32331.51502727461;32336.353272934408;32345;32687.58717573145;9600.471974041495;9692.41845489273;9796.069373409515;10084.74788130288;10101.898981010243;7976.5612891290375;8006.279434850775;8166;8304.875426868603;8356.874646880302;7436.879262893409;8655.836040989752;9075.319351048698;9276.536173191313;9338.90661093394;3520.5247291615815;3585.659362360572;3600.837962291703;3628.63713628635;3719.34911390511;901.8016036471965;959.3231111464148;986.1765425869336;1013.614826365991;1113.2930589075834;18851.52871178204;19507.02464876779;19531.804681953;19617;19630.90184549068;962.3504134709043;1006.059334522224;1012.1447376966452;1017.8167929772563;1022.8721409823772;10822.40476773785;10829.783404332027;10892.183086268562;11057.889421105687;11058.060064894413;413526;423678;427390;429145;447407;92308;94527;94713.52643236739;94973;95640.52179739057;991.8561808537721;1025.1286406554518;1034.4724190662666;1050.3225419604312;1056.3186744549723;16373.345066197218;17179;17296.91351543234;17315.91342043282;17968.820311796713;34171.65828341685;37863.81068094642;40851.182976340904;42828;42922.35616465693;53876.19185712296;55370.44629553814;56390.43609563852;56609.433905660415;57469.8277155058;8186.918130818854;8225.71210007647;8234.876476852973;8244.628991695268;8459.83080338402;9114.954425227832;10026.147777438999;12765.808512872129;13028.28344441027;13032.283224422748;10820.350778953289;10888.346699198073;11096.33421994683;11119.888801111885;11253.099752019654;11349.205555611028;11392.43037848121;11499.94250028778;11570.537178512765;11675.182737208313;11619.128565357802;11680.824787628022;11793.233439826385;11802.52789888395;11993.64019079429;8066.1127275998415;8146.959265203636;8406.747797566082;8444.746657600283;8499.32005439551;8394.607536851969;11626.82559761621;11679.649610511698;11685.298882067103;11737.119716021161 08:24:23 INFO - PROCESS | 27784 | |3;mootools.html;1367.5418734723867;1527.61045933287;1541.8072740907385;1702.1914590569472;1859.0890463672797;8611.612477438515;8955.910440895588;8962.193402593773;9237.861432078507;9244;8864.46813191209;9113.362064655477;9115.908840911605;9119.179273865351;9119.863202051974;2037.7962203779578;2274.317704688595;2331.5686597979384;2342.8125749939963;2363.1020212319295;2377.6671266022686;2387.5821731197057;2389.354874183978;2391.0316321889663;2393.0547433763654;2279.908803647852;2321.9303420897318;2323.442373830277;2323.663068855015;2323.8140948724063;1922.9423117306433;2214.966775498369;2288.9084436622516;2296.2307626944994;2320.93037208884;2251.4596496840804;2258.67249248858;2265.750767415583;2268.591653502369;2306.642470417088;9048.276137909017;9174.311926605531;9214;9216.308776841697;9219.032001639798;5198.350206224222;5319.095753721838;5333.919991200135;5342.759575819097;5347.679139251619;3285.802851828898;3380.2394461246267;3423.0928803866996;3432.1076520104702;3434.9828250858836;1074.8011617850723;1083.1984331594642;1088.4884104470887;1103.2112039891515;1126.6282126898186;12796.61610151697;12844.48622055126;12856.35718214095;12859.742805143938;12865.678358041125;4760.809567617256;4860.3195552622665;4897.902041959141;4908.386451693538;4937.950620493821;10847;10868.239223254455;10896.945515272373;10902.672919812418;10908.072813810757;4787.186178349689;5544.112941929353;5549.38956714761;5557.166425036277;5558.277423934863;4902.607791376681;5004.524570165829;5021.196608542688;5070.391553013662;5070.4929507049;4092.836286548564;4100.610442008005;4189.036521600049;4214.346776249687;4222.936655950163;1264.462603393554;1283.3198404845448;1291.9547815826402;1298.9805152922713;1307.1242267680677;888.1828717579842;913.3743385780762;975.380633297861;983.4448468785432;1019.0777346501428;5806.767729290781;5936.495397891142;5975.043992961106;6007.3992600739575;6124.6325220486915;450.58095970746865;457.1474200615894;467.2430662327052;469.1461539997172;469.31480039143236;3993.684774945649;4087.4890638670167;4094.201630682048;4118.979405102956;4179.477565304337;10436.321639093434;10734.302270352402;10813.459327033617;10823.242373033812;10845.566177352817;10395.220358473145;10599.046085852311;10615.787684246272;10666.893331066745;10698;8017.278444939983;8120.431569790177;8131.552764598004;8207.220314070153;8232.753017409368;5611.971940140274;5675.858103547444;5780.161876527964;5817.76728930838;5926.762929482772;9869.654562090293;10585.576576936835;10656.307340022873;10701.929807019236;10711.571537138427;10309.793804123725;10631.255812093079;10936.671899843017;10941;10946.343219406543;6838.589684618939;7750.379969602305;7923.484973476706;8035.316998055231;8201.425900187169;8782.56087195625;8829.16122968317;8850.601722922613;8867.201951824367;8874.822503550022;7547.622618869144;7656.234376562299;7711.652975616223;7790.766277011699;8171.5505647189975;7539.962300188464;7540;7600.695972161273;7690.038745156856;7854.803629909298;7114.537555058904;7182.820429489305;7202.063731714844;7215.062041934515;7216.386607138452;5115.667481613683;5117.590592752496;5216.37403511581;5257.894842103213;5282.102042652681;5225.712585807817;5234.685918844882;5246.685198888079;5263.868403289795;5339.759710812945 08:24:23 INFO - PROCESS | 27784 | |4;prototype.html;305.9265776213709;310.78245228340165;316.13379340606735;327.70670250126153;332.99833500832494;5309.946900530994;5331.2003199520095;5403.729813509329;5415.754376493409;5432.782688692458;5332.866678333044;5337.306150200478;5341.813036543722;5341.919871201935;5353.437889021655;4161.439460202424;4162.604552567501;4168.854090106847;4170.165966806636;4175.394567787669;4052.2705912935658;4133.6693064554765;4136.400221967813;4154.916901661965;4159.232326261342;4120.877747959788;4126.154138401621;4128.256913755523;4128.855490057848;4140.275451795938;4133.524644665857;4146.419501269825;4150.7340261220315;4153.273177194009;4154.169166166779;3676.871309504181;3687.2625474904858;3692.390755525335;3698.1124530112847;3706.5552133744122;4946.2580612908;5165.380154381461;5181.300524429229;5217.634765566412;5228.816991405321;4623.861284161447;4636.814527418899;4648.768076459741;4678.415198100238;4718.764061796931;5520.309961254843;5548.55611551075;5554.944450555483;5564.415736347666;5571.997040532702;3802.619738026175;3903.960960390388;3924.6860251179837;3925.646691797723;3925.803709814498;5450.700211488366;5545.916811247875;5702.287214098238;5763.971180144073;5780.942190578083;3946.7829269389886;3973.642372186517;3979.422983667352;3983.900402489961;3996.5204175498543;3832.2910261601137;3996.002997751686;4030.1738143680477;4058.066644671742;4088.632023117934;4559.635229181657;4599.011212589309;4624.6819656397765;4636.4899861015265;4647.885212228428;5516.3380394352935;5575.944240557624;5599.552035837123;5604.915926261109;5610.915836262459;1328.2296268164441;1379.4620098161524;1381.86181381861;1382.4746596293344;1382.9585112446644;860.7331727164599;876.2508055612487;878.6221924572368;878.7846977490556;883.3816328570026;4782.689125206851;4853.277086634264;4857.635677324215;4864.637901387617;4898.68158569699;5144.485551444825;5184.377874655065;5185.429602743695;5200.453952335026;5215.6609820361555;4850.671677594703;4942;4951.232558953368;4955.578775804025;4974.353334066621;3050.7864449488325;3055.205646531918;3071.201487613192;3075.3695492424;3075.5540446635114;5922.822315330461;5932.3177834548715;5950.869334826369;5958.225430693982;5987.580869339192;5615.803446879421;5813.79651712188;5821.941780582225;5850.912236316459;5873.295204575478;5860.970695146497;5932.3982524718085;5935.673537955454;5953.4344237298255;6025.367336429699;5319.973400132974;5433.8369848904595;5707.714614269353;5742.253507044057;5763.769449221984;5022.974885125551;5645.209670646031;5661.66030038199;5691.800786972436;5706.942930570641;5887.911681324698;5888.175655408332;5908.231929849264;5913.58604897653;5951.732172052181;3959.287328280937;3972.245273398045;3990.960090399059;4006.7395619284653;4125.628693417607;5719.48524632785;5721.771129154788;5722.484976352148;5727.284089488814;5737.8565535861935;5592.3009623797025;5619.831405057855;5632.943670563406;5660.405657406078;5667.914981275367;5494.80768173112;5500.477454641803;5528.834134975958;5535.972320138373;5558.861028474321;5337.359516858002;5451.754671039892;5478.493414311097;5517.2275881377445;5539.789759782675;5391.353037635509;5573.359063707563;5573.359063707726;5581;5583.972080139573;5461.235427040138;5551.22282880389;5569.554435645057;5571.526420254162;5596.916046259391 08:24:23 INFO - PROCESS | 27784 | |5;yui.html;761.5088268067096;787.9251471110242;819.1562690428858;833.62903507939;862.1637012098263;15392.769108463368;15710.293036813342;15733.213339333017;15735.370585176594;15747.448839290613;13957.371918263678;14016.22910739909;14074.577762667112;14101.294935253221;14108.365123569438;812.5530957973135;819.8319344534356;820.1716266570747;821.4126899267023;821.6179476543406;662.1127688896877;788.3771820262015;810.6878851642131;817.0073360866546;820.2576668115365;847.063994286311;853.3173461231021;855.110684887716;856.8886044814196;857.6783706110209;684.6063513479719;853.1766844994548;854.8162145138793;855.589317127779;856.2251162697737;608.6591508755112;616.7502161624504;617.5306766857221;624.4660815003152;624.8781487609917;13942.23317717525;14039.157650541;14060.718785624333;14061.086029408056;14072.507462238773;12776;13189.73620527584;13210;13263.668408289774;13564.186148831102;11874.643760687193;12166.756664866742;12312.13815032948;12482.687932801753;12820.358982050953;4361.694681372305;4434.2905135178535;4459.910801783946;4647.000894807633;4649.95350046502;60134;61132.38867611267;61287.69356153191;61393.38606613966;61634.69182654103;9926.900730992598;9995.891963591943;10011.749706257402;10040.66374364942;10202.591896324064;17343.56641083983;17348.566285842953;17365.392211272545;17378.304867805145;17488.300467981393;8200.753977380688;8279.958600207081;8506.064332923374;8645.567721613894;8856.335774816915;4699.929501057487;4759.643026773006;4816.759162041954;4865.343178670834;4886.902261954741;3330.1841048943165;3436.8281585920604;3447.2760720248525;3449.379111759857;3453.8963831085107;607.2470137030051;611.9479844213291;613.0191693290789;646.0857886091222;653.7907869481816;620.6183197333607;622.4988883948465;709.7019251914209;711.729542773753;718.7843646905907;8825.91174088251;9126.224270936911;9172.816543669089;9291.953540232256;9385.812283754423;739.8298291819634;755.3315315945318;759.787259567311;779.0923574036184;803.0644299391143;4431.180231657154;4545.136424079415;4652.232381656989;4655.2784318430695;4660.440747110369;64898.67550662311;69587.65206173937;69706.65146674235;70085;70106.29893700998;61257.69371153116;62807.6859615699;62909.37090629127;63339.36660633427;63791.681041595424;50576.24135637969;52011.479885200664;55543.722281388335;55876;56102.719486402304;8837.690680826398;8863.512506812187;8963.372563920462;9265.814683706423;9341.953290233505;36825.447618286285;36832.44751328679;37221.25557488781;37256.81371593125;37470.250594988494;24170.154044608353;24499.63250551279;24602.138925137533;24638.13766518163;39165.412518811674;11785.587504437304;11913.880861191277;12428.81356779631;12701.185649129295;13277.507788161995;12832.871671283541;13657.248851312876;13733.244671543162;13889.861101388857;14022.088564243291;12654.430550625428;12699.111062225555;12759.93620031894;12765.808512872129;13311.267880266678;12871.806922896352;13141;13239.86760132425;13544.525941591997;13591.45634174622;11725.35510546894;11923.701907452383;11951.103667225167;12061.155719099579;12084.577039803564;9547.952260238655;9625.278104142077;9865.161461275586;10209.030142136486;10325.277230593787;9804.705858824247;9998.20014398861;10460.790784184426;10899;10934.617288395186 08:24:23 INFO - PROCESS | 27784 | __end_tp_report 08:24:23 INFO - PROCESS | 27784 | __start_cc_report 08:24:23 INFO - PROCESS | 27784 | _x_x_mozilla_cycle_collect,1081 08:24:23 INFO - PROCESS | 27784 | __end_cc_report 08:24:23 INFO - PROCESS | 27784 | __startTimestamp1464621863839__endTimestamp 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | ------- Summary: start ------- 08:24:23 INFO - PROCESS | 27784 | Number of tests: 6 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | [#0] dojo.html Cycles:165 Average:5478.71 Median:5684.80 stddev:637.91 (11.2%) stddev-sans-first:613.87 08:24:23 INFO - PROCESS | 27784 | Values: 3180.8 3184.4 3199.3 3221.0 3236.1 5272.9 5360.0 5478.2 5562.7 5587.6 5342.8 5348.4 5493.8 5509.2 5551.8 4802.7 4871.5 4884.4 4893.6 5136.9 5000.0 5063.9 5070.3 5089.0 5131.1 4885.7 4956.9 4969.0 4996.0 5010.4 4922.4 4927.9 4932.1 4939.5 4998.4 4950.0 4976.1 4984.5 4997.0 5025.9 5231.6 5267.9 5405.6 5466.0 5478.1 5957.3 5963.5 5975.7 5988.9 5989.6 6019.9 6027.1 6035.4 6040.1 6043.0 5351.9 5459.7 5505.3 5505.9 5611.8 6068.1 6070.3 6071.3 6072.2 6074.7 5847.0 5866.5 5869.9 5883.5 5890.4 5686.9 5865.9 5891.0 5906.6 5988.1 5870.8 5904.4 5904.8 5914.0 5920.8 5881.3 5928.5 5938.2 5941.6 5945.4 4378.6 4407.1 4412.0 4468.4 4493.8 3992.6 4000.7 4010.5 4043.0 4069.0 5652.9 5663.2 5666.2 5674.9 5716.0 5684.8 5857.9 5886.0 5888.7 5959.3 5616.5 5622.1 5623.8 5629.2 5638.1 5116.6 5130.8 5136.6 5140.3 5186.4 5908.7 6112.0 6121.5 6122.6 6178.1 5952.9 5987.5 5989.8 5991.1 6027.9 5810.2 6137.7 6158.8 6159.2 6160.2 5759.8 5788.1 5799.4 5823.9 5880.9 5888.5 5921.7 5928.2 5935.8 5948.9 5621.0 5832.4 5840.5 5844.2 5848.9 5728.1 5728.3 5729.1 5775.9 5777.9 5634.5 5636.7 5639.9 5641.9 5646.8 5610.1 5759.0 5764.3 5810.2 5810.9 5675.1 5697.6 5709.5 5727.7 5766.1 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | [#1] ext.html Cycles:180 Average:57765.30 Median:42265.76 stddev:112690.83 (266.6%) stddev-sans-first:112925.14 08:24:23 INFO - PROCESS | 27784 | Values: 571.6 626.8 628.1 630.4 639.6 31745.0 32244.0 43616.6 44502.0 44672.3 42391.2 45772.3 46225.3 46278.1 46309.0 8777.2 8997.6 9000.4 9004.2 9005.1 8797.7 8951.3 8955.4 8958.3 8962.9 8982.6 9059.1 9061.2 9062.0 9066.4 8914.8 8977.8 8981.5 8990.4 8992.0 8831.7 8901.7 8916.9 8917.1 8920.8 42694.4 43137.6 43241.4 43247.8 43264.4 3733.8 3806.7 4111.6 4171.4 4240.3 32624.7 32845.3 33051.3 33061.0 33350.3 4433.0 4467.8 4514.8 4632.0 4654.6 249777.0 252150.0 253142.0 253256.7 254114.0 59904.7 59942.0 60312.7 60350.7 60369.7 62642.0 63002.4 63073.4 63084.7 63108.1 15773.1 15922.9 15937.6 15943.0 15988.6 12218.0 12259.4 12281.8 12282.4 12282.5 16705.5 18268.9 18433.4 18483.1 18513.9 5768.3 5780.2 5904.1 5916.6 6011.0 995.0 1057.5 1128.0 1138.6 1142.4 32545.7 32792.7 32815.3 33188.8 33545.2 1122.2 1132.7 1139.5 1146.1 1198.2 16822.2 17094.7 17098.7 17359.8 17456.3 559256.0 565102.0 565401.0 566248.0 568567.0 59552.7 59659.0 59660.0 59693.0 59719.4 1248.8 1364.6 1381.1 1394.7 1412.5 32723.7 34027.5 34297.8 34314.8 34655.0 50830.7 51091.0 51396.5 51424.5 51472.5 393473.0 395734.0 395837.0 396240.0 396526.0 34246.8 35538.5 41951.6 42543.5 42879.0 47981.8 48246.5 48613.0 48669.8 48887.0 38067.4 41677.2 41999.6 42132.8 42224.0 40898.6 41049.4 41251.8 42256.4 42275.2 40119.6 40672.4 41056.6 41742.6 44881.6 34482.7 37458.9 37739.8 39034.8 39342.6 27566.9 27794.0 27845.9 27867.2 28108.6 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | [#2] jquery.html Cycles:180 Average:28199.85 Median:18846.09 stddev:70937.71 (376.4%) stddev-sans-first:71105.99 08:24:23 INFO - PROCESS | 27784 | Values: 394.5 411.2 412.2 418.7 427.5 13947.9 17889.4 20010.7 20012.0 20027.9 14503.4 18445.7 18581.5 19042.2 19669.6 5675.4 5775.0 5815.9 5819.2 5874.4 5775.9 5789.1 5822.1 5832.4 5840.7 4318.1 4508.8 5711.5 6344.0 6351.3 6365.6 6415.0 6426.1 6479.4 6481.4 5554.2 5680.5 5689.5 5691.5 5726.0 23215.9 23299.3 23565.3 24027.5 24288.9 2390.7 2437.9 2495.8 2519.7 3134.2 15093.0 15766.0 15899.6 16068.7 16749.1 1902.7 1984.0 1989.2 2056.9 2092.8 74628.6 77892.6 83453.0 87040.0 87514.0 16843.7 17716.6 17782.4 17808.7 18312.9 32111.2 32331.5 32336.4 32345.0 32687.6 9600.5 9692.4 9796.1 10084.7 10101.9 7976.6 8006.3 8166.0 8304.9 8356.9 7436.9 8655.8 9075.3 9276.5 9338.9 3520.5 3585.7 3600.8 3628.6 3719.3 901.8 959.3 986.2 1013.6 1113.3 18851.5 19507.0 19531.8 19617.0 19630.9 962.4 1006.1 1012.1 1017.8 1022.9 10822.4 10829.8 10892.2 11057.9 11058.1 413526.0 423678.0 427390.0 429145.0 447407.0 92308.0 94527.0 94713.5 94973.0 95640.5 991.9 1025.1 1034.5 1050.3 1056.3 16373.3 17179.0 17296.9 17315.9 17968.8 34171.7 37863.8 40851.2 42828.0 42922.4 53876.2 55370.4 56390.4 56609.4 57469.8 8186.9 8225.7 8234.9 8244.6 8459.8 9115.0 10026.1 12765.8 13028.3 13032.3 10820.4 10888.3 11096.3 11119.9 11253.1 11349.2 11392.4 11499.9 11570.5 11675.2 11619.1 11680.8 11793.2 11802.5 11993.6 8066.1 8147.0 8406.7 8444.7 8499.3 8394.6 11626.8 11679.6 11685.3 11737.1 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | [#3] mootools.html Cycles:180 Average:5894.07 Median:4774.00 stddev:3415.46 (71.5%) stddev-sans-first:3408.10 08:24:23 INFO - PROCESS | 27784 | Values: 1367.5 1527.6 1541.8 1702.2 1859.1 8611.6 8955.9 8962.2 9237.9 9244.0 8864.5 9113.4 9115.9 9119.2 9119.9 2037.8 2274.3 2331.6 2342.8 2363.1 2377.7 2387.6 2389.4 2391.0 2393.1 2279.9 2321.9 2323.4 2323.7 2323.8 1922.9 2215.0 2288.9 2296.2 2320.9 2251.5 2258.7 2265.8 2268.6 2306.6 9048.3 9174.3 9214.0 9216.3 9219.0 5198.4 5319.1 5333.9 5342.8 5347.7 3285.8 3380.2 3423.1 3432.1 3435.0 1074.8 1083.2 1088.5 1103.2 1126.6 12796.6 12844.5 12856.4 12859.7 12865.7 4760.8 4860.3 4897.9 4908.4 4938.0 10847.0 10868.2 10896.9 10902.7 10908.1 4787.2 5544.1 5549.4 5557.2 5558.3 4902.6 5004.5 5021.2 5070.4 5070.5 4092.8 4100.6 4189.0 4214.3 4222.9 1264.5 1283.3 1292.0 1299.0 1307.1 888.2 913.4 975.4 983.4 1019.1 5806.8 5936.5 5975.0 6007.4 6124.6 450.6 457.1 467.2 469.1 469.3 3993.7 4087.5 4094.2 4119.0 4179.5 10436.3 10734.3 10813.5 10823.2 10845.6 10395.2 10599.0 10615.8 10666.9 10698.0 8017.3 8120.4 8131.6 8207.2 8232.8 5612.0 5675.9 5780.2 5817.8 5926.8 9869.7 10585.6 10656.3 10701.9 10711.6 10309.8 10631.3 10936.7 10941.0 10946.3 6838.6 7750.4 7923.5 8035.3 8201.4 8782.6 8829.2 8850.6 8867.2 8874.8 7547.6 7656.2 7711.7 7790.8 8171.6 7540.0 7540.0 7600.7 7690.0 7854.8 7114.5 7182.8 7202.1 7215.1 7216.4 5115.7 5117.6 5216.4 5257.9 5282.1 5225.7 5234.7 5246.7 5263.9 5339.8 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | [#4] prototype.html Cycles:180 Average:4634.80 Median:5269.38 stddev:1375.11 (26.1%) stddev-sans-first:1340.04 08:24:23 INFO - PROCESS | 27784 | Values: 305.9 310.8 316.1 327.7 333.0 5309.9 5331.2 5403.7 5415.8 5432.8 5332.9 5337.3 5341.8 5341.9 5353.4 4161.4 4162.6 4168.9 4170.2 4175.4 4052.3 4133.7 4136.4 4154.9 4159.2 4120.9 4126.2 4128.3 4128.9 4140.3 4133.5 4146.4 4150.7 4153.3 4154.2 3676.9 3687.3 3692.4 3698.1 3706.6 4946.3 5165.4 5181.3 5217.6 5228.8 4623.9 4636.8 4648.8 4678.4 4718.8 5520.3 5548.6 5554.9 5564.4 5572.0 3802.6 3904.0 3924.7 3925.6 3925.8 5450.7 5545.9 5702.3 5764.0 5780.9 3946.8 3973.6 3979.4 3983.9 3996.5 3832.3 3996.0 4030.2 4058.1 4088.6 4559.6 4599.0 4624.7 4636.5 4647.9 5516.3 5575.9 5599.6 5604.9 5610.9 1328.2 1379.5 1381.9 1382.5 1383.0 860.7 876.3 878.6 878.8 883.4 4782.7 4853.3 4857.6 4864.6 4898.7 5144.5 5184.4 5185.4 5200.5 5215.7 4850.7 4942.0 4951.2 4955.6 4974.4 3050.8 3055.2 3071.2 3075.4 3075.6 5922.8 5932.3 5950.9 5958.2 5987.6 5615.8 5813.8 5821.9 5850.9 5873.3 5861.0 5932.4 5935.7 5953.4 6025.4 5320.0 5433.8 5707.7 5742.3 5763.8 5023.0 5645.2 5661.7 5691.8 5706.9 5887.9 5888.2 5908.2 5913.6 5951.7 3959.3 3972.2 3991.0 4006.7 4125.6 5719.5 5721.8 5722.5 5727.3 5737.9 5592.3 5619.8 5632.9 5660.4 5667.9 5494.8 5500.5 5528.8 5536.0 5558.9 5337.4 5451.8 5478.5 5517.2 5539.8 5391.4 5573.4 5573.4 5581.0 5584.0 5461.2 5551.2 5569.6 5571.5 5596.9 08:24:23 INFO - PROCESS | 27784 | 08:24:23 INFO - PROCESS | 27784 | [#5] yui.html Cycles:180 Average:15092.78 Median:4841.05 stddev:18337.75 (378.8%) stddev-sans-first:18357.61 08:24:23 INFO - PROCESS | 27784 | Values: 761.5 787.9 819.2 833.6 862.2 15392.8 15710.3 15733.2 15735.4 15747.4 13957.4 14016.2 14074.6 14101.3 14108.4 812.6 819.8 820.2 821.4 821.6 662.1 788.4 810.7 817.0 820.3 847.1 853.3 855.1 856.9 857.7 684.6 853.2 854.8 855.6 856.2 608.7 616.8 617.5 624.5 624.9 13942.2 14039.2 14060.7 14061.1 14072.5 12776.0 13189.7 13210.0 13263.7 13564.2 11874.6 12166.8 12312.1 12482.7 12820.4 4361.7 4434.3 4459.9 4647.0 4650.0 60134.0 61132.4 61287.7 61393.4 61634.7 9926.9 9995.9 10011.7 10040.7 10202.6 17343.6 17348.6 17365.4 17378.3 17488.3 8200.8 8280.0 8506.1 8645.6 8856.3 4699.9 4759.6 4816.8 4865.3 4886.9 3330.2 3436.8 3447.3 3449.4 3453.9 607.2 611.9 613.0 646.1 653.8 620.6 622.5 709.7 711.7 718.8 8825.9 9126.2 9172.8 9292.0 9385.8 739.8 755.3 759.8 779.1 803.1 4431.2 4545.1 4652.2 4655.3 4660.4 64898.7 69587.7 69706.7 70085.0 70106.3 61257.7 62807.7 62909.4 63339.4 63791.7 50576.2 52011.5 55543.7 55876.0 56102.7 8837.7 8863.5 8963.4 9265.8 9342.0 36825.4 36832.4 37221.3 37256.8 37470.3 24170.2 24499.6 24602.1 24638.1 39165.4 11785.6 11913.9 12428.8 12701.2 13277.5 12832.9 13657.2 13733.2 13889.9 14022.1 12654.4 12699.1 12759.9 12765.8 13311.3 12871.8 13141.0 13239.9 13544.5 13591.5 11725.4 11923.7 11951.1 12061.2 12084.6 9548.0 9625.3 9865.2 10209.0 10325.3 9804.7 9998.2 10460.8 10899.0 10934.6 08:24:23 INFO - PROCESS | 27784 | -------- Summary: end -------- 08:24:23 INFO - PROCESS | 27784 | 08:24:24 INFO - TEST-INFO | 27784: exit 0 08:24:24 INFO - TEST-OK | dromaeo_css | took 1113350ms 08:24:24 INFO - TEST-START | kraken 08:24:24 INFO - operating with platform_type : linux_ 08:24:24 INFO - Initialising browser for kraken test... 08:24:24 INFO - TEST-INFO | started process 27965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32y5zS/profile http://localhost:58584/getInfo.html) 08:24:28 INFO - PROCESS | 27965 | __metrics Screen width/height:1600/1200 08:24:28 INFO - PROCESS | 27965 | colorDepth:24 08:24:28 INFO - PROCESS | 27965 | Browser inner width/height: 1024/697 08:24:28 INFO - PROCESS | 27965 | __metrics 08:24:29 ERROR - PROCESS | 27965 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:24:30 INFO - TEST-INFO | 27965: exit 0 08:24:30 INFO - Browser initialized. 08:24:30 INFO - Running cycle 1/1 for kraken test... 08:24:30 INFO - TEST-INFO | started process 28048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32y5zS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:42 INFO - PROCESS | 28048 | RSS: Main: 155242496 08:24:42 INFO - PROCESS | 28048 | 08:24:44 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58584/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:45 INFO - PROCESS | 28048 | RSS: Main: 213938176 08:24:45 INFO - PROCESS | 28048 | 08:24:48 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58584/tests/kraken/driver.html?testName=audio-dft) 08:24:48 INFO - PROCESS | 28048 | RSS: Main: 198352896 08:24:48 INFO - PROCESS | 28048 | 08:24:51 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58584/tests/kraken/driver.html?testName=audio-fft) 08:24:52 INFO - PROCESS | 28048 | RSS: Main: 268943360 08:24:52 INFO - PROCESS | 28048 | 08:24:54 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58584/tests/kraken/driver.html?testName=audio-oscillator) 08:24:55 INFO - PROCESS | 28048 | RSS: Main: 179212288 08:24:55 INFO - PROCESS | 28048 | 08:24:57 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58584/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:58 INFO - PROCESS | 28048 | RSS: Main: 183537664 08:24:58 INFO - PROCESS | 28048 | 08:25:01 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58584/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:01 INFO - PROCESS | 28048 | RSS: Main: 219803648 08:25:01 INFO - PROCESS | 28048 | 08:25:05 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58584/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:05 INFO - PROCESS | 28048 | RSS: Main: 220774400 08:25:05 INFO - PROCESS | 28048 | 08:25:08 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58584/tests/kraken/driver.html?testName=json-parse-financial) 08:25:09 INFO - PROCESS | 28048 | RSS: Main: 220925952 08:25:09 INFO - PROCESS | 28048 | 08:25:10 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58584/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:11 INFO - PROCESS | 28048 | RSS: Main: 209051648 08:25:11 INFO - PROCESS | 28048 | 08:25:12 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:13 INFO - PROCESS | 28048 | RSS: Main: 209915904 08:25:13 INFO - PROCESS | 28048 | 08:25:15 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:16 INFO - PROCESS | 28048 | RSS: Main: 216039424 08:25:16 INFO - PROCESS | 28048 | 08:25:18 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:19 INFO - PROCESS | 28048 | RSS: Main: 222777344 08:25:19 INFO - PROCESS | 28048 | 08:25:22 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:22 INFO - PROCESS | 28048 | RSS: Main: 222228480 08:25:22 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:58584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58584/tests/kraken/driver.html?testName=ai-astar) 08:25:24 INFO - PROCESS | 28048 | RSS: Main: 263618560 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | __start_tp_report 08:25:24 INFO - PROCESS | 28048 | _x_x_mozilla_page_load 08:25:24 INFO - PROCESS | 28048 | _x_x_mozilla_page_load_details 08:25:24 INFO - PROCESS | 28048 | |i|pagename|runs| 08:25:24 INFO - PROCESS | 28048 | |0;ai-astar;111;105;109;110;109;110;111;109;111;110 08:25:24 INFO - PROCESS | 28048 | |1;audio-beat-detection;147;124;126;190;127;128;150;125;175;128 08:25:24 INFO - PROCESS | 28048 | |2;audio-dft;161;161;159;161;160;161;163;159;161;162 08:25:24 INFO - PROCESS | 28048 | |3;audio-fft;75;75;76;127;74;75;72;74;100;74 08:25:24 INFO - PROCESS | 28048 | |4;audio-oscillator;82;84;104;82;83;83;120;84;83;134 08:25:24 INFO - PROCESS | 28048 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 08:25:24 INFO - PROCESS | 28048 | |6;imaging-darkroom;146;147;146;145;147;146;146;145;146;145 08:25:24 INFO - PROCESS | 28048 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 08:25:24 INFO - PROCESS | 28048 | |8;json-parse-financial;52;51;53;52;52;53;53;53;52;52 08:25:24 INFO - PROCESS | 28048 | |9;json-stringify-tinderbox;61;63;61;62;62;62;61;62;62;63 08:25:24 INFO - PROCESS | 28048 | |10;stanford-crypto-aes;83;81;79;79;80;80;78;81;110;86 08:25:24 INFO - PROCESS | 28048 | |11;stanford-crypto-ccm;129;121;138;128;128;120;130;130;131;119 08:25:24 INFO - PROCESS | 28048 | |12;stanford-crypto-pbkdf2;158;158;161;155;158;161;154;154;162;157 08:25:24 INFO - PROCESS | 28048 | |13;stanford-crypto-sha256-iterative;62;61;63;61;61;62;65;62;61;65 08:25:24 INFO - PROCESS | 28048 | __end_tp_report 08:25:24 INFO - PROCESS | 28048 | __start_cc_report 08:25:24 INFO - PROCESS | 28048 | _x_x_mozilla_cycle_collect,1672 08:25:24 INFO - PROCESS | 28048 | __end_cc_report 08:25:24 INFO - PROCESS | 28048 | __startTimestamp1464621924610__endTimestamp 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | ------- Summary: start ------- 08:25:24 INFO - PROCESS | 28048 | Number of tests: 14 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.78 (1.6%) stddev-sans-first:1.80 08:25:24 INFO - PROCESS | 28048 | Values: 111.0 105.0 109.0 110.0 109.0 110.0 111.0 109.0 111.0 110.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:137.50 stddev:23.49 (17.1%) stddev-sans-first:24.85 08:25:24 INFO - PROCESS | 28048 | Values: 147.0 124.0 126.0 190.0 127.0 128.0 150.0 125.0 175.0 128.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 08:25:24 INFO - PROCESS | 28048 | Values: 161.0 161.0 159.0 161.0 160.0 161.0 163.0 159.0 161.0 162.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:17.71 (23.8%) stddev-sans-first:18.59 08:25:24 INFO - PROCESS | 28048 | Values: 75.0 75.0 76.0 127.0 74.0 75.0 72.0 74.0 100.0 74.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:83.00 stddev:18.94 (22.8%) stddev-sans-first:19.59 08:25:24 INFO - PROCESS | 28048 | Values: 82.0 84.0 104.0 82.0 83.0 83.0 120.0 84.0 83.0 134.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 08:25:24 INFO - PROCESS | 28048 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:25:24 INFO - PROCESS | 28048 | Values: 146.0 147.0 146.0 145.0 147.0 146.0 146.0 145.0 146.0 145.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:25:24 INFO - PROCESS | 28048 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.67 (1.3%) stddev-sans-first:0.71 08:25:24 INFO - PROCESS | 28048 | Values: 52.0 51.0 53.0 52.0 52.0 53.0 53.0 53.0 52.0 52.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 08:25:24 INFO - PROCESS | 28048 | Values: 61.0 63.0 61.0 62.0 62.0 62.0 61.0 62.0 62.0 63.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:80.50 stddev:9.52 (11.8%) stddev-sans-first:10.10 08:25:24 INFO - PROCESS | 28048 | Values: 83.0 81.0 79.0 79.0 80.0 80.0 78.0 81.0 110.0 86.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:129.50 stddev:5.85 (4.5%) stddev-sans-first:6.18 08:25:24 INFO - PROCESS | 28048 | Values: 129.0 121.0 138.0 128.0 128.0 120.0 130.0 130.0 131.0 119.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.00 stddev:2.90 (1.8%) stddev-sans-first:3.07 08:25:24 INFO - PROCESS | 28048 | Values: 158.0 158.0 161.0 155.0 158.0 161.0 154.0 154.0 162.0 157.0 08:25:24 INFO - PROCESS | 28048 | 08:25:24 INFO - PROCESS | 28048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.57 (2.5%) stddev-sans-first:1.66 08:25:24 INFO - PROCESS | 28048 | Values: 62.0 61.0 63.0 61.0 61.0 62.0 65.0 62.0 61.0 65.0 08:25:24 INFO - PROCESS | 28048 | -------- Summary: end -------- 08:25:24 INFO - PROCESS | 28048 | 08:25:25 INFO - TEST-INFO | 28048: exit 0 08:25:25 INFO - TEST-OK | kraken | took 61009ms 08:25:25 INFO - SUITE-END | took 1174s 08:25:25 INFO - Completed test suite (00:19:34) 08:25:25 INFO - javascript benchmark 08:25:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3180.8409579521026, 3184.3631273745254, 3199.3441344524376, 3221.0175896351634, 3236.093893709762, 5272.92090618641, 5360.035193665139, 5478.233047373371, 5562.749676264568, 5587.580931430144, 5342.786288548463, 5348.438413966526, 5493.7802487900535, 5509.228707980886, 5551.750171242294, 4802.687825291345, 4871.512848715136, 4884.438289596706, 4893.632977526682, 5136.8972620547565, 5000.0, 5063.898722025558, 5070.340855688755, 5088.974555127219, 5131.076406246874, 4885.7312847793355, 4956.876078098058, 4969.0, 4996.0, 5010.398752149747, 4922.433920099199, 4927.852164435073, 4932.112219800434, 4939.53074457926, 4998.40019197695, 4949.975250123763, 4976.129177393977, 4984.451710311862, 4996.975015124901, 5025.949740502585, 5231.555317797992, 5267.920981185285, 5405.594580406485, 5466.0, 5478.123500239943, 5957.285125784891, 5963.493103086243, 5975.701214939279, 5988.880222395571, 5989.610675306091, 6019.879602407971, 6027.126066720345, 6035.366286539938, 6040.0939859021055, 6042.972694641921, 5351.866203344908, 5459.69971651559, 5505.3393592768325, 5505.862353441116, 5611.803586874481, 6068.060272280922, 6070.265262822343, 6071.280667002622, 6072.15346042105, 6074.65454327936, 5846.970765146232, 5866.472017518444, 5869.941300587025, 5883.470487656132, 5890.352061273256, 5686.914696279559, 5865.941340586625, 5891.0, 5906.557008224315, 5988.131720900445, 5870.794522191788, 5904.350521442638, 5904.763809447574, 5913.970430147821, 5920.822375328747, 5881.294244690579, 5928.525717942554, 5938.2280303560265, 5941.643501389931, 5945.405459454107, 4378.64970802335, 4407.118576284692, 4411.9558804411545, 4468.352088947085, 4493.775311234425, 3992.580779018161, 4000.7199496035, 4010.498687664042, 4042.9797851011144, 4068.9796551017057, 5652.85867853307, 5663.235463212413, 5666.206731057655, 5674.943250567441, 5715.971420142872, 5684.8010319638615, 5857.912131318034, 5885.970570147122, 5888.676122813286, 5959.255093113361, 5616.522595579339, 5622.100463925753, 5623.775048997994, 5629.211910332557, 5638.069718496402, 5116.56509196715, 5130.820421285312, 5136.5890728741615, 5140.254663073833, 5186.40356359016, 5908.675022873783, 6112.047575716847, 6121.5139442231075, 6122.632642041492, 6178.104174894615, 5952.940470595412, 5987.491063259497, 5989.760409583568, 5991.101334799815, 6027.939720602738, 5810.157527158453, 6137.693115344304, 6158.784442544489, 6159.168512250968, 6160.16837726919, 5759.769609215752, 5788.131780232999, 5799.420057994167, 5823.94176058234, 5880.882382352414, 5888.528917686489, 5921.733521991435, 5928.2293301872205, 5935.762569497345, 5948.910766338595, 5620.971895140498, 5832.387599302012, 5840.532757379315, 5844.181814545882, 5848.883022339614, 5728.140778883034, 5728.255326807488, 5729.1119876419225, 5775.9133612996675, 5777.884442311214, 5634.52106570946, 5636.746346414503, 5639.887202256014, 5641.8589535261945, 5646.802361917313, 5610.102383618601, 5758.971205143947, 5764.308283006066, 5810.244668193108, 5810.854728631818, 5675.0636145035605, 5697.6296540724725, 5709.457601527848, 5727.6849773262875, 5766.135079738073], "value": 5435.020496026015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.6055921414223, 626.793158257775, 628.0986783965011, 630.3633330336359, 639.5619000984324, 31745.0, 32244.0, 43616.56383436161, 44502.0, 44672.32991505122, 42391.15217695644, 45772.3134152988, 46225.30662040064, 46278.07443851129, 46309.0, 8777.16616921393, 8997.640094396216, 9000.414973026765, 9004.189622933935, 9005.099490050976, 8797.692080777175, 8951.283897288235, 8955.37312388133, 8958.28333733303, 8962.910370896305, 8982.595783189772, 9059.094090590954, 9061.184493395593, 9061.957874844378, 9066.365354425192, 8914.777130571723, 8977.775555611097, 8981.506017169053, 8990.370674052754, 8991.955040224822, 8831.735047948572, 8901.688440904538, 8916.910830891673, 8917.108289171096, 8920.776980575472, 42694.35958460625, 43137.568624313986, 43241.351379729014, 43247.78376108131, 43264.35103473451, 3733.831977561016, 3806.695464362844, 4111.6093971073, 4171.436856024428, 4240.279152544075, 32624.6737532624, 32845.343093138006, 33051.3389732204, 33061.0, 33350.33299334024, 4432.977835110803, 4467.843625473125, 4514.774261286922, 4632.0, 4654.557817007379, 249777.0, 252150.0, 253142.0, 253256.7337163321, 254114.0, 59904.70047649734, 59942.0, 60312.69843650753, 60350.69824650849, 60369.698151508965, 62642.0, 63002.36997629965, 63073.369266307665, 63084.68457657682, 63108.05337919935, 15773.132477713836, 15922.920385397998, 15937.601559961095, 15943.0, 15988.600284992735, 12218.0, 12259.448324825225, 12281.815772763415, 12282.447289871798, 12282.508699651913, 16705.498835034967, 18268.90865545664, 18433.446996590123, 18483.075846207907, 18513.90743046276, 5768.307803063659, 5780.21967034445, 5904.077481646526, 5916.556258280646, 6010.9699451502465, 994.955227014786, 1057.4765491081964, 1128.041165009735, 1138.6014894786758, 1142.440204299887, 32545.674543254263, 32792.67207327944, 32815.343693126, 33188.83405582957, 33545.161370965434, 1122.169594500064, 1132.7111586545377, 1139.515705825021, 1146.1060372909144, 1198.1672737447564, 16822.24299906507, 17094.658106838044, 17098.743518847226, 17359.785202863863, 17456.30174792994, 559256.0, 565102.0, 565401.0, 566248.0, 568567.0, 59552.70223648941, 59659.0, 59660.0, 59693.0, 59719.402805972255, 1248.7689777391213, 1364.6110858405505, 1381.1367895065584, 1394.6792237785367, 1412.4773833681397, 32723.67276327206, 34027.4895876567, 34297.82851085729, 34314.82842585771, 34655.0, 50830.74584627053, 51091.0, 51396.48603514067, 51424.48575514197, 51472.48527514677, 393473.0, 395734.0, 395837.0, 396240.0, 396526.0, 34246.828765856015, 35538.46692299669, 41951.58048419477, 42543.53292904324, 42879.0, 47981.76009119932, 48246.517534824205, 48613.0, 48669.756651216514, 48887.0, 38067.42898856464, 41677.1664566713, 41999.58000419957, 42132.78933605312, 42224.0, 40898.59101408948, 41049.384259235536, 41251.793741031106, 42256.36615450709, 42275.15449690927, 40119.598804011584, 40672.38991415191, 41056.58943410528, 41742.58257417508, 44881.55118448774, 34482.65517344794, 37458.87623371303, 37739.81130094332, 39034.804825976826, 39342.62699817928, 27566.862165689847, 27794.0, 27845.86077069683, 27867.16398508048, 28108.578371324038], "value": 20240.619667029514, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.49307639683, 411.2166323154392, 412.16330848377805, 418.69226118802675, 427.480611057565, 13947.930260348685, 17889.373871914486, 20010.69983950242, 20011.999400029996, 20027.899860500696, 14503.41986320546, 18445.7233141503, 18581.53546161347, 19042.2383104676, 19669.606607867834, 5675.3757086720425, 5774.97112514439, 5815.941840581603, 5819.156222347779, 5874.412558744113, 5775.884482310351, 5789.131630255474, 5822.068469044953, 5832.445917637818, 5840.707964601753, 4318.07161460286, 4508.774561271924, 5711.514521265697, 6344.0, 6351.269603995554, 6365.61806291624, 6414.999999999976, 6426.1003459515705, 6479.416852483276, 6481.41667249945, 5554.222408862763, 5680.517156041741, 5689.516391106761, 5691.544676425876, 5726.026575482178, 23215.88392058029, 23299.301020969397, 23565.29304120879, 24027.50226104153, 24288.878555607287, 2390.6653068570413, 2437.9390515237083, 2495.75042495749, 2519.7354277800932, 3134.2164458885277, 15093.0, 15765.975211611209, 15899.581589958214, 16068.678626427523, 16749.078800665957, 1902.7156669248202, 1984.0, 1989.2142603671468, 2056.9177232910665, 2092.8221101206414, 74628.62685686591, 77892.61053694753, 83453.0, 87040.0, 87514.0, 16843.663126737396, 17716.645667086585, 17782.39958403724, 17808.732869006973, 18312.90843545774, 32111.197220069684, 32331.51502727461, 32336.353272934408, 32345.0, 32687.58717573145, 9600.471974041495, 9692.41845489273, 9796.069373409515, 10084.74788130288, 10101.898981010243, 7976.5612891290375, 8006.279434850775, 8166.0, 8304.875426868603, 8356.874646880302, 7436.879262893409, 8655.836040989752, 9075.319351048698, 9276.536173191313, 9338.90661093394, 3520.5247291615815, 3585.659362360572, 3600.837962291703, 3628.63713628635, 3719.34911390511, 901.8016036471965, 959.3231111464148, 986.1765425869336, 1013.614826365991, 1113.2930589075834, 18851.52871178204, 19507.02464876779, 19531.804681953, 19617.0, 19630.90184549068, 962.3504134709043, 1006.059334522224, 1012.1447376966452, 1017.8167929772563, 1022.8721409823772, 10822.40476773785, 10829.783404332027, 10892.183086268562, 11057.889421105687, 11058.060064894413, 413526.0, 423678.0, 427390.0, 429145.0, 447407.0, 92308.0, 94527.0, 94713.52643236739, 94973.0, 95640.52179739057, 991.8561808537721, 1025.1286406554518, 1034.4724190662666, 1050.3225419604312, 1056.3186744549723, 16373.345066197218, 17179.0, 17296.91351543234, 17315.91342043282, 17968.820311796713, 34171.65828341685, 37863.81068094642, 40851.182976340904, 42828.0, 42922.35616465693, 53876.19185712296, 55370.44629553814, 56390.43609563852, 56609.433905660415, 57469.8277155058, 8186.918130818854, 8225.71210007647, 8234.876476852973, 8244.628991695268, 8459.83080338402, 9114.954425227832, 10026.147777438999, 12765.808512872129, 13028.28344441027, 13032.283224422748, 10820.350778953289, 10888.346699198073, 11096.33421994683, 11119.888801111885, 11253.099752019654, 11349.205555611028, 11392.43037848121, 11499.94250028778, 11570.537178512765, 11675.182737208313, 11619.128565357802, 11680.824787628022, 11793.233439826385, 11802.52789888395, 11993.64019079429, 8066.1127275998415, 8146.959265203636, 8406.747797566082, 8444.746657600283, 8499.32005439551, 8394.607536851969, 11626.82559761621, 11679.649610511698, 11685.298882067103, 11737.119716021161], "value": 9988.89877535071, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.5418734723867, 1527.61045933287, 1541.8072740907385, 1702.1914590569472, 1859.0890463672797, 8611.612477438515, 8955.910440895588, 8962.193402593773, 9237.861432078507, 9244.0, 8864.46813191209, 9113.362064655477, 9115.908840911605, 9119.179273865351, 9119.863202051974, 2037.7962203779578, 2274.317704688595, 2331.5686597979384, 2342.8125749939963, 2363.1020212319295, 2377.6671266022686, 2387.5821731197057, 2389.354874183978, 2391.0316321889663, 2393.0547433763654, 2279.908803647852, 2321.9303420897318, 2323.442373830277, 2323.663068855015, 2323.8140948724063, 1922.9423117306433, 2214.966775498369, 2288.9084436622516, 2296.2307626944994, 2320.93037208884, 2251.4596496840804, 2258.67249248858, 2265.750767415583, 2268.591653502369, 2306.642470417088, 9048.276137909017, 9174.311926605531, 9214.0, 9216.308776841697, 9219.032001639798, 5198.350206224222, 5319.095753721838, 5333.919991200135, 5342.759575819097, 5347.679139251619, 3285.802851828898, 3380.2394461246267, 3423.0928803866996, 3432.1076520104702, 3434.9828250858836, 1074.8011617850723, 1083.1984331594642, 1088.4884104470887, 1103.2112039891515, 1126.6282126898186, 12796.61610151697, 12844.48622055126, 12856.35718214095, 12859.742805143938, 12865.678358041125, 4760.809567617256, 4860.3195552622665, 4897.902041959141, 4908.386451693538, 4937.950620493821, 10847.0, 10868.239223254455, 10896.945515272373, 10902.672919812418, 10908.072813810757, 4787.186178349689, 5544.112941929353, 5549.38956714761, 5557.166425036277, 5558.277423934863, 4902.607791376681, 5004.524570165829, 5021.196608542688, 5070.391553013662, 5070.4929507049, 4092.836286548564, 4100.610442008005, 4189.036521600049, 4214.346776249687, 4222.936655950163, 1264.462603393554, 1283.3198404845448, 1291.9547815826402, 1298.9805152922713, 1307.1242267680677, 888.1828717579842, 913.3743385780762, 975.380633297861, 983.4448468785432, 1019.0777346501428, 5806.767729290781, 5936.495397891142, 5975.043992961106, 6007.3992600739575, 6124.6325220486915, 450.58095970746865, 457.1474200615894, 467.2430662327052, 469.1461539997172, 469.31480039143236, 3993.684774945649, 4087.4890638670167, 4094.201630682048, 4118.979405102956, 4179.477565304337, 10436.321639093434, 10734.302270352402, 10813.459327033617, 10823.242373033812, 10845.566177352817, 10395.220358473145, 10599.046085852311, 10615.787684246272, 10666.893331066745, 10698.0, 8017.278444939983, 8120.431569790177, 8131.552764598004, 8207.220314070153, 8232.753017409368, 5611.971940140274, 5675.858103547444, 5780.161876527964, 5817.76728930838, 5926.762929482772, 9869.654562090293, 10585.576576936835, 10656.307340022873, 10701.929807019236, 10711.571537138427, 10309.793804123725, 10631.255812093079, 10936.671899843017, 10941.0, 10946.343219406543, 6838.589684618939, 7750.379969602305, 7923.484973476706, 8035.316998055231, 8201.425900187169, 8782.56087195625, 8829.16122968317, 8850.601722922613, 8867.201951824367, 8874.822503550022, 7547.622618869144, 7656.234376562299, 7711.652975616223, 7790.766277011699, 8171.5505647189975, 7539.962300188464, 7540.0, 7600.695972161273, 7690.038745156856, 7854.803629909298, 7114.537555058904, 7182.820429489305, 7202.063731714844, 7215.062041934515, 7216.386607138452, 5115.667481613683, 5117.590592752496, 5216.37403511581, 5257.894842103213, 5282.102042652681, 5225.712585807817, 5234.685918844882, 5246.685198888079, 5263.868403289795, 5339.759710812945], "value": 4608.019208398885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.9265776213709, 310.78245228340165, 316.13379340606735, 327.70670250126153, 332.99833500832494, 5309.946900530994, 5331.2003199520095, 5403.729813509329, 5415.754376493409, 5432.782688692458, 5332.866678333044, 5337.306150200478, 5341.813036543722, 5341.919871201935, 5353.437889021655, 4161.439460202424, 4162.604552567501, 4168.854090106847, 4170.165966806636, 4175.394567787669, 4052.2705912935658, 4133.6693064554765, 4136.400221967813, 4154.916901661965, 4159.232326261342, 4120.877747959788, 4126.154138401621, 4128.256913755523, 4128.855490057848, 4140.275451795938, 4133.524644665857, 4146.419501269825, 4150.7340261220315, 4153.273177194009, 4154.169166166779, 3676.871309504181, 3687.2625474904858, 3692.390755525335, 3698.1124530112847, 3706.5552133744122, 4946.2580612908, 5165.380154381461, 5181.300524429229, 5217.634765566412, 5228.816991405321, 4623.861284161447, 4636.814527418899, 4648.768076459741, 4678.415198100238, 4718.764061796931, 5520.309961254843, 5548.55611551075, 5554.944450555483, 5564.415736347666, 5571.997040532702, 3802.619738026175, 3903.960960390388, 3924.6860251179837, 3925.646691797723, 3925.803709814498, 5450.700211488366, 5545.916811247875, 5702.287214098238, 5763.971180144073, 5780.942190578083, 3946.7829269389886, 3973.642372186517, 3979.422983667352, 3983.900402489961, 3996.5204175498543, 3832.2910261601137, 3996.002997751686, 4030.1738143680477, 4058.066644671742, 4088.632023117934, 4559.635229181657, 4599.011212589309, 4624.6819656397765, 4636.4899861015265, 4647.885212228428, 5516.3380394352935, 5575.944240557624, 5599.552035837123, 5604.915926261109, 5610.915836262459, 1328.2296268164441, 1379.4620098161524, 1381.86181381861, 1382.4746596293344, 1382.9585112446644, 860.7331727164599, 876.2508055612487, 878.6221924572368, 878.7846977490556, 883.3816328570026, 4782.689125206851, 4853.277086634264, 4857.635677324215, 4864.637901387617, 4898.68158569699, 5144.485551444825, 5184.377874655065, 5185.429602743695, 5200.453952335026, 5215.6609820361555, 4850.671677594703, 4942.0, 4951.232558953368, 4955.578775804025, 4974.353334066621, 3050.7864449488325, 3055.205646531918, 3071.201487613192, 3075.3695492424, 3075.5540446635114, 5922.822315330461, 5932.3177834548715, 5950.869334826369, 5958.225430693982, 5987.580869339192, 5615.803446879421, 5813.79651712188, 5821.941780582225, 5850.912236316459, 5873.295204575478, 5860.970695146497, 5932.3982524718085, 5935.673537955454, 5953.4344237298255, 6025.367336429699, 5319.973400132974, 5433.8369848904595, 5707.714614269353, 5742.253507044057, 5763.769449221984, 5022.974885125551, 5645.209670646031, 5661.66030038199, 5691.800786972436, 5706.942930570641, 5887.911681324698, 5888.175655408332, 5908.231929849264, 5913.58604897653, 5951.732172052181, 3959.287328280937, 3972.245273398045, 3990.960090399059, 4006.7395619284653, 4125.628693417607, 5719.48524632785, 5721.771129154788, 5722.484976352148, 5727.284089488814, 5737.8565535861935, 5592.3009623797025, 5619.831405057855, 5632.943670563406, 5660.405657406078, 5667.914981275367, 5494.80768173112, 5500.477454641803, 5528.834134975958, 5535.972320138373, 5558.861028474321, 5337.359516858002, 5451.754671039892, 5478.493414311097, 5517.2275881377445, 5539.789759782675, 5391.353037635509, 5573.359063707563, 5573.359063707726, 5581.0, 5583.972080139573, 5461.235427040138, 5551.22282880389, 5569.554435645057, 5571.526420254162, 5596.916046259391], "value": 4188.31846809715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.5088268067096, 787.9251471110242, 819.1562690428858, 833.62903507939, 862.1637012098263, 15392.769108463368, 15710.293036813342, 15733.213339333017, 15735.370585176594, 15747.448839290613, 13957.371918263678, 14016.22910739909, 14074.577762667112, 14101.294935253221, 14108.365123569438, 812.5530957973135, 819.8319344534356, 820.1716266570747, 821.4126899267023, 821.6179476543406, 662.1127688896877, 788.3771820262015, 810.6878851642131, 817.0073360866546, 820.2576668115365, 847.063994286311, 853.3173461231021, 855.110684887716, 856.8886044814196, 857.6783706110209, 684.6063513479719, 853.1766844994548, 854.8162145138793, 855.589317127779, 856.2251162697737, 608.6591508755112, 616.7502161624504, 617.5306766857221, 624.4660815003152, 624.8781487609917, 13942.23317717525, 14039.157650541, 14060.718785624333, 14061.086029408056, 14072.507462238773, 12776.0, 13189.73620527584, 13210.0, 13263.668408289774, 13564.186148831102, 11874.643760687193, 12166.756664866742, 12312.13815032948, 12482.687932801753, 12820.358982050953, 4361.694681372305, 4434.2905135178535, 4459.910801783946, 4647.000894807633, 4649.95350046502, 60134.0, 61132.38867611267, 61287.69356153191, 61393.38606613966, 61634.69182654103, 9926.900730992598, 9995.891963591943, 10011.749706257402, 10040.66374364942, 10202.591896324064, 17343.56641083983, 17348.566285842953, 17365.392211272545, 17378.304867805145, 17488.300467981393, 8200.753977380688, 8279.958600207081, 8506.064332923374, 8645.567721613894, 8856.335774816915, 4699.929501057487, 4759.643026773006, 4816.759162041954, 4865.343178670834, 4886.902261954741, 3330.1841048943165, 3436.8281585920604, 3447.2760720248525, 3449.379111759857, 3453.8963831085107, 607.2470137030051, 611.9479844213291, 613.0191693290789, 646.0857886091222, 653.7907869481816, 620.6183197333607, 622.4988883948465, 709.7019251914209, 711.729542773753, 718.7843646905907, 8825.91174088251, 9126.224270936911, 9172.816543669089, 9291.953540232256, 9385.812283754423, 739.8298291819634, 755.3315315945318, 759.787259567311, 779.0923574036184, 803.0644299391143, 4431.180231657154, 4545.136424079415, 4652.232381656989, 4655.2784318430695, 4660.440747110369, 64898.67550662311, 69587.65206173937, 69706.65146674235, 70085.0, 70106.29893700998, 61257.69371153116, 62807.6859615699, 62909.37090629127, 63339.36660633427, 63791.681041595424, 50576.24135637969, 52011.479885200664, 55543.722281388335, 55876.0, 56102.719486402304, 8837.690680826398, 8863.512506812187, 8963.372563920462, 9265.814683706423, 9341.953290233505, 36825.447618286285, 36832.44751328679, 37221.25557488781, 37256.81371593125, 37470.250594988494, 24170.154044608353, 24499.63250551279, 24602.138925137533, 24638.13766518163, 39165.412518811674, 11785.587504437304, 11913.880861191277, 12428.81356779631, 12701.185649129295, 13277.507788161995, 12832.871671283541, 13657.248851312876, 13733.244671543162, 13889.861101388857, 14022.088564243291, 12654.430550625428, 12699.111062225555, 12759.93620031894, 12765.808512872129, 13311.267880266678, 12871.806922896352, 13141.0, 13239.86760132425, 13544.525941591997, 13591.45634174622, 11725.35510546894, 11923.701907452383, 11951.103667225167, 12061.155719099579, 12084.577039803564, 9547.952260238655, 9625.278104142077, 9865.161461275586, 10209.030142136486, 10325.277230593787, 9804.705858824247, 9998.20014398861, 10460.790784184426, 10899.0, 10934.617288395186], "value": 6772.188922323146, "unit": "score"}], "name": "dromaeo_css", "value": 7236.780690344793, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 110.0, 109.0, 110.0, 111.0, 109.0, 111.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 126.0, 190.0, 127.0, 128.0, 150.0, 125.0, 175.0, 128.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 160.0, 161.0, 163.0, 159.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 127.0, 74.0, 75.0, 72.0, 74.0, 100.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 104.0, 82.0, 83.0, 83.0, 120.0, 84.0, 83.0, 134.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 79.0, 79.0, 80.0, 80.0, 78.0, 81.0, 110.0, 86.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 121.0, 138.0, 128.0, 128.0, 120.0, 130.0, 130.0, 131.0, 119.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 161.0, 155.0, 158.0, 161.0, 154.0, 154.0, 162.0, 157.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 61.0, 61.0, 62.0, 65.0, 62.0, 61.0, 65.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1491.5, "alertThreshold": 2.0}]} 08:25:25 INFO - Return code: 0 08:25:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:25:25 ERROR - # TBPL SUCCESS # 08:25:25 INFO - Running post-action listener: _resource_record_post_action 08:25:25 INFO - ##### 08:25:25 INFO - ##### Finished run-tests step (success) 08:25:25 INFO - ##### 08:25:25 INFO - Running post-run listener: _resource_record_post_run 08:25:25 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 546795520; Read time: 0; Write time: 459952 08:25:25 INFO - TinderboxPrint: CPU usage
13.1% 08:25:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:25:25 INFO - TinderboxPrint: I/O write bytes / time
546,795,520 / 459,952 08:25:25 INFO - TinderboxPrint: CPU idle
8,262.8 (86.8%) 08:25:25 INFO - TinderboxPrint: CPU user
1,205.5 (12.7%) 08:25:25 INFO - TinderboxPrint: Swap in / out
0 / 0 08:25:25 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254676992; Read time: 0; Write time: 221760 08:25:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 292118528; Read time: 0; Write time: 238192 08:25:26 INFO - Running post-run listener: _upload_blobber_files 08:25:26 INFO - Blob upload gear active. 08:25:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:26 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 08:25:26 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'] 08:25:26 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 08:25:26 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:27 INFO - (blobuploader) - INFO - Done attempting. 08:25:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:28 INFO - (blobuploader) - INFO - Done attempting. 08:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:33 INFO - (blobuploader) - INFO - Done attempting. 08:25:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:33 INFO - Return code: 0 08:25:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62ed81f24956f345bcf73b002ddae912cc0acd48e76ca50e506651dc831bf34ca4ed4d91db744aa54ee80469695e083099a47cdd5210692241a9670d130a6230", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e4c34dbaee5379eada8560b43bff2f30d532314c738aadf61ffade4763271e58337747184de8b3a8ffe4f7278dbc061662a88023ee2910ff7d9567bc680077f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1b1d4f6aab76bba7e70e99ededdfb89b9dc89bb9a1945909ae891bedd3b81243dc834f1a0ad32ffce64a9f93ca0c388854eeb1c6bcfca9e438c3a61cac3687"} 08:25:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:33 INFO - Contents: 08:25:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62ed81f24956f345bcf73b002ddae912cc0acd48e76ca50e506651dc831bf34ca4ed4d91db744aa54ee80469695e083099a47cdd5210692241a9670d130a6230", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e4c34dbaee5379eada8560b43bff2f30d532314c738aadf61ffade4763271e58337747184de8b3a8ffe4f7278dbc061662a88023ee2910ff7d9567bc680077f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1b1d4f6aab76bba7e70e99ededdfb89b9dc89bb9a1945909ae891bedd3b81243dc834f1a0ad32ffce64a9f93ca0c388854eeb1c6bcfca9e438c3a61cac3687"} 08:25:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:33 INFO - Copying logs to upload dir... 08:25:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.160863 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 08:25:33.277457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:25:33.284038) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435 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/62ed81f24956f345bcf73b002ddae912cc0acd48e76ca50e506651dc831bf34ca4ed4d91db744aa54ee80469695e083099a47cdd5210692241a9670d130a6230", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e4c34dbaee5379eada8560b43bff2f30d532314c738aadf61ffade4763271e58337747184de8b3a8ffe4f7278dbc061662a88023ee2910ff7d9567bc680077f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1b1d4f6aab76bba7e70e99ededdfb89b9dc89bb9a1945909ae891bedd3b81243dc834f1a0ad32ffce64a9f93ca0c388854eeb1c6bcfca9e438c3a61cac3687"} build_url:https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/bG1KpJ7zTiuA3vKosVJBdA/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/62ed81f24956f345bcf73b002ddae912cc0acd48e76ca50e506651dc831bf34ca4ed4d91db744aa54ee80469695e083099a47cdd5210692241a9670d130a6230", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e4c34dbaee5379eada8560b43bff2f30d532314c738aadf61ffade4763271e58337747184de8b3a8ffe4f7278dbc061662a88023ee2910ff7d9567bc680077f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a1b1d4f6aab76bba7e70e99ededdfb89b9dc89bb9a1945909ae891bedd3b81243dc834f1a0ad32ffce64a9f93ca0c388854eeb1c6bcfca9e438c3a61cac3687"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:25:33.317116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:25:33.317474) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464620696.774035-1533791435 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:25:33.403986) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:25:33.404322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:25:33.404718) ========= ========= Total master_lag: 0.21 =========