builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1464053118.07 results: success (0) buildid: 20160523172042 builduid: 153e8b2cbc8e4be7b8bc06f5a32da908 revision: b3835efbf422b78ea753a5072d3e25986b7df180 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.066555) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.066973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.067253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.091817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.092189) ========= 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=ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 18:25:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.4M=0s 2016-05-23 18:25:18 (33.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.215672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.216087) ========= 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=ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.267359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.267742) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b3835efbf422b78ea753a5072d3e25986b7df180 --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 b3835efbf422b78ea753a5072d3e25986b7df180 --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=ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 18:25:18,500 truncating revision to first 12 chars 2016-05-23 18:25:18,500 Setting DEBUG logging. 2016-05-23 18:25:18,500 attempt 1/10 2016-05-23 18:25:18,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b3835efbf422?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 18:25:18,897 unpacking tar archive at: fx-team-b3835efbf422/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.972060) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.972380) ========= script_repo_revision: b3835efbf422b78ea753a5072d3e25986b7df180 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.972785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.973407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 18:25:18.983022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-23 18:25:18.983470) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:25:19 INFO - MultiFileLogger online at 20160523 18:25:19 in /builds/slave/test 18:25:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:25:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:19 INFO - {'append_to_log': False, 18:25:19 INFO - 'base_work_dir': '/builds/slave/test', 18:25:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:25:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:19 INFO - 'branch': 'Fx-Team-Non-PGO', 18:25:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:19 INFO - 'config_files': ('talos/linux_config.py',), 18:25:19 INFO - 'default_actions': ('clobber', 18:25:19 INFO - 'read-buildbot-config', 18:25:19 INFO - 'download-and-extract', 18:25:19 INFO - 'populate-webroot', 18:25:19 INFO - 'create-virtualenv', 18:25:19 INFO - 'install', 18:25:19 INFO - 'run-tests'), 18:25:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:19 INFO - 'download_minidump_stackwalk': True, 18:25:19 INFO - 'download_symbols': 'ondemand', 18:25:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:19 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:19 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:19 INFO - 'installer_path': 'installer.exe', 18:25:19 INFO - 'log_level': 'info', 18:25:19 INFO - 'log_name': 'talos', 18:25:19 INFO - 'log_to_console': True, 18:25:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:25:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:25:19 INFO - 'opt_config_files': (), 18:25:19 INFO - 'pip_index': False, 18:25:19 INFO - 'sps_profile': False, 18:25:19 INFO - 'sps_profile_interval': 0, 18:25:19 INFO - 'suite': 'dromaeojs', 18:25:19 INFO - 'system_bits': '32', 18:25:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:19 INFO - 'title': 'talos-linux64-ix-035', 18:25:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:19 INFO - 'use_talos_json': True, 18:25:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:19 INFO - 'work_dir': 'build'} 18:25:19 INFO - ##### 18:25:19 INFO - ##### Running clobber step. 18:25:19 INFO - ##### 18:25:19 INFO - Running pre-action listener: _resource_record_pre_action 18:25:19 INFO - Running main action method: clobber 18:25:19 INFO - rmtree: /builds/slave/test/build 18:25:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:19 INFO - Running post-action listener: _resource_record_post_action 18:25:19 INFO - ##### 18:25:19 INFO - ##### Finished clobber step (success) 18:25:19 INFO - ##### 18:25:19 INFO - ##### 18:25:19 INFO - ##### Running read-buildbot-config step. 18:25:19 INFO - ##### 18:25:19 INFO - Running pre-action listener: _resource_record_pre_action 18:25:19 INFO - Running main action method: read_buildbot_config 18:25:19 INFO - Using buildbot properties: 18:25:19 INFO - { 18:25:19 INFO - "project": "", 18:25:19 INFO - "product": "firefox", 18:25:19 INFO - "script_repo_revision": "production", 18:25:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:25:19 INFO - "repository": "", 18:25:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:25:19 INFO - "buildid": "20160523172042", 18:25:19 INFO - "pgo_build": "False", 18:25:19 INFO - "basedir": "/builds/slave/test", 18:25:19 INFO - "buildnumber": 1767, 18:25:19 INFO - "slavename": "talos-linux64-ix-035", 18:25:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:25:19 INFO - "platform": "ubuntu64_hw", 18:25:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:25:19 INFO - "branch": "fx-team", 18:25:19 INFO - "repo_path": "integration/fx-team", 18:25:19 INFO - "revision": "b3835efbf422b78ea753a5072d3e25986b7df180", 18:25:19 INFO - "stage_platform": "linux64", 18:25:19 INFO - "builduid": "153e8b2cbc8e4be7b8bc06f5a32da908", 18:25:19 INFO - "slavebuilddir": "test" 18:25:19 INFO - } 18:25:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:25:19 INFO - Running post-action listener: _resource_record_post_action 18:25:19 INFO - ##### 18:25:19 INFO - ##### Finished read-buildbot-config step (success) 18:25:19 INFO - ##### 18:25:19 INFO - ##### 18:25:19 INFO - ##### Running download-and-extract step. 18:25:19 INFO - ##### 18:25:19 INFO - Running pre-action listener: _resource_record_pre_action 18:25:19 INFO - Running main action method: download_and_extract 18:25:19 INFO - mkdir: /builds/slave/test/build/tests 18:25: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')]} 18:25:19 INFO - https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:25:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:25:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:25:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:25 INFO - Downloaded 1361 bytes. 18:25:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:25:25 INFO - Using the following test package requirements: 18:25:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:25:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:25:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'jsshell-linux-x86_64.zip'], 18:25:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:25:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:25:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:25:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:25:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:25:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:25:25 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')]} 18:25:25 INFO - https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:25:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:25:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:25:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:29 INFO - Downloaded 22814445 bytes. 18:25:29 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'] 18:25:29 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 18:25:30 INFO - Return code: 0 18:25:30 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 18:25:30 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')]} 18:25:30 INFO - https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:25:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:25:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:25:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:34 INFO - Downloaded 22814445 bytes. 18:25:34 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'] 18:25:34 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 18:25:35 INFO - Return code: 0 18:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:35 INFO - https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:36 INFO - Downloaded 10840359 bytes. 18:25:36 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'] 18:25:36 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 18:25:37 INFO - Return code: 0 18:25:37 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')]} 18:25:37 INFO - https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoBXpQiORUm9eYs-0P_0gA/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 18:25:40 INFO - Downloaded 54816298 bytes. 18:25:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:25:40 INFO - mkdir: /builds/slave/test/properties 18:25:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:40 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:40 INFO - Contents: 18:25:40 INFO - build_url:https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:25:41 INFO - Running post-action listener: _resource_record_post_action 18:25:41 INFO - Running post-action listener: set_extra_try_arguments 18:25:41 INFO - ##### 18:25:41 INFO - ##### Finished download-and-extract step (success) 18:25:41 INFO - ##### 18:25:41 INFO - ##### 18:25:41 INFO - ##### Running populate-webroot step. 18:25:41 INFO - ##### 18:25:41 INFO - Running pre-action listener: _resource_record_pre_action 18:25:41 INFO - Running main action method: populate_webroot 18:25:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:25:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:25:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:25:41 INFO - '--tppagecycles', 18:25:41 INFO - '7'], 18:25:41 INFO - 'tests': ['tsvgm']}}, 18:25:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:25:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:25:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['damp', 'tps']}, 18:25:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'tests': ['damp', 'tps']}, 18:25:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['dromaeo_dom']}, 18:25:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['a11yr', 18:25:41 INFO - 'ts_paint', 18:25:41 INFO - 'tpaint', 18:25:41 INFO - 'sessionrestore', 18:25:41 INFO - 'sessionrestore_no_auto_restore', 18:25:41 INFO - 'tabpaint']}, 18:25:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:41 INFO - 'ts_paint', 18:25:41 INFO - 'tpaint', 18:25:41 INFO - 'sessionrestore', 18:25:41 INFO - 'sessionrestore_no_auto_restore', 18:25:41 INFO - 'tabpaint']}, 18:25:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:25:41 INFO - 'ts_paint', 18:25:41 INFO - 'tpaint', 18:25:41 INFO - 'sessionrestore', 18:25:41 INFO - 'sessionrestore_no_auto_restore', 18:25:41 INFO - 'tabpaint']}, 18:25:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:25:41 INFO - 'ts_paint', 18:25:41 INFO - 'tpaint', 18:25:41 INFO - 'sessionrestore', 18:25:41 INFO - 'sessionrestore_no_auto_restore', 18:25:41 INFO - 'tabpaint']}, 18:25:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['a11yr', 18:25:41 INFO - 'ts_paint', 18:25:41 INFO - 'tpaint', 18:25:41 INFO - 'sessionrestore', 18:25:41 INFO - 'sessionrestore_no_auto_restore', 18:25:41 INFO - 'tabpaint']}, 18:25:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['a11yr', 18:25:41 INFO - 'ts_paint', 18:25:41 INFO - 'tpaint', 18:25:41 INFO - 'sessionrestore', 18:25:41 INFO - 'sessionrestore_no_auto_restore', 18:25:41 INFO - 'tabpaint']}, 18:25:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['tsvgx', 18:25:41 INFO - 'tsvgr_opacity', 18:25:41 INFO - 'tart', 18:25:41 INFO - 'tscrollx', 18:25:41 INFO - 'cart']}, 18:25:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:41 INFO - 'tsvgr_opacity', 18:25:41 INFO - 'tart', 18:25:41 INFO - 'tscrollx', 18:25:41 INFO - 'cart']}, 18:25:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'talos_options': ['--disable-e10s'], 18:25:41 INFO - 'tests': ['tp5o']}, 18:25:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'tests': ['tp5o']}, 18:25:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'talos_options': ['--disable-e10s', 18:25:41 INFO - '--xperf_path', 18:25:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:41 INFO - 'tests': ['tp5n']}, 18:25:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:25:41 INFO - 'talos_options': ['--xperf_path', 18:25:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:41 INFO - 'tests': ['tp5n']}}, 18:25:41 INFO - 'talos.zip': {'path': '', 18:25:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:25:41 INFO - Running post-action listener: _resource_record_post_action 18:25:41 INFO - ##### 18:25:41 INFO - ##### Finished populate-webroot step (success) 18:25:41 INFO - ##### 18:25:41 INFO - ##### 18:25:41 INFO - ##### Running create-virtualenv step. 18:25:41 INFO - ##### 18:25:41 INFO - Running pre-action listener: _resource_record_pre_action 18:25:41 INFO - Running main action method: create_virtualenv 18:25:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:41 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 18:25:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:41 INFO - Using real prefix '/usr' 18:25:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:44 INFO - Installing pip.................done. 18:25:44 INFO - Return code: 0 18:25:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:44 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:25:44 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 18:25:44 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 18:25:44 INFO - Using env: {'DISPLAY': ':0', 18:25:44 INFO - 'HOME': '/home/cltbld', 18:25:44 INFO - 'LANG': 'en_US.UTF-8', 18:25:44 INFO - 'LANGUAGE': 'en_US:en', 18:25:44 INFO - 'LOGNAME': 'cltbld', 18:25:44 INFO - 'MAIL': '/var/mail/cltbld', 18:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:44 INFO - 'MOZ_NO_REMOTE': '1', 18:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:44 INFO - 'NO_EM_RESTART': '1', 18:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:44 INFO - 'PWD': '/builds/slave/test', 18:25:44 INFO - 'SHELL': '/bin/bash', 18:25:44 INFO - 'SHLVL': '1', 18:25:44 INFO - 'TERM': 'linux', 18:25:44 INFO - 'TMOUT': '86400', 18:25:44 INFO - 'USER': 'cltbld', 18:25:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:44 INFO - '_': '/tools/buildbot/bin/python'} 18:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:44 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 18:25:44 INFO - Cleaning up... 18:25:44 INFO - Return code: 0 18:25:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:44 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:25:44 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 18:25:44 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 18:25:44 INFO - Using env: {'DISPLAY': ':0', 18:25:44 INFO - 'HOME': '/home/cltbld', 18:25:44 INFO - 'LANG': 'en_US.UTF-8', 18:25:44 INFO - 'LANGUAGE': 'en_US:en', 18:25:44 INFO - 'LOGNAME': 'cltbld', 18:25:44 INFO - 'MAIL': '/var/mail/cltbld', 18:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:44 INFO - 'MOZ_NO_REMOTE': '1', 18:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:44 INFO - 'NO_EM_RESTART': '1', 18:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:44 INFO - 'PWD': '/builds/slave/test', 18:25:44 INFO - 'SHELL': '/bin/bash', 18:25:44 INFO - 'SHLVL': '1', 18:25:44 INFO - 'TERM': 'linux', 18:25:44 INFO - 'TMOUT': '86400', 18:25:44 INFO - 'USER': 'cltbld', 18:25:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:44 INFO - '_': '/tools/buildbot/bin/python'} 18:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:44 INFO - Downloading/unpacking psutil>=3.1.1 18:25:44 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 18:25:44 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 18:25:44 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 18:25:44 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 18:25:44 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 18:25:44 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 18:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:25:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:46 INFO - Installing collected packages: psutil 18:25:46 INFO - Running setup.py install for psutil 18:25:46 INFO - building 'psutil._psutil_linux' extension 18:25:46 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 18:25:46 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 18:25:46 INFO - building 'psutil._psutil_posix' extension 18:25:46 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 18:25:46 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 18:25:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:46 INFO - Successfully installed psutil 18:25:46 INFO - Cleaning up... 18:25:47 INFO - Return code: 0 18:25:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:25:47 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')]} 18:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:47 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')]} 18:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:47 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:25:47 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 18:25:47 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 18:25:47 INFO - Using env: {'DISPLAY': ':0', 18:25:47 INFO - 'HOME': '/home/cltbld', 18:25:47 INFO - 'LANG': 'en_US.UTF-8', 18:25:47 INFO - 'LANGUAGE': 'en_US:en', 18:25:47 INFO - 'LOGNAME': 'cltbld', 18:25:47 INFO - 'MAIL': '/var/mail/cltbld', 18:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:47 INFO - 'MOZ_NO_REMOTE': '1', 18:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:47 INFO - 'NO_EM_RESTART': '1', 18:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:47 INFO - 'PWD': '/builds/slave/test', 18:25:47 INFO - 'SHELL': '/bin/bash', 18:25:47 INFO - 'SHLVL': '1', 18:25:47 INFO - 'TERM': 'linux', 18:25:47 INFO - 'TMOUT': '86400', 18:25:47 INFO - 'USER': 'cltbld', 18:25:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:47 INFO - '_': '/tools/buildbot/bin/python'} 18:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:25:49 INFO - Installing collected packages: mozsystemmonitor 18:25:49 INFO - Running setup.py install for mozsystemmonitor 18:25:49 INFO - Successfully installed mozsystemmonitor 18:25:49 INFO - Cleaning up... 18:25:49 INFO - Return code: 0 18:25:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:49 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:25:49 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 18:25:49 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 18:25:49 INFO - Using env: {'DISPLAY': ':0', 18:25:49 INFO - 'HOME': '/home/cltbld', 18:25:49 INFO - 'LANG': 'en_US.UTF-8', 18:25:49 INFO - 'LANGUAGE': 'en_US:en', 18:25:49 INFO - 'LOGNAME': 'cltbld', 18:25:49 INFO - 'MAIL': '/var/mail/cltbld', 18:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:49 INFO - 'MOZ_NO_REMOTE': '1', 18:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:49 INFO - 'NO_EM_RESTART': '1', 18:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:49 INFO - 'PWD': '/builds/slave/test', 18:25:49 INFO - 'SHELL': '/bin/bash', 18:25:49 INFO - 'SHLVL': '1', 18:25:49 INFO - 'TERM': 'linux', 18:25:49 INFO - 'TMOUT': '86400', 18:25:49 INFO - 'USER': 'cltbld', 18:25:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:49 INFO - '_': '/tools/buildbot/bin/python'} 18:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:25:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:25:51 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 18:25:51 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 18:25:51 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 18:25:51 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 18:25:51 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 18:25:51 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 18:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:25:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:25:51 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 18:25:51 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 18:25:51 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 18:25:51 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 18:25:51 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 18:25:51 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 18:25:52 INFO - Downloading docopt-0.6.1.tar.gz 18:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:25:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:25:52 INFO - Running setup.py install for blobuploader 18:25:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:25:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:25:52 INFO - Running setup.py install for requests 18:25:52 INFO - Running setup.py install for docopt 18:25:52 INFO - Successfully installed blobuploader requests docopt 18:25:52 INFO - Cleaning up... 18:25:52 INFO - Return code: 0 18:25:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:52 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:25:52 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 18:25:52 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 18:25:52 INFO - Using env: {'DISPLAY': ':0', 18:25:52 INFO - 'HOME': '/home/cltbld', 18:25:52 INFO - 'LANG': 'en_US.UTF-8', 18:25:52 INFO - 'LANGUAGE': 'en_US:en', 18:25:52 INFO - 'LOGNAME': 'cltbld', 18:25:52 INFO - 'MAIL': '/var/mail/cltbld', 18:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:52 INFO - 'MOZ_NO_REMOTE': '1', 18:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:52 INFO - 'NO_EM_RESTART': '1', 18:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:52 INFO - 'PWD': '/builds/slave/test', 18:25:52 INFO - 'SHELL': '/bin/bash', 18:25:52 INFO - 'SHLVL': '1', 18:25:52 INFO - 'TERM': 'linux', 18:25:52 INFO - 'TMOUT': '86400', 18:25:52 INFO - 'USER': 'cltbld', 18:25:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:52 INFO - '_': '/tools/buildbot/bin/python'} 18:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:52 INFO - Running setup.py (path:/tmp/pip-R1D0eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:53 INFO - Running setup.py (path:/tmp/pip-l455Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:53 INFO - Running setup.py (path:/tmp/pip-IhYENe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:53 INFO - Running setup.py (path:/tmp/pip-acqlGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:53 INFO - Running setup.py (path:/tmp/pip-jopXWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:53 INFO - Running setup.py (path:/tmp/pip-g7waF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:53 INFO - Running setup.py (path:/tmp/pip-vYe0aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:53 INFO - Running setup.py (path:/tmp/pip-3JnIo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:53 INFO - Running setup.py (path:/tmp/pip-Li2FE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:53 INFO - Running setup.py (path:/tmp/pip-h4Dh9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:53 INFO - Running setup.py (path:/tmp/pip-9lp_Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:53 INFO - Running setup.py (path:/tmp/pip-Nj3uyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:53 INFO - Running setup.py (path:/tmp/pip-E3Iqxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:53 INFO - Running setup.py (path:/tmp/pip-VHYdKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:53 INFO - Running setup.py (path:/tmp/pip-s1r8Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:54 INFO - Running setup.py (path:/tmp/pip-Z0czNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:54 INFO - Running setup.py (path:/tmp/pip-QnOMKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:25:54 INFO - Running setup.py install for manifestparser 18:25:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Running setup.py install for mozcrash 18:25:54 INFO - Running setup.py install for mozdebug 18:25:54 INFO - Running setup.py install for mozdevice 18:25:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Running setup.py install for mozfile 18:25:54 INFO - Running setup.py install for mozhttpd 18:25:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Running setup.py install for mozinfo 18:25:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Running setup.py install for mozInstall 18:25:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:54 INFO - Running setup.py install for mozleak 18:25:55 INFO - Running setup.py install for mozlog 18:25:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:25:55 INFO - Running setup.py install for moznetwork 18:25:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:25:55 INFO - Running setup.py install for mozprocess 18:25:55 INFO - Running setup.py install for mozprofile 18:25:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:25:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:25:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:25:55 INFO - Running setup.py install for mozrunner 18:25:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:25:55 INFO - Running setup.py install for mozscreenshot 18:25:55 INFO - Running setup.py install for moztest 18:25:55 INFO - Running setup.py install for mozversion 18:25:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:55 INFO - Cleaning up... 18:25:55 INFO - Return code: 0 18:25:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:55 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:25:55 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 18:25:55 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 18:25:55 INFO - Using env: {'DISPLAY': ':0', 18:25:55 INFO - 'HOME': '/home/cltbld', 18:25:55 INFO - 'LANG': 'en_US.UTF-8', 18:25:55 INFO - 'LANGUAGE': 'en_US:en', 18:25:55 INFO - 'LOGNAME': 'cltbld', 18:25:55 INFO - 'MAIL': '/var/mail/cltbld', 18:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:56 INFO - 'MOZ_NO_REMOTE': '1', 18:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:56 INFO - 'NO_EM_RESTART': '1', 18:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:56 INFO - 'PWD': '/builds/slave/test', 18:25:56 INFO - 'SHELL': '/bin/bash', 18:25:56 INFO - 'SHLVL': '1', 18:25:56 INFO - 'TERM': 'linux', 18:25:56 INFO - 'TMOUT': '86400', 18:25:56 INFO - 'USER': 'cltbld', 18:25:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:56 INFO - '_': '/tools/buildbot/bin/python'} 18:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:56 INFO - Running setup.py (path:/tmp/pip-tzTPto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:56 INFO - Running setup.py (path:/tmp/pip-Wgx0Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:56 INFO - Running setup.py (path:/tmp/pip-cb8DFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:56 INFO - Running setup.py (path:/tmp/pip-x3wrIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:56 INFO - Running setup.py (path:/tmp/pip-CtIc3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:56 INFO - Running setup.py (path:/tmp/pip-McQaa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:56 INFO - Running setup.py (path:/tmp/pip-4LRmhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:56 INFO - Running setup.py (path:/tmp/pip-cRe2JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:56 INFO - Running setup.py (path:/tmp/pip-gUTEFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:56 INFO - Running setup.py (path:/tmp/pip-Jc6v99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:56 INFO - Running setup.py (path:/tmp/pip-FEv3Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:56 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)) 18:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:56 INFO - Running setup.py (path:/tmp/pip-Lemv8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:57 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)) 18:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:57 INFO - Running setup.py (path:/tmp/pip-JKVAaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:57 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)) 18:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:57 INFO - Running setup.py (path:/tmp/pip-nJh15Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:57 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)) 18:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:57 INFO - Running setup.py (path:/tmp/pip-nGhVIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:57 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)) 18:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:57 INFO - Running setup.py (path:/tmp/pip-8406Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:57 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)) 18:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:57 INFO - Running setup.py (path:/tmp/pip-Wa8nkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:57 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)) 18:25:57 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)) 18:25:57 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)) 18:25:57 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)) 18:25:57 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)) 18:25:57 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)) 18:25:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:59 INFO - Downloading blessings-1.6.tar.gz 18:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:59 INFO - Installing collected packages: blessings 18:25:59 INFO - Running setup.py install for blessings 18:25:59 INFO - Successfully installed blessings 18:25:59 INFO - Cleaning up... 18:25:59 INFO - Return code: 0 18:25:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:59 INFO - Reading from file tmpfile_stdout 18:25:59 INFO - Current package versions: 18:25:59 INFO - argparse == 1.2.1 18:25:59 INFO - blessings == 1.6 18:25:59 INFO - blobuploader == 1.2.4 18:25:59 INFO - docopt == 0.6.1 18:25:59 INFO - manifestparser == 1.1 18:25:59 INFO - mozInstall == 1.12 18:25:59 INFO - mozcrash == 0.17 18:25:59 INFO - mozdebug == 0.1 18:25:59 INFO - mozdevice == 0.48 18:25:59 INFO - mozfile == 1.2 18:25:59 INFO - mozhttpd == 0.7 18:25:59 INFO - mozinfo == 0.9 18:25:59 INFO - mozleak == 0.1 18:25:59 INFO - mozlog == 3.2 18:25:59 INFO - moznetwork == 0.27 18:25:59 INFO - mozprocess == 0.22 18:25:59 INFO - mozprofile == 0.28 18:25:59 INFO - mozrunner == 6.11 18:25:59 INFO - mozscreenshot == 0.1 18:25:59 INFO - mozsystemmonitor == 0.3 18:26:00 INFO - moztest == 0.7 18:26:00 INFO - mozversion == 1.4 18:26:00 INFO - psutil == 3.1.1 18:26:00 INFO - requests == 1.2.3 18:26:00 INFO - wsgiref == 0.1.2 18:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:00 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')]} 18:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:00 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')]} 18:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:00 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:26:00 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 18:26:00 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 18:26:00 INFO - Using env: {'DISPLAY': ':0', 18:26:00 INFO - 'HOME': '/home/cltbld', 18:26:00 INFO - 'LANG': 'en_US.UTF-8', 18:26:00 INFO - 'LANGUAGE': 'en_US:en', 18:26:00 INFO - 'LOGNAME': 'cltbld', 18:26:00 INFO - 'MAIL': '/var/mail/cltbld', 18:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:00 INFO - 'MOZ_NO_REMOTE': '1', 18:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:00 INFO - 'NO_EM_RESTART': '1', 18:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:00 INFO - 'PWD': '/builds/slave/test', 18:26:00 INFO - 'SHELL': '/bin/bash', 18:26:00 INFO - 'SHLVL': '1', 18:26:00 INFO - 'TERM': 'linux', 18:26:00 INFO - 'TMOUT': '86400', 18:26:00 INFO - 'USER': 'cltbld', 18:26:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:00 INFO - '_': '/tools/buildbot/bin/python'} 18:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 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)) 18:26:00 INFO - Cleaning up... 18:26:00 INFO - Return code: 0 18:26:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26:00 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')]} 18:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:00 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')]} 18:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:00 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:26:00 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 18:26:00 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 18:26:00 INFO - Using env: {'DISPLAY': ':0', 18:26:00 INFO - 'HOME': '/home/cltbld', 18:26:00 INFO - 'LANG': 'en_US.UTF-8', 18:26:00 INFO - 'LANGUAGE': 'en_US:en', 18:26:00 INFO - 'LOGNAME': 'cltbld', 18:26:00 INFO - 'MAIL': '/var/mail/cltbld', 18:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:00 INFO - 'MOZ_NO_REMOTE': '1', 18:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:00 INFO - 'NO_EM_RESTART': '1', 18:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:00 INFO - 'PWD': '/builds/slave/test', 18:26:00 INFO - 'SHELL': '/bin/bash', 18:26:00 INFO - 'SHLVL': '1', 18:26:00 INFO - 'TERM': 'linux', 18:26:00 INFO - 'TMOUT': '86400', 18:26:00 INFO - 'USER': 'cltbld', 18:26:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:00 INFO - '_': '/tools/buildbot/bin/python'} 18:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:00 INFO - Downloading/unpacking jsonschema 18:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:02 INFO - Downloading/unpacking functools32 (from jsonschema) 18:26:02 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 18:26:02 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 18:26:02 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 18:26:02 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 18:26:02 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 18:26:02 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 18:26:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:02 INFO - warning: no files found matching '*.txt' 18:26:02 INFO - no previously-included directories found matching 'build' 18:26:02 INFO - no previously-included directories found matching 'dist' 18:26:02 INFO - no previously-included directories found matching '.git*' 18:26:02 INFO - Installing collected packages: jsonschema, functools32 18:26:02 INFO - Running setup.py install for functools32 18:26:02 INFO - warning: no files found matching '*.txt' 18:26:02 INFO - no previously-included directories found matching 'build' 18:26:02 INFO - no previously-included directories found matching 'dist' 18:26:02 INFO - no previously-included directories found matching '.git*' 18:26:02 INFO - Successfully installed jsonschema functools32 18:26:02 INFO - Cleaning up... 18:26:02 INFO - Return code: 0 18:26:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:02 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 0x7f3f42e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', '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 18:26:02 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 18:26:02 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 18:26:02 INFO - Using env: {'DISPLAY': ':0', 18:26:02 INFO - 'HOME': '/home/cltbld', 18:26:02 INFO - 'LANG': 'en_US.UTF-8', 18:26:02 INFO - 'LANGUAGE': 'en_US:en', 18:26:02 INFO - 'LOGNAME': 'cltbld', 18:26:02 INFO - 'MAIL': '/var/mail/cltbld', 18:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:02 INFO - 'MOZ_NO_REMOTE': '1', 18:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:02 INFO - 'NO_EM_RESTART': '1', 18:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:02 INFO - 'PWD': '/builds/slave/test', 18:26:02 INFO - 'SHELL': '/bin/bash', 18:26:02 INFO - 'SHLVL': '1', 18:26:02 INFO - 'TERM': 'linux', 18:26:02 INFO - 'TMOUT': '86400', 18:26:02 INFO - 'USER': 'cltbld', 18:26:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:02 INFO - '_': '/tools/buildbot/bin/python'} 18:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:03 INFO - Downloading/unpacking flake8 18:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:26:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:26:04 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 18:26:04 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 18:26:04 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 18:26:04 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 18:26:04 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 18:26:04 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 18:26:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:26:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:26:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:26:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:26:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:26:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:26:05 INFO - no previously-included directories found matching 'docs/_build' 18:26:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:26:05 INFO - Running setup.py install for pep8 18:26:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:26:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:26:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:26:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:26:05 INFO - no previously-included directories found matching 'docs/_build' 18:26:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:26:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:26:05 INFO - Cleaning up... 18:26:05 INFO - Return code: 0 18:26:05 INFO - Running post-action listener: _resource_record_post_action 18:26:05 INFO - Running post-action listener: _start_resource_monitoring 18:26:05 INFO - Starting resource monitoring. 18:26:05 INFO - ##### 18:26:05 INFO - ##### Finished create-virtualenv step (success) 18:26:05 INFO - ##### 18:26:05 INFO - ##### 18:26:05 INFO - ##### Running install step. 18:26:05 INFO - ##### 18:26:05 INFO - Running pre-action listener: _resource_record_pre_action 18:26:05 INFO - Running main action method: install 18:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:06 INFO - Reading from file tmpfile_stdout 18:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:06 INFO - Reading from file tmpfile_stdout 18:26:06 INFO - Output received: 18:26:06 INFO - Usage: mozinstall [options] installer 18:26:06 INFO - Options: 18:26:06 INFO - -h, --help show this help message and exit 18:26:06 INFO - -d DEST, --destination=DEST 18:26:06 INFO - Directory to install application into. [default: 18:26:06 INFO - "/builds/slave/test"] 18:26:06 INFO - --app=APP Application being installed. [default: firefox] 18:26:06 INFO - mkdir: /builds/slave/test/build/application 18:26:06 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'] 18:26:06 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 18:26:22 INFO - Reading from file tmpfile_stdout 18:26:22 INFO - Output received: 18:26:22 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:22 INFO - Running post-action listener: _resource_record_post_action 18:26:22 INFO - ##### 18:26:22 INFO - ##### Finished install step (success) 18:26:22 INFO - ##### 18:26:22 INFO - ##### 18:26:22 INFO - ##### Running run-tests step. 18:26:22 INFO - ##### 18:26:22 INFO - Running pre-action listener: _resource_record_pre_action 18:26:22 INFO - Running main action method: run_tests 18:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:22 INFO - Python 2.7.3 18:26:22 INFO - Return code: 0 18:26:22 INFO - grabbing minidump binary from tooltool 18:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:26:22 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 0x2b1b9c0>, '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 0x2b1c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:22 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 18:26:22 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 18:26:22 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 18:26:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:22 INFO - Return code: 0 18:26:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:26:23 INFO - Return code: 0 18:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 18:26:23 INFO - Using env: {'DISPLAY': ':0', 18:26:23 INFO - 'HOME': '/home/cltbld', 18:26:23 INFO - 'LANG': 'en_US.UTF-8', 18:26:23 INFO - 'LANGUAGE': 'en_US:en', 18:26:23 INFO - 'LOGNAME': 'cltbld', 18:26:23 INFO - 'MAIL': '/var/mail/cltbld', 18:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:23 INFO - 'MOZ_NO_REMOTE': '1', 18:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:23 INFO - 'NO_EM_RESTART': '1', 18:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:23 INFO - 'PWD': '/builds/slave/test', 18:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:23 INFO - 'SHELL': '/bin/bash', 18:26:23 INFO - 'SHLVL': '1', 18:26:23 INFO - 'TERM': 'linux', 18:26:23 INFO - 'TMOUT': '86400', 18:26:23 INFO - 'USER': 'cltbld', 18:26:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032', 18:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:23 INFO - '_': '/tools/buildbot/bin/python'} 18:26:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:26:23 INFO - mozversion application_buildid: 20160523172042 18:26:23 INFO - mozversion application_changeset: b3835efbf422b78ea753a5072d3e25986b7df180 18:26:23 INFO - mozversion application_display_name: Nightly 18:26:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:23 INFO - mozversion application_name: Firefox 18:26:23 INFO - mozversion application_remotingname: firefox 18:26:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:26:23 INFO - mozversion application_vendor: Mozilla 18:26:23 INFO - mozversion application_version: 49.0a1 18:26:23 INFO - mozversion platform_buildid: 20160523172042 18:26:23 INFO - mozversion platform_changeset: b3835efbf422b78ea753a5072d3e25986b7df180 18:26:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:26:23 INFO - mozversion platform_version: 49.0a1 18:26:23 INFO - using testdate: 1464053183 18:26:23 INFO - actual date: 1464053183 18:26:23 INFO - starting webserver on 'localhost:42424' 18:26:23 INFO - SUITE-START | Running 2 tests 18:26:23 INFO - TEST-START | dromaeo_css 18:26:23 INFO - operating with platform_type : linux_ 18:26:23 INFO - Initialising browser for dromaeo_css test... 18:26:23 INFO - TEST-INFO | started process 20972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUAjWC/profile http://localhost:42424/getInfo.html) 18:26:27 INFO - PROCESS | 20972 | __metrics Screen width/height:1600/1200 18:26:27 INFO - PROCESS | 20972 | colorDepth:24 18:26:27 INFO - PROCESS | 20972 | Browser inner width/height: 1024/697 18:26:27 INFO - PROCESS | 20972 | __metrics 18:26:28 ERROR - PROCESS | 20972 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:26:29 INFO - TEST-INFO | 20972: exit 0 18:26:29 INFO - Browser initialized. 18:26:29 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:29 INFO - TEST-INFO | started process 21053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUAjWC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:41 INFO - PROCESS | 21053 | RSS: Main: 154890240 18:26:41 INFO - PROCESS | 21053 | 18:27:32 INFO - PROCESS | 21053 | 1464053252682 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] 18:29:44 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42424/tests/dromaeo/cssquery-ext.html) 18:29:45 INFO - PROCESS | 21053 | RSS: Main: 267186176 18:29:45 INFO - PROCESS | 21053 | 18:32:48 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-ext.html (next: http://localhost:42424/tests/dromaeo/cssquery-jquery.html) 18:32:48 INFO - PROCESS | 21053 | RSS: Main: 231665664 18:32:48 INFO - PROCESS | 21053 | 18:35:50 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42424/tests/dromaeo/cssquery-mootools.html) 18:35:51 INFO - PROCESS | 21053 | RSS: Main: 240144384 18:35:51 INFO - PROCESS | 21053 | 18:38:53 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42424/tests/dromaeo/cssquery-prototype.html) 18:38:54 INFO - PROCESS | 21053 | RSS: Main: 235671552 18:38:54 INFO - PROCESS | 21053 | 18:41:56 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42424/tests/dromaeo/cssquery-yui.html) 18:41:57 INFO - PROCESS | 21053 | RSS: Main: 211468288 18:41:57 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | Cycle 1(1): loaded http://localhost:42424/tests/dromaeo/cssquery-yui.html (next: http://localhost:42424/tests/dromaeo/cssquery-dojo.html) 18:45:00 INFO - PROCESS | 21053 | RSS: Main: 267182080 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | __start_tp_report 18:45:00 INFO - PROCESS | 21053 | _x_x_mozilla_page_load 18:45:00 INFO - PROCESS | 21053 | _x_x_mozilla_page_load_details 18:45:00 INFO - PROCESS | 21053 | |i|pagename|runs| 18:45:00 INFO - PROCESS | 21053 | |0;dojo.html;2658.3752818087746;2674.933126671832;2689.95965060524;2697.069511018698;2712.7151649076854;4647.163510568105;4670.3461515387835;4702.811887524504;4747.620190384765;4825.034993001401;4691.15559199344;4713.552212539803;4717.268823332381;4760.547747963947;4774.450938142115;4153.210889930919;4283.678724095697;4365.781710914457;4393.846215382462;4524.773761311938;4433.578810013059;4448.621867141297;4480.977595112036;4489.371487991683;4513.593776560109;4282.635975942033;4324.17840610283;4347.739135651871;4367.585079417482;4403.757793321366;4358.978205108986;4375.431193944767;4406.603405693503;4406.603405693503;4419.0940857124215;4378.354404516886;4393.319035549495;4394.62645675118;4426.778661066966;4435.512093669694;4551.704139230939;4613.261878099488;4674.368960190365;4681.789319480597;4744.6441516886025;5108.846734597968;5133.358330208724;5135.974320128413;5139.743012849342;5145.048166089286;5064.797408103672;5087.135187018179;5167.044096842096;5181.041507321158;5183.092958732207;4699.5535424135;4736.502667219961;4742.099001189763;4788.377510923558;4797.088553174955;5203.843884683465;5233.39815921174;5243.9213411798855;5248.685078895279;5258.053550360895;4868.902621947541;4888.633352498577;5058.519440653132;5075.416327122354;5114.616403769732;4980.302757613937;5040.747962601855;5049.141645920203;5053.0904437200925;5065.138926382524;5036.445990940993;5038.748062596856;5077.822276220315;5079.31429257053;5082.288479612857;5015.172496538104;5015.24771284303;5023.2214006829;5027.572656324253;5074.467180945948;4195.727277726938;4198.6221240087925;4256.4679415073115;4262.147570485853;4307.7415355078165;3711.88864334065;3747.7001839852746;3757.0043938356357;3770.3024940386117;3793.6775374093513;4437.64498840092;4438.4451943507065;4441.222786012435;4441.644668426518;4491.483479399845;4999.975000124976;5112.284280200774;5119.1553393690365;5119.411267704188;5178.870528236749;4432.822687092545;4453.3320001999955;4460.375547423363;4498;4503.369528266046;4582.991741816795;4620.607248383858;4621.560951709582;4622.2835460503675;4666.020135771458;4770.308305295782;4826.420829500483;4872.317875497504;4891.877703057452;4899.706017638953;5175.560077393464;5177.0940085484135;5181.896362072662;5207.921881171861;5222.634415591024;4913.680610760289;4918.680285781413;4922.753862306942;4924.187509061108;4951.356323677899;4979.726115063561;5003.649744517995;5031.169856973558;5048.469910659328;5113.590912727047;5108.3103780989095;5120.052790233819;5127.54483011346;5128.487151284841;5144.254083157996;4987.850364489072;4988.800447982186;4989.9251511228085;4994.400671919393;5029.245613158056;4828.493008234085;4924.8276310328965;4978.900421991468;4994.800207991785;5010.824621138243;4891.33966914462;4931.038447502702;4936.481669424802;4965.925511117408;4980.651354405157;4888.853334399973;4983.6760610560195;5032.471590483093;5073.036123136592;5085.186370180753;4853.878653033561;4876.122297986397;4883.291922671264;4900.558949694545;4935.284383764406 18:45:00 INFO - PROCESS | 21053 | |1;ext.html;549.6784381137035;596.6718304932286;602.153973666998;602.3765402808094;606.9211002569665;39998.80000599997;41235.17529649405;41286.58713412865;41353.58646413535;45012.3248151278;41718.16563668725;42309.36535951963;42337.57662423383;42395;42447.78776106123;7547.54714717116;7689.730859419921;7812.10160831506;9891.406515609087;10155.441450720207;9966.352187107852;10113.494325283744;10115.645952391667;10119.747006324827;10128.088472037514;10165.695029149138;10228.181745460346;10234.846477302846;10240.539175737073;10250.333728307636;7614.2766437188375;10103.545340459697;10321.84517232242;10327.070563649308;10340.948295258551;9645.37305075168;9744.658936937172;9756.951215243878;9997.600095996151;10012.29913906027;39961.400578991335;40577.79711101425;40597.39103913444;40599.59400405988;40641.57754478609;3125.828079455629;3137.294108825519;3428.6228514863346;3451.5340429042008;3821.1593449441357;30202.84898575515;30225.395492090254;30317.393652126833;30602.38795224083;31540.842295788603;3567.5362202913716;3576.624454432299;3579.785212887235;3620.4026335654585;3643.908902277438;267172;269977;270143;270187;270302;32833.50749738756;58281.4171858276;59229;59313.406865931654;59463.405365945786;34133.65866341305;34179.82910085434;34189.48715769265;34208;34224.31551368959;10584.470776461147;11511.942440287745;11784.88215117855;11785.646430607096;11797.35114568707;8914.910850891409;9172.036936121745;9207.907920920705;9325.440473571607;9326.207272381924;8064.83870322602;8098.878516822252;8107.635156417975;8135.3898457615915;8147.959260203661;3096.752259819209;3161.762867784925;3169.122695296535;3188.007495315428;3190.1386625610953;947.5357075033185;952.7951490429591;955.5843208204315;986.363795351994;1007.2244371833793;27098.5935210972;28002;28171.154865354074;28207.153785386472;28220.717792821808;977.6773664690635;1001.379144930148;1032.5250384822916;1041.3231399590327;1111.9888801112047;13903;14798.92600537012;14984.47554335593;15006.849931500545;15330.770038449433;360248;369603;369662;369666;370223;34663.30673386518;34751.304973900886;35000.64999350025;35002.474962875574;35018.474722878665;1138.1009002887793;1178.6114919606132;1204.9036077113635;1269.3082270162784;1279.718461938372;26389.472210555297;29610.407791843612;29747.85126074356;29815.701842981292;30125.548116778704;43285.7835710832;44314.77842610766;44356.33465497955;44378.33432498579;44404.777976109915;337076;343967;347068;347078;348193;33243.50134747932;37664.81167594145;38968.154885757525;41377.37933931054;41592.58407415887;41887.162256755306;41972;41992.580074198864;42118.36822447604;42691.35962960496;35500;36164.819175905;36481.81759091187;36547.63452365442;36691.44962825506;35446.64553354433;36192.638073618924;36311.09222269464;36315.45526817153;36560;34429;34917.825410872785;35184.12039699028;35493.82253088718;35622.109447264025;31697.683023169473;33610.49584256287;33888.83055584706;34090;34097.48853767146;25297.367565811;25662.230133096036;25742.485150297263;25920.740792592587;26418.207453776417 18:45:00 INFO - PROCESS | 21053 | |2;jquery.html;366.7157952586745;367.5846293688132;372.5510759534761;374.51126280204323;383.8349509710823;16746.49760507185;17217;17397.56506087347;17646.38237661682;17739.20173592188;16564.83435165648;16981.91509042456;17583.648327033483;17671.381501647444;17686.734698979526;5103.081445339828;5215.895682086356;5295.973520132394;5296.25852380667;5301.840944771663;3585.390483617778;3790.0714324990417;3930.960690393088;5168.48315168482;5751.1373294006025;6026.8794624107495;6035.366286539916;6081.087836824468;6113.908291375633;6130.295016073142;5983.880322393549;6097.634141951475;6097.756089756404;6113.205283313141;6117.877642447148;3427.4516077427493;5037.949620503821;5183.50756678115;5378.704171270618;5378.838634840961;19795.30716424918;20482;20568;20580.58838823215;20645.17419303226;1860.962780744391;2021.7978202179665;2051.5384038591346;2111.873287602749;2508.2600632813183;13100.541481048118;13107.47570097195;13118.409671564803;13229.470821167142;13639.613067713111;1734.6530693861278;1736.9826301736948;1753.6142048749255;1769.469159252232;1815.2557451444977;66134.66932665306;66546.66726666335;66718.66640666766;68100.31899681038;68696;9584.233261339075;9597.520123993772;9861.852072218779;9942.254330925209;9955.303128780915;13666;13783.379747911367;13783.793243101361;13791.310434478237;13810.447582096804;6824.18109826814;6863.10779598659;6898.448124150056;6998.335158159966;7037.683304251321;6348.04779283102;6386.98809874888;6495.642739649365;6514.250861150934;6525.836854078686;6205.503559715212;6303;6326.4622507087415;6356.300806911236;6384.3934826191435;1718.8453039226529;1810;1826.881252718569;1836.8530517558563;1850.2506484873647;872.3457406944791;919.6229545886155;931.7856892914667;947.9099485548862;1011.7420057885192;16401.58996025109;17004.149792510325;17290.827091729174;17493.037882916306;17541.473755787345;857.3184318466834;875.8729984152262;905.5608030105394;921.3642586615214;932.8320902237663;9231.769205769775;9568.330216884751;10030.64892728751;10334.948325258476;10347.068763811143;416619;416634;421940;425173;427387;70795;74284;74911;75726;75848;951.0442005784142;951.5765484359532;965.8985806490358;967.1923943507251;987.0968064221157;15569.766453503433;15575.532734017997;15645.374185032471;15832.129232892301;16044.278007489924;30392.544111838783;32904;33582.66417335795;34227.4865877007;34339.14152146217;47124;48257.75871120622;48373;48552.75723621359;48640;7273.599952002479;7440.404767618686;7594.734184303523;7644.847103057797;7663.501872378278;9784.804303914025;10130;10494.52774625159;10569.524371403151;10893.509792059534;4678.461976872703;5818.214541036906;7582.96208518976;9185.422026828028;9603.231741460526;9046.185843274137;9202.723918282461;9290.62837486493;9552.23582113443;9583.329166958525;9300.627974880928;9355.672551460666;9587.280953928344;9614.423134611945;9877.50612469388;7132.108486439195;7295.2340004298785;7323.890141647773;7329.157146927958;7573.129090154703;8287.461315014505;9429.292803039662;9472.186868308807;9596.23230141601;9832.950835245778 18:45:00 INFO - PROCESS | 21053 | |3;mootools.html;1291.451133268362;1399.6430910117922;1452.2520901735606;1540.4069433268196;1787.2314904591028;6504.1869766279215;7571.35643470305;7806.336461400788;7811.804704882374;7992.800179995503;7727.459077864538;7856.450048496607;7858.371330293577;7859.449838511292;7908.525488470696;2195.1329224956135;2223.8109760670363;2226.7216597925258;2227.7772222777753;2229.141780414536;2153.5692861427697;2175.7715439878743;2191.868487890724;2192.572448372568;2197.3188311623367;2183.3995651195887;2185.8797766122857;2195.1658369819447;2197.198022721703;2228.799408053275;2143.0998980428258;2151.709519214902;2152.4080877758665;2152.8062474377302;2153.935381938544;2055.095757866549;2098.4019554426914;2099.1078791513696;2099.265257159982;2102.36928921323;7582.128055273659;7785.1436342002335;7809.882851757228;7816.257455541714;7830.491018083863;4298.290782020963;4451.043025749479;4455.888602784924;4460.241758900995;4464.196444639963;2903.767698584108;2927.224285564327;2985.149232468736;3008.909732708022;3043.45217860785;927.8561822917459;949.3971328206569;959.8848138223458;963.5037955452947;985.1527686189871;10636.468176591217;10695.625653102183;10712.464376781209;10724.946375268151;10743.086837618734;3933.7049721270446;4051.594840515984;4108.815103320358;4112.897177570585;4117.2588933992165;8404.117567655308;8453.746387608382;8456.957715211507;8469.280111190494;8478.491290522588;4362.1275744851155;4377.715448495837;4379.408779814684;4391.912161756747;4395.120975804852;3378.5438965739804;3847.6921846252235;3960.7821569813937;3976.204759048202;4068.816903239361;3382.5095361172985;3408.301298233856;3446.4141096013736;3448.4827275908815;3490.075130090528;1023.6417253961054;1033.194108595297;1034.4569101221919;1046.9790604187874;1048.648702684594;739.301360214592;822.7819627798638;839.6389552492487;855.5294587976588;861.401326078382;5320.14877619579;5339.81310654133;5365.812196573102;5420.593455490854;5554.1391084381985;869.3566760597113;871.5833930990532;907.8365894138987;907.9727608171765;911.2482202183226;3476.5132881396626;3680.871169509054;3758.285925674113;3798.2973149967343;3827.8468861245237;9229.538523073954;9435.386699864624;9682.612695492102;9691.418514889128;9702.369345992487;9532.666356677482;9595.616175352907;9644.132028117363;9690;9692.030796920251;7043.436525077981;7077.504574679826;7204.531705439234;7210.747623833141;7254.419646428379;5066.9746651266505;5071.619628527801;5082.771275292546;5142.280080788618;5153.278541004337;8782.165694259034;8989.910100898907;9089.409188402733;9197.540122993958;9218.21645160169;9133.497657628894;9233.076692330982;9261.814763704553;9342.205912497513;9413;5595.468430499096;6106.786262480792;6228.34602366745;6343.9682801585695;6390.584612000205;7134.964325178341;7394;7416.592087435243;7431.665575049027;7440.962795185989;6581.111549940697;6605.2734199239;6629.535932484872;6962.094927659575;7018.122734658168;6709.899351509634;6758;6797.218319893078;6800.251972283144;6866.759663411756;6486.091947127312;6500.349965003462;6543.836404089936;6556.737730490727;6559.311272316338;4143.7306575072525;4417.977910110429;4442.355858400579;4448.998975230547;4532.682712210114;4518.525554816697;4523.502414734311;4731.243001119804;4752.691075080109;4773.522647735199 18:45:00 INFO - PROCESS | 21053 | |4;prototype.html;284.2424937541452;284.8632656324964;287.57869720858946;293.87510308119056;296.64550861720255;4708.505606911276;4726.858194254178;4747.382840230765;4777.187878060734;4810.591099756516;4654.394928659278;4681;4690.710054734949;4699.788509517071;4716.103940251359;3518.5074089627537;3624.275144971003;3670;3724.7392682512236;3760.3795373763296;3713.922962340918;3739.3456145174487;3746.063484128968;3762.6989840812807;3766.6986641068784;3510.7542472026967;3706.6478684524927;3711.515393842458;3714.8699795507164;3716.293904158215;3578.3022310649435;3670.1558641512333;3708.4437334400054;3709.7774133552075;3722.7021838252876;3251.951220731691;3267.15054085937;3273.770836041478;3273.918152046194;3275.9344813103603;4525.140223357552;4539.6368290536675;4546.52261512543;4555.681102322838;4566.885827854297;3975.3440682287387;4182.498100227962;4203.369494575838;4208.768517731523;4215.936760948588;4937.753112344404;4940.802367905279;4944.87637809054;4949.653524253304;4968.3292755477905;3492.3713731528314;3495.755297129202;3504.1590018395655;3513.367593833109;3517.3844577199143;5008.424031236382;5074.868555206822;5105.897882042338;5114.769835357418;5131.820386286499;3546.627604101584;3556.626554211822;3561.9821900890847;3568.0901370150445;3582.462630605378;3586.5158203642172;3605.2789442111684;3616.27674465108;3622.3117607654463;3622.619624939396;4104.692148088905;4109.876703698834;4117.691173162025;4125.793710314472;4129.401236820704;4712.468447754493;4901.387326584177;4939.086269040167;4965.553100220997;4977.776000080005;1253.3232054690366;1259.5402678022456;1264.64589914824;1266.3351740336398;1267.7084270617809;808.1030056637128;810.1210186947111;831.7296878514386;857.9356548258905;863.2877875752404;4359.193549193409;4395.384646149541;4397.2964325707735;4397.934030989538;4422.115576884636;4908.533689299511;5006.924896126561;5045.747712614355;5055.51972562606;5057.924131138036;4245.532991370947;4355.303151495746;4360.454943132108;4364.454443194601;4368.230866499073;2662.786977041832;2677.072507794385;2691.4751623433635;2691.7039125696156;2698.8110832241555;4741.596964258077;4765.26138448541;4782.760861956888;4792.257200133985;4803.183458811941;4908.828191013297;5117.2068329409;5134.922976155361;5135.6918584885025;5154.804021506689;4790.329353890528;4790.538885639844;4803.231482962709;4817.445993710769;4820.385170967765;5015.473375295687;5022.8949631081105;5024.84925452237;5051.87370315745;5060.443351231288;4781.6891902026255;4933.802647894044;4946.925796113133;4983.925241121314;5089.592832573311;4880.6095512358215;4912.76469206503;4917.950820491749;4923.236898280772;4926.753662316942;3631.182983828723;3635.127569383382;3646.106703857572;3650.393826716236;3654.7624404413627;4962.801487940586;5075.187969924795;5109.8722531937;5117.5394214520875;5123.692578445305;4899.926501102557;4901.059364381343;4906.55840974314;4917.360743103373;4933.457319694902;4941;4945.208766597327;4948.208286674115;4956.504349565159;4958.851234462972;4714.952850471589;4850.345203397496;4879.878003049952;4883.902321953612;4892.192788189909;4724.834630787906;4834.5890599299455;4932.3094766731965;4957.677750946177;4966.379202599675;4798.688085274446;4842.685225460334;4849.830255941025;4875.219964805614;4894.535019173173 18:45:00 INFO - PROCESS | 21053 | |5;yui.html;668.8996650502424;724.4168444402255;733.7101844771315;767.5624893810531;788.0307222116793;12489.562865299717;12627.305498197595;12644.241345519275;12649.873501264985;12662.43019064142;13067.673308167301;13591.728165436685;13602.795958060613;14157.29213539324;14194.71610567788;640.3756337570878;792.6987744657037;793.9126696063457;796.6216047377508;797.2904115337326;791.4064451661254;813.4224700462679;813.5078277642031;815.0748899998515;817.456391499652;844.1769274956898;848.9066202717696;851.8211175653089;853.2235665544356;853.6841368693592;660.2835923023525;827.0488937721608;845.5772113943028;845.8815765792793;846.4328899637227;625.5652321636464;627.7143899525705;628.3684896678809;628.7516431009772;629.1694962649304;13217.273049982246;13271.800922986164;13277.668058298523;13293.73412531744;13304.13523120994;11525.596604118815;12018.87981120195;12134.635960921098;12252.958498527636;12409.813852792215;10059.295849290553;10081.49592520371;10121.139703125244;10246.077852993267;10322.122619577345;3319.2531680371962;3343.9832800836084;3360.2439451123546;3399.4220982433044;3419.777714448553;47591.28613070807;47658.761706191246;47728.28407573889;48304.758476207746;48850.75574622104;9592.95203523978;9770.560324785401;9889.159421449114;9905.504724763878;9920.305578609572;17058.914705426643;17177.742333865;17210.39763608268;17248.741268880978;17343.56641083983;6450.548461607643;6506.512011599054;6515;6518.185226846645;6738.696758645872;3742.5134732484603;3867.245887052054;3904.6003669216457;3915.353966595537;3996.4604778355133;2642.1016854269255;2758.158761577698;2765.861706914646;2775.9028434004713;2786.9442611147665;529.0582762682432;529.1533546325848;536.5787856532603;540.0953403049875;544.1130956540813;581.282116586016;641.5060403489288;643.9420452159328;660.1747815230962;660.428729149292;8116.715914943066;8212.794680133044;8315.376346774015;8470.0393294552;8556.700515482053;539.6734975339941;552.9419410961872;572.9026065568863;639.9808005759835;640.3596403596404;3818.59904710007;3921.2157568485845;3932.9803350983634;3958.6437220650278;4025.75845449274;51758.482415175364;55141.44858551363;55292.44707552953;55443.61390965258;55514.16728749072;46286.768566156956;49138.26292605614;49383.50616493861;49643.75178124086;51698.48301517012;44991.32513012308;45167;45440.77279613581;45534;45786.77106614512;7527;7586.089669239505;7627.389808815393;7715.691372345043;7734.303912647889;28617.14148575546;30754.53868191934;31042.379152417278;31795.682043179273;32702.50946235856;36973.26053478861;40190;40715.592844072366;41037;41553.58446415497;10419.111276148038;10473.738156546147;10742.624008159677;10972.506237219184;11239.66281011571;11575.71060723455;11613.187076904536;12395.93802030984;12869.613911582668;13013.544525941546;11101.944490277498;11163.832542511705;11312.264702794291;11353.148513861328;11564.47959841826;11275.718107047389;11383.886161138282;11453.54390723129;11509.769804604028;11665.183437159656;11245.38150401703;11314.264572802742;11401.144914131308;11522.308661480338;11544.422778861192;9316.301277404358;9347.298952578447;9412.717618471457;9688.70933871985;9744.512774361112;9074.682386116718;9250.444973301623;9307.767305817139;9350.345475816628;9421.717348479557 18:45:00 INFO - PROCESS | 21053 | __end_tp_report 18:45:00 INFO - PROCESS | 21053 | __start_cc_report 18:45:00 INFO - PROCESS | 21053 | _x_x_mozilla_cycle_collect,1046 18:45:00 INFO - PROCESS | 21053 | __end_cc_report 18:45:00 INFO - PROCESS | 21053 | __startTimestamp1464054300541__endTimestamp 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | ------- Summary: start ------- 18:45:00 INFO - PROCESS | 21053 | Number of tests: 6 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | [#0] dojo.html Cycles:165 Average:4718.61 Median:4883.29 stddev:495.50 (10.1%) stddev-sans-first:469.92 18:45:00 INFO - PROCESS | 21053 | Values: 2658.4 2674.9 2690.0 2697.1 2712.7 4647.2 4670.3 4702.8 4747.6 4825.0 4691.2 4713.6 4717.3 4760.5 4774.5 4153.2 4283.7 4365.8 4393.8 4524.8 4433.6 4448.6 4481.0 4489.4 4513.6 4282.6 4324.2 4347.7 4367.6 4403.8 4359.0 4375.4 4406.6 4406.6 4419.1 4378.4 4393.3 4394.6 4426.8 4435.5 4551.7 4613.3 4674.4 4681.8 4744.6 5108.8 5133.4 5136.0 5139.7 5145.0 5064.8 5087.1 5167.0 5181.0 5183.1 4699.6 4736.5 4742.1 4788.4 4797.1 5203.8 5233.4 5243.9 5248.7 5258.1 4868.9 4888.6 5058.5 5075.4 5114.6 4980.3 5040.7 5049.1 5053.1 5065.1 5036.4 5038.7 5077.8 5079.3 5082.3 5015.2 5015.2 5023.2 5027.6 5074.5 4195.7 4198.6 4256.5 4262.1 4307.7 3711.9 3747.7 3757.0 3770.3 3793.7 4437.6 4438.4 4441.2 4441.6 4491.5 5000.0 5112.3 5119.2 5119.4 5178.9 4432.8 4453.3 4460.4 4498.0 4503.4 4583.0 4620.6 4621.6 4622.3 4666.0 4770.3 4826.4 4872.3 4891.9 4899.7 5175.6 5177.1 5181.9 5207.9 5222.6 4913.7 4918.7 4922.8 4924.2 4951.4 4979.7 5003.6 5031.2 5048.5 5113.6 5108.3 5120.1 5127.5 5128.5 5144.3 4987.9 4988.8 4989.9 4994.4 5029.2 4828.5 4924.8 4978.9 4994.8 5010.8 4891.3 4931.0 4936.5 4965.9 4980.7 4888.9 4983.7 5032.5 5073.0 5085.2 4853.9 4876.1 4883.3 4900.6 4935.3 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | [#1] ext.html Cycles:180 Average:47636.96 Median:35001.56 stddev:86868.31 (248.2%) stddev-sans-first:87040.06 18:45:00 INFO - PROCESS | 21053 | Values: 549.7 596.7 602.2 602.4 606.9 39998.8 41235.2 41286.6 41353.6 45012.3 41718.2 42309.4 42337.6 42395.0 42447.8 7547.5 7689.7 7812.1 9891.4 10155.4 9966.4 10113.5 10115.6 10119.7 10128.1 10165.7 10228.2 10234.8 10240.5 10250.3 7614.3 10103.5 10321.8 10327.1 10340.9 9645.4 9744.7 9757.0 9997.6 10012.3 39961.4 40577.8 40597.4 40599.6 40641.6 3125.8 3137.3 3428.6 3451.5 3821.2 30202.8 30225.4 30317.4 30602.4 31540.8 3567.5 3576.6 3579.8 3620.4 3643.9 267172.0 269977.0 270143.0 270187.0 270302.0 32833.5 58281.4 59229.0 59313.4 59463.4 34133.7 34179.8 34189.5 34208.0 34224.3 10584.5 11511.9 11784.9 11785.6 11797.4 8914.9 9172.0 9207.9 9325.4 9326.2 8064.8 8098.9 8107.6 8135.4 8148.0 3096.8 3161.8 3169.1 3188.0 3190.1 947.5 952.8 955.6 986.4 1007.2 27098.6 28002.0 28171.2 28207.2 28220.7 977.7 1001.4 1032.5 1041.3 1112.0 13903.0 14798.9 14984.5 15006.8 15330.8 360248.0 369603.0 369662.0 369666.0 370223.0 34663.3 34751.3 35000.6 35002.5 35018.5 1138.1 1178.6 1204.9 1269.3 1279.7 26389.5 29610.4 29747.9 29815.7 30125.5 43285.8 44314.8 44356.3 44378.3 44404.8 337076.0 343967.0 347068.0 347078.0 348193.0 33243.5 37664.8 38968.2 41377.4 41592.6 41887.2 41972.0 41992.6 42118.4 42691.4 35500.0 36164.8 36481.8 36547.6 36691.4 35446.6 36192.6 36311.1 36315.5 36560.0 34429.0 34917.8 35184.1 35493.8 35622.1 31697.7 33610.5 33888.8 34090.0 34097.5 25297.4 25662.2 25742.5 25920.7 26418.2 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | [#2] jquery.html Cycles:180 Average:24863.99 Median:5340.27 stddev:69291.07 (1297.5%) stddev-sans-first:69461.03 18:45:00 INFO - PROCESS | 21053 | Values: 366.7 367.6 372.6 374.5 383.8 16746.5 17217.0 17397.6 17646.4 17739.2 16564.8 16981.9 17583.6 17671.4 17686.7 5103.1 5215.9 5296.0 5296.3 5301.8 3585.4 3790.1 3931.0 5168.5 5751.1 6026.9 6035.4 6081.1 6113.9 6130.3 5983.9 6097.6 6097.8 6113.2 6117.9 3427.5 5037.9 5183.5 5378.7 5378.8 19795.3 20482.0 20568.0 20580.6 20645.2 1861.0 2021.8 2051.5 2111.9 2508.3 13100.5 13107.5 13118.4 13229.5 13639.6 1734.7 1737.0 1753.6 1769.5 1815.3 66134.7 66546.7 66718.7 68100.3 68696.0 9584.2 9597.5 9861.9 9942.3 9955.3 13666.0 13783.4 13783.8 13791.3 13810.4 6824.2 6863.1 6898.4 6998.3 7037.7 6348.0 6387.0 6495.6 6514.3 6525.8 6205.5 6303.0 6326.5 6356.3 6384.4 1718.8 1810.0 1826.9 1836.9 1850.3 872.3 919.6 931.8 947.9 1011.7 16401.6 17004.1 17290.8 17493.0 17541.5 857.3 875.9 905.6 921.4 932.8 9231.8 9568.3 10030.6 10334.9 10347.1 416619.0 416634.0 421940.0 425173.0 427387.0 70795.0 74284.0 74911.0 75726.0 75848.0 951.0 951.6 965.9 967.2 987.1 15569.8 15575.5 15645.4 15832.1 16044.3 30392.5 32904.0 33582.7 34227.5 34339.1 47124.0 48257.8 48373.0 48552.8 48640.0 7273.6 7440.4 7594.7 7644.8 7663.5 9784.8 10130.0 10494.5 10569.5 10893.5 4678.5 5818.2 7583.0 9185.4 9603.2 9046.2 9202.7 9290.6 9552.2 9583.3 9300.6 9355.7 9587.3 9614.4 9877.5 7132.1 7295.2 7323.9 7329.2 7573.1 8287.5 9429.3 9472.2 9596.2 9833.0 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | [#3] mootools.html Cycles:180 Average:5082.92 Median:5329.98 stddev:2868.51 (53.8%) stddev-sans-first:2862.40 18:45:00 INFO - PROCESS | 21053 | Values: 1291.5 1399.6 1452.3 1540.4 1787.2 6504.2 7571.4 7806.3 7811.8 7992.8 7727.5 7856.5 7858.4 7859.4 7908.5 2195.1 2223.8 2226.7 2227.8 2229.1 2153.6 2175.8 2191.9 2192.6 2197.3 2183.4 2185.9 2195.2 2197.2 2228.8 2143.1 2151.7 2152.4 2152.8 2153.9 2055.1 2098.4 2099.1 2099.3 2102.4 7582.1 7785.1 7809.9 7816.3 7830.5 4298.3 4451.0 4455.9 4460.2 4464.2 2903.8 2927.2 2985.1 3008.9 3043.5 927.9 949.4 959.9 963.5 985.2 10636.5 10695.6 10712.5 10724.9 10743.1 3933.7 4051.6 4108.8 4112.9 4117.3 8404.1 8453.7 8457.0 8469.3 8478.5 4362.1 4377.7 4379.4 4391.9 4395.1 3378.5 3847.7 3960.8 3976.2 4068.8 3382.5 3408.3 3446.4 3448.5 3490.1 1023.6 1033.2 1034.5 1047.0 1048.6 739.3 822.8 839.6 855.5 861.4 5320.1 5339.8 5365.8 5420.6 5554.1 869.4 871.6 907.8 908.0 911.2 3476.5 3680.9 3758.3 3798.3 3827.8 9229.5 9435.4 9682.6 9691.4 9702.4 9532.7 9595.6 9644.1 9690.0 9692.0 7043.4 7077.5 7204.5 7210.7 7254.4 5067.0 5071.6 5082.8 5142.3 5153.3 8782.2 8989.9 9089.4 9197.5 9218.2 9133.5 9233.1 9261.8 9342.2 9413.0 5595.5 6106.8 6228.3 6344.0 6390.6 7135.0 7394.0 7416.6 7431.7 7441.0 6581.1 6605.3 6629.5 6962.1 7018.1 6709.9 6758.0 6797.2 6800.3 6866.8 6486.1 6500.3 6543.8 6556.7 6559.3 4143.7 4418.0 4442.4 4449.0 4532.7 4518.5 4523.5 4731.2 4752.7 4773.5 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | [#4] prototype.html Cycles:180 Average:4095.78 Median:4713.71 stddev:1185.76 (25.2%) stddev-sans-first:1154.06 18:45:00 INFO - PROCESS | 21053 | Values: 284.2 284.9 287.6 293.9 296.6 4708.5 4726.9 4747.4 4777.2 4810.6 4654.4 4681.0 4690.7 4699.8 4716.1 3518.5 3624.3 3670.0 3724.7 3760.4 3713.9 3739.3 3746.1 3762.7 3766.7 3510.8 3706.6 3711.5 3714.9 3716.3 3578.3 3670.2 3708.4 3709.8 3722.7 3252.0 3267.2 3273.8 3273.9 3275.9 4525.1 4539.6 4546.5 4555.7 4566.9 3975.3 4182.5 4203.4 4208.8 4215.9 4937.8 4940.8 4944.9 4949.7 4968.3 3492.4 3495.8 3504.2 3513.4 3517.4 5008.4 5074.9 5105.9 5114.8 5131.8 3546.6 3556.6 3562.0 3568.1 3582.5 3586.5 3605.3 3616.3 3622.3 3622.6 4104.7 4109.9 4117.7 4125.8 4129.4 4712.5 4901.4 4939.1 4965.6 4977.8 1253.3 1259.5 1264.6 1266.3 1267.7 808.1 810.1 831.7 857.9 863.3 4359.2 4395.4 4397.3 4397.9 4422.1 4908.5 5006.9 5045.7 5055.5 5057.9 4245.5 4355.3 4360.5 4364.5 4368.2 2662.8 2677.1 2691.5 2691.7 2698.8 4741.6 4765.3 4782.8 4792.3 4803.2 4908.8 5117.2 5134.9 5135.7 5154.8 4790.3 4790.5 4803.2 4817.4 4820.4 5015.5 5022.9 5024.8 5051.9 5060.4 4781.7 4933.8 4946.9 4983.9 5089.6 4880.6 4912.8 4918.0 4923.2 4926.8 3631.2 3635.1 3646.1 3650.4 3654.8 4962.8 5075.2 5109.9 5117.5 5123.7 4899.9 4901.1 4906.6 4917.4 4933.5 4941.0 4945.2 4948.2 4956.5 4958.9 4715.0 4850.3 4879.9 4883.9 4892.2 4724.8 4834.6 4932.3 4957.7 4966.4 4798.7 4842.7 4849.8 4875.2 4894.5 18:45:00 INFO - PROCESS | 21053 | 18:45:00 INFO - PROCESS | 21053 | [#5] yui.html Cycles:180 Average:13223.05 Median:46939.03 stddev:15208.34 (32.4%) stddev-sans-first:15221.78 18:45:00 INFO - PROCESS | 21053 | Values: 668.9 724.4 733.7 767.6 788.0 12489.6 12627.3 12644.2 12649.9 12662.4 13067.7 13591.7 13602.8 14157.3 14194.7 640.4 792.7 793.9 796.6 797.3 791.4 813.4 813.5 815.1 817.5 844.2 848.9 851.8 853.2 853.7 660.3 827.0 845.6 845.9 846.4 625.6 627.7 628.4 628.8 629.2 13217.3 13271.8 13277.7 13293.7 13304.1 11525.6 12018.9 12134.6 12253.0 12409.8 10059.3 10081.5 10121.1 10246.1 10322.1 3319.3 3344.0 3360.2 3399.4 3419.8 47591.3 47658.8 47728.3 48304.8 48850.8 9593.0 9770.6 9889.2 9905.5 9920.3 17058.9 17177.7 17210.4 17248.7 17343.6 6450.5 6506.5 6515.0 6518.2 6738.7 3742.5 3867.2 3904.6 3915.4 3996.5 2642.1 2758.2 2765.9 2775.9 2786.9 529.1 529.2 536.6 540.1 544.1 581.3 641.5 643.9 660.2 660.4 8116.7 8212.8 8315.4 8470.0 8556.7 539.7 552.9 572.9 640.0 640.4 3818.6 3921.2 3933.0 3958.6 4025.8 51758.5 55141.4 55292.4 55443.6 55514.2 46286.8 49138.3 49383.5 49643.8 51698.5 44991.3 45167.0 45440.8 45534.0 45786.8 7527.0 7586.1 7627.4 7715.7 7734.3 28617.1 30754.5 31042.4 31795.7 32702.5 36973.3 40190.0 40715.6 41037.0 41553.6 10419.1 10473.7 10742.6 10972.5 11239.7 11575.7 11613.2 12395.9 12869.6 13013.5 11101.9 11163.8 11312.3 11353.1 11564.5 11275.7 11383.9 11453.5 11509.8 11665.2 11245.4 11314.3 11401.1 11522.3 11544.4 9316.3 9347.3 9412.7 9688.7 9744.5 9074.7 9250.4 9307.8 9350.3 9421.7 18:45:00 INFO - PROCESS | 21053 | -------- Summary: end -------- 18:45:00 INFO - PROCESS | 21053 | 18:45:01 INFO - TEST-INFO | 21053: exit 0 18:45:01 INFO - TEST-OK | dromaeo_css | took 1118065ms 18:45:01 INFO - TEST-START | kraken 18:45:01 INFO - operating with platform_type : linux_ 18:45:01 INFO - Initialising browser for kraken test... 18:45:01 INFO - TEST-INFO | started process 21228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpivFbE9/profile http://localhost:42424/getInfo.html) 18:45:05 INFO - PROCESS | 21228 | __metrics Screen width/height:1600/1200 18:45:05 INFO - PROCESS | 21228 | colorDepth:24 18:45:05 INFO - PROCESS | 21228 | Browser inner width/height: 1024/697 18:45:05 INFO - PROCESS | 21228 | __metrics 18:45:06 ERROR - PROCESS | 21228 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:45:07 INFO - TEST-INFO | 21228: exit 0 18:45:07 INFO - Browser initialized. 18:45:07 INFO - Running cycle 1/1 for kraken test... 18:45:07 INFO - TEST-INFO | started process 21308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpivFbE9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:19 INFO - PROCESS | 21308 | RSS: Main: 155025408 18:45:19 INFO - PROCESS | 21308 | 18:45:21 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:22 INFO - PROCESS | 21308 | RSS: Main: 210866176 18:45:22 INFO - PROCESS | 21308 | 18:45:25 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-dft) 18:45:26 INFO - PROCESS | 21308 | RSS: Main: 198410240 18:45:26 INFO - PROCESS | 21308 | 18:45:29 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-fft) 18:45:30 INFO - PROCESS | 21308 | RSS: Main: 267239424 18:45:30 INFO - PROCESS | 21308 | 18:45:32 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42424/tests/kraken/driver.html?testName=audio-oscillator) 18:45:33 INFO - PROCESS | 21308 | RSS: Main: 176398336 18:45:33 INFO - PROCESS | 21308 | 18:45:35 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:36 INFO - PROCESS | 21308 | RSS: Main: 181174272 18:45:36 INFO - PROCESS | 21308 | 18:45:39 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:40 INFO - PROCESS | 21308 | RSS: Main: 216711168 18:45:40 INFO - PROCESS | 21308 | 18:45:43 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42424/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:44 INFO - PROCESS | 21308 | RSS: Main: 215568384 18:45:44 INFO - PROCESS | 21308 | 18:45:47 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42424/tests/kraken/driver.html?testName=json-parse-financial) 18:45:47 INFO - PROCESS | 21308 | RSS: Main: 215793664 18:45:47 INFO - PROCESS | 21308 | 18:45:49 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:50 INFO - PROCESS | 21308 | RSS: Main: 210272256 18:45:50 INFO - PROCESS | 21308 | 18:45:52 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:52 INFO - PROCESS | 21308 | RSS: Main: 213950464 18:45:52 INFO - PROCESS | 21308 | 18:45:55 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:55 INFO - PROCESS | 21308 | RSS: Main: 218198016 18:45:55 INFO - PROCESS | 21308 | 18:45:58 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:59 INFO - PROCESS | 21308 | RSS: Main: 221933568 18:45:59 INFO - PROCESS | 21308 | 18:46:02 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:03 INFO - PROCESS | 21308 | RSS: Main: 220356608 18:46:03 INFO - PROCESS | 21308 | 18:46:04 INFO - PROCESS | 21308 | Cycle 1(1): loaded http://localhost:42424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42424/tests/kraken/driver.html?testName=ai-astar) 18:46:05 INFO - PROCESS | 21308 | RSS: Main: 266428416 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | __start_tp_report 18:46:05 INFO - PROCESS | 21308 | _x_x_mozilla_page_load 18:46:05 INFO - PROCESS | 21308 | _x_x_mozilla_page_load_details 18:46:05 INFO - PROCESS | 21308 | |i|pagename|runs| 18:46:05 INFO - PROCESS | 21308 | |0;ai-astar;114;111;113;113;114;113;114;113;113;114 18:46:05 INFO - PROCESS | 21308 | |1;audio-beat-detection;154;135;129;194;137;152;153;131;195;131 18:46:05 INFO - PROCESS | 21308 | |2;audio-dft;162;162;161;162;161;161;161;161;162;161 18:46:05 INFO - PROCESS | 21308 | |3;audio-fft;76;77;74;137;75;75;75;78;112;75 18:46:05 INFO - PROCESS | 21308 | |4;audio-oscillator;94;95;153;93;93;93;123;92;94;135 18:46:05 INFO - PROCESS | 21308 | |5;imaging-gaussian-blur;117;116;116;117;117;119;117;117;117;117 18:46:05 INFO - PROCESS | 21308 | |6;imaging-darkroom;146;148;146;147;146;146;146;146;146;145 18:46:05 INFO - PROCESS | 21308 | |7;imaging-desaturate;95;94;95;95;95;95;94;95;95;95 18:46:05 INFO - PROCESS | 21308 | |8;json-parse-financial;65;64;64;64;65;65;65;69;65;65 18:46:05 INFO - PROCESS | 21308 | |9;json-stringify-tinderbox;64;66;65;64;65;65;64;65;65;65 18:46:05 INFO - PROCESS | 21308 | |10;stanford-crypto-aes;84;82;86;82;86;82;80;89;151;84 18:46:05 INFO - PROCESS | 21308 | |11;stanford-crypto-ccm;137;145;142;132;133;127;130;128;164;133 18:46:05 INFO - PROCESS | 21308 | |12;stanford-crypto-pbkdf2;171;171;172;171;172;171;169;173;170;168 18:46:05 INFO - PROCESS | 21308 | |13;stanford-crypto-sha256-iterative;67;69;66;67;66;67;67;66;65;65 18:46:05 INFO - PROCESS | 21308 | __end_tp_report 18:46:05 INFO - PROCESS | 21308 | __start_cc_report 18:46:05 INFO - PROCESS | 21308 | _x_x_mozilla_cycle_collect,2135 18:46:05 INFO - PROCESS | 21308 | __end_cc_report 18:46:05 INFO - PROCESS | 21308 | __startTimestamp1464054365103__endTimestamp 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | ------- Summary: start ------- 18:46:05 INFO - PROCESS | 21308 | Number of tests: 14 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:0.92 (0.8%) stddev-sans-first:0.93 18:46:05 INFO - PROCESS | 21308 | Values: 114.0 111.0 113.0 113.0 114.0 113.0 114.0 113.0 113.0 114.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:152.50 stddev:24.80 (16.3%) stddev-sans-first:26.28 18:46:05 INFO - PROCESS | 21308 | Values: 154.0 135.0 129.0 194.0 137.0 152.0 153.0 131.0 195.0 131.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 18:46:05 INFO - PROCESS | 21308 | Values: 162.0 162.0 161.0 162.0 161.0 161.0 161.0 161.0 162.0 161.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:21.46 (28.6%) stddev-sans-first:22.50 18:46:05 INFO - PROCESS | 21308 | Values: 76.0 77.0 74.0 137.0 75.0 75.0 75.0 78.0 112.0 75.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:22.23 (23.9%) stddev-sans-first:23.12 18:46:05 INFO - PROCESS | 21308 | Values: 94.0 95.0 153.0 93.0 93.0 93.0 123.0 92.0 94.0 135.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 18:46:05 INFO - PROCESS | 21308 | Values: 117.0 116.0 116.0 117.0 117.0 119.0 117.0 117.0 117.0 117.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 18:46:05 INFO - PROCESS | 21308 | Values: 146.0 148.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:46:05 INFO - PROCESS | 21308 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.54 18:46:05 INFO - PROCESS | 21308 | Values: 65.0 64.0 64.0 64.0 65.0 65.0 65.0 69.0 65.0 65.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 18:46:05 INFO - PROCESS | 21308 | Values: 64.0 66.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:84.00 stddev:21.38 (25.5%) stddev-sans-first:22.54 18:46:05 INFO - PROCESS | 21308 | Values: 84.0 82.0 86.0 82.0 86.0 82.0 80.0 89.0 151.0 84.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:135.00 stddev:11.08 (8.2%) stddev-sans-first:11.75 18:46:05 INFO - PROCESS | 21308 | Values: 137.0 145.0 142.0 132.0 133.0 127.0 130.0 128.0 164.0 133.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 18:46:05 INFO - PROCESS | 21308 | Values: 171.0 171.0 172.0 171.0 172.0 171.0 169.0 173.0 170.0 168.0 18:46:05 INFO - PROCESS | 21308 | 18:46:05 INFO - PROCESS | 21308 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 18:46:05 INFO - PROCESS | 21308 | Values: 67.0 69.0 66.0 67.0 66.0 67.0 67.0 66.0 65.0 65.0 18:46:05 INFO - PROCESS | 21308 | -------- Summary: end -------- 18:46:05 INFO - PROCESS | 21308 | 18:46:06 INFO - TEST-INFO | 21308: exit 0 18:46:06 INFO - TEST-OK | kraken | took 64952ms 18:46:06 INFO - SUITE-END | took 1183s 18:46:06 INFO - Completed test suite (00:19:43) 18:46:06 INFO - javascript benchmark 18:46:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2658.3752818087746, 2674.933126671832, 2689.95965060524, 2697.069511018698, 2712.7151649076854, 4647.163510568105, 4670.3461515387835, 4702.811887524504, 4747.620190384765, 4825.034993001401, 4691.15559199344, 4713.552212539803, 4717.268823332381, 4760.547747963947, 4774.450938142115, 4153.210889930919, 4283.678724095697, 4365.781710914457, 4393.846215382462, 4524.773761311938, 4433.578810013059, 4448.621867141297, 4480.977595112036, 4489.371487991683, 4513.593776560109, 4282.635975942033, 4324.17840610283, 4347.739135651871, 4367.585079417482, 4403.757793321366, 4358.978205108986, 4375.431193944767, 4406.603405693503, 4406.603405693503, 4419.0940857124215, 4378.354404516886, 4393.319035549495, 4394.62645675118, 4426.778661066966, 4435.512093669694, 4551.704139230939, 4613.261878099488, 4674.368960190365, 4681.789319480597, 4744.6441516886025, 5108.846734597968, 5133.358330208724, 5135.974320128413, 5139.743012849342, 5145.048166089286, 5064.797408103672, 5087.135187018179, 5167.044096842096, 5181.041507321158, 5183.092958732207, 4699.5535424135, 4736.502667219961, 4742.099001189763, 4788.377510923558, 4797.088553174955, 5203.843884683465, 5233.39815921174, 5243.9213411798855, 5248.685078895279, 5258.053550360895, 4868.902621947541, 4888.633352498577, 5058.519440653132, 5075.416327122354, 5114.616403769732, 4980.302757613937, 5040.747962601855, 5049.141645920203, 5053.0904437200925, 5065.138926382524, 5036.445990940993, 5038.748062596856, 5077.822276220315, 5079.31429257053, 5082.288479612857, 5015.172496538104, 5015.24771284303, 5023.2214006829, 5027.572656324253, 5074.467180945948, 4195.727277726938, 4198.6221240087925, 4256.4679415073115, 4262.147570485853, 4307.7415355078165, 3711.88864334065, 3747.7001839852746, 3757.0043938356357, 3770.3024940386117, 3793.6775374093513, 4437.64498840092, 4438.4451943507065, 4441.222786012435, 4441.644668426518, 4491.483479399845, 4999.975000124976, 5112.284280200774, 5119.1553393690365, 5119.411267704188, 5178.870528236749, 4432.822687092545, 4453.3320001999955, 4460.375547423363, 4498.0, 4503.369528266046, 4582.991741816795, 4620.607248383858, 4621.560951709582, 4622.2835460503675, 4666.020135771458, 4770.308305295782, 4826.420829500483, 4872.317875497504, 4891.877703057452, 4899.706017638953, 5175.560077393464, 5177.0940085484135, 5181.896362072662, 5207.921881171861, 5222.634415591024, 4913.680610760289, 4918.680285781413, 4922.753862306942, 4924.187509061108, 4951.356323677899, 4979.726115063561, 5003.649744517995, 5031.169856973558, 5048.469910659328, 5113.590912727047, 5108.3103780989095, 5120.052790233819, 5127.54483011346, 5128.487151284841, 5144.254083157996, 4987.850364489072, 4988.800447982186, 4989.9251511228085, 4994.400671919393, 5029.245613158056, 4828.493008234085, 4924.8276310328965, 4978.900421991468, 4994.800207991785, 5010.824621138243, 4891.33966914462, 4931.038447502702, 4936.481669424802, 4965.925511117408, 4980.651354405157, 4888.853334399973, 4983.6760610560195, 5032.471590483093, 5073.036123136592, 5085.186370180753, 4853.878653033561, 4876.122297986397, 4883.291922671264, 4900.558949694545, 4935.284383764406], "value": 4687.070542051941, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.6784381137035, 596.6718304932286, 602.153973666998, 602.3765402808094, 606.9211002569665, 39998.80000599997, 41235.17529649405, 41286.58713412865, 41353.58646413535, 45012.3248151278, 41718.16563668725, 42309.36535951963, 42337.57662423383, 42395.0, 42447.78776106123, 7547.54714717116, 7689.730859419921, 7812.10160831506, 9891.406515609087, 10155.441450720207, 9966.352187107852, 10113.494325283744, 10115.645952391667, 10119.747006324827, 10128.088472037514, 10165.695029149138, 10228.181745460346, 10234.846477302846, 10240.539175737073, 10250.333728307636, 7614.2766437188375, 10103.545340459697, 10321.84517232242, 10327.070563649308, 10340.948295258551, 9645.37305075168, 9744.658936937172, 9756.951215243878, 9997.600095996151, 10012.29913906027, 39961.400578991335, 40577.79711101425, 40597.39103913444, 40599.59400405988, 40641.57754478609, 3125.828079455629, 3137.294108825519, 3428.6228514863346, 3451.5340429042008, 3821.1593449441357, 30202.84898575515, 30225.395492090254, 30317.393652126833, 30602.38795224083, 31540.842295788603, 3567.5362202913716, 3576.624454432299, 3579.785212887235, 3620.4026335654585, 3643.908902277438, 267172.0, 269977.0, 270143.0, 270187.0, 270302.0, 32833.50749738756, 58281.4171858276, 59229.0, 59313.406865931654, 59463.405365945786, 34133.65866341305, 34179.82910085434, 34189.48715769265, 34208.0, 34224.31551368959, 10584.470776461147, 11511.942440287745, 11784.88215117855, 11785.646430607096, 11797.35114568707, 8914.910850891409, 9172.036936121745, 9207.907920920705, 9325.440473571607, 9326.207272381924, 8064.83870322602, 8098.878516822252, 8107.635156417975, 8135.3898457615915, 8147.959260203661, 3096.752259819209, 3161.762867784925, 3169.122695296535, 3188.007495315428, 3190.1386625610953, 947.5357075033185, 952.7951490429591, 955.5843208204315, 986.363795351994, 1007.2244371833793, 27098.5935210972, 28002.0, 28171.154865354074, 28207.153785386472, 28220.717792821808, 977.6773664690635, 1001.379144930148, 1032.5250384822916, 1041.3231399590327, 1111.9888801112047, 13903.0, 14798.92600537012, 14984.47554335593, 15006.849931500545, 15330.770038449433, 360248.0, 369603.0, 369662.0, 369666.0, 370223.0, 34663.30673386518, 34751.304973900886, 35000.64999350025, 35002.474962875574, 35018.474722878665, 1138.1009002887793, 1178.6114919606132, 1204.9036077113635, 1269.3082270162784, 1279.718461938372, 26389.472210555297, 29610.407791843612, 29747.85126074356, 29815.701842981292, 30125.548116778704, 43285.7835710832, 44314.77842610766, 44356.33465497955, 44378.33432498579, 44404.777976109915, 337076.0, 343967.0, 347068.0, 347078.0, 348193.0, 33243.50134747932, 37664.81167594145, 38968.154885757525, 41377.37933931054, 41592.58407415887, 41887.162256755306, 41972.0, 41992.580074198864, 42118.36822447604, 42691.35962960496, 35500.0, 36164.819175905, 36481.81759091187, 36547.63452365442, 36691.44962825506, 35446.64553354433, 36192.638073618924, 36311.09222269464, 36315.45526817153, 36560.0, 34429.0, 34917.825410872785, 35184.12039699028, 35493.82253088718, 35622.109447264025, 31697.683023169473, 33610.49584256287, 33888.83055584706, 34090.0, 34097.48853767146, 25297.367565811, 25662.230133096036, 25742.485150297263, 25920.740792592587, 26418.207453776417], "value": 17251.762109378178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.7157952586745, 367.5846293688132, 372.5510759534761, 374.51126280204323, 383.8349509710823, 16746.49760507185, 17217.0, 17397.56506087347, 17646.38237661682, 17739.20173592188, 16564.83435165648, 16981.91509042456, 17583.648327033483, 17671.381501647444, 17686.734698979526, 5103.081445339828, 5215.895682086356, 5295.973520132394, 5296.25852380667, 5301.840944771663, 3585.390483617778, 3790.0714324990417, 3930.960690393088, 5168.48315168482, 5751.1373294006025, 6026.8794624107495, 6035.366286539916, 6081.087836824468, 6113.908291375633, 6130.295016073142, 5983.880322393549, 6097.634141951475, 6097.756089756404, 6113.205283313141, 6117.877642447148, 3427.4516077427493, 5037.949620503821, 5183.50756678115, 5378.704171270618, 5378.838634840961, 19795.30716424918, 20482.0, 20568.0, 20580.58838823215, 20645.17419303226, 1860.962780744391, 2021.7978202179665, 2051.5384038591346, 2111.873287602749, 2508.2600632813183, 13100.541481048118, 13107.47570097195, 13118.409671564803, 13229.470821167142, 13639.613067713111, 1734.6530693861278, 1736.9826301736948, 1753.6142048749255, 1769.469159252232, 1815.2557451444977, 66134.66932665306, 66546.66726666335, 66718.66640666766, 68100.31899681038, 68696.0, 9584.233261339075, 9597.520123993772, 9861.852072218779, 9942.254330925209, 9955.303128780915, 13666.0, 13783.379747911367, 13783.793243101361, 13791.310434478237, 13810.447582096804, 6824.18109826814, 6863.10779598659, 6898.448124150056, 6998.335158159966, 7037.683304251321, 6348.04779283102, 6386.98809874888, 6495.642739649365, 6514.250861150934, 6525.836854078686, 6205.503559715212, 6303.0, 6326.4622507087415, 6356.300806911236, 6384.3934826191435, 1718.8453039226529, 1810.0, 1826.881252718569, 1836.8530517558563, 1850.2506484873647, 872.3457406944791, 919.6229545886155, 931.7856892914667, 947.9099485548862, 1011.7420057885192, 16401.58996025109, 17004.149792510325, 17290.827091729174, 17493.037882916306, 17541.473755787345, 857.3184318466834, 875.8729984152262, 905.5608030105394, 921.3642586615214, 932.8320902237663, 9231.769205769775, 9568.330216884751, 10030.64892728751, 10334.948325258476, 10347.068763811143, 416619.0, 416634.0, 421940.0, 425173.0, 427387.0, 70795.0, 74284.0, 74911.0, 75726.0, 75848.0, 951.0442005784142, 951.5765484359532, 965.8985806490358, 967.1923943507251, 987.0968064221157, 15569.766453503433, 15575.532734017997, 15645.374185032471, 15832.129232892301, 16044.278007489924, 30392.544111838783, 32904.0, 33582.66417335795, 34227.4865877007, 34339.14152146217, 47124.0, 48257.75871120622, 48373.0, 48552.75723621359, 48640.0, 7273.599952002479, 7440.404767618686, 7594.734184303523, 7644.847103057797, 7663.501872378278, 9784.804303914025, 10130.0, 10494.52774625159, 10569.524371403151, 10893.509792059534, 4678.461976872703, 5818.214541036906, 7582.96208518976, 9185.422026828028, 9603.231741460526, 9046.185843274137, 9202.723918282461, 9290.62837486493, 9552.23582113443, 9583.329166958525, 9300.627974880928, 9355.672551460666, 9587.280953928344, 9614.423134611945, 9877.50612469388, 7132.108486439195, 7295.2340004298785, 7323.890141647773, 7329.157146927958, 7573.129090154703, 8287.461315014505, 9429.292803039662, 9472.186868308807, 9596.23230141601, 9832.950835245778], "value": 8213.13458609264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.451133268362, 1399.6430910117922, 1452.2520901735606, 1540.4069433268196, 1787.2314904591028, 6504.1869766279215, 7571.35643470305, 7806.336461400788, 7811.804704882374, 7992.800179995503, 7727.459077864538, 7856.450048496607, 7858.371330293577, 7859.449838511292, 7908.525488470696, 2195.1329224956135, 2223.8109760670363, 2226.7216597925258, 2227.7772222777753, 2229.141780414536, 2153.5692861427697, 2175.7715439878743, 2191.868487890724, 2192.572448372568, 2197.3188311623367, 2183.3995651195887, 2185.8797766122857, 2195.1658369819447, 2197.198022721703, 2228.799408053275, 2143.0998980428258, 2151.709519214902, 2152.4080877758665, 2152.8062474377302, 2153.935381938544, 2055.095757866549, 2098.4019554426914, 2099.1078791513696, 2099.265257159982, 2102.36928921323, 7582.128055273659, 7785.1436342002335, 7809.882851757228, 7816.257455541714, 7830.491018083863, 4298.290782020963, 4451.043025749479, 4455.888602784924, 4460.241758900995, 4464.196444639963, 2903.767698584108, 2927.224285564327, 2985.149232468736, 3008.909732708022, 3043.45217860785, 927.8561822917459, 949.3971328206569, 959.8848138223458, 963.5037955452947, 985.1527686189871, 10636.468176591217, 10695.625653102183, 10712.464376781209, 10724.946375268151, 10743.086837618734, 3933.7049721270446, 4051.594840515984, 4108.815103320358, 4112.897177570585, 4117.2588933992165, 8404.117567655308, 8453.746387608382, 8456.957715211507, 8469.280111190494, 8478.491290522588, 4362.1275744851155, 4377.715448495837, 4379.408779814684, 4391.912161756747, 4395.120975804852, 3378.5438965739804, 3847.6921846252235, 3960.7821569813937, 3976.204759048202, 4068.816903239361, 3382.5095361172985, 3408.301298233856, 3446.4141096013736, 3448.4827275908815, 3490.075130090528, 1023.6417253961054, 1033.194108595297, 1034.4569101221919, 1046.9790604187874, 1048.648702684594, 739.301360214592, 822.7819627798638, 839.6389552492487, 855.5294587976588, 861.401326078382, 5320.14877619579, 5339.81310654133, 5365.812196573102, 5420.593455490854, 5554.1391084381985, 869.3566760597113, 871.5833930990532, 907.8365894138987, 907.9727608171765, 911.2482202183226, 3476.5132881396626, 3680.871169509054, 3758.285925674113, 3798.2973149967343, 3827.8468861245237, 9229.538523073954, 9435.386699864624, 9682.612695492102, 9691.418514889128, 9702.369345992487, 9532.666356677482, 9595.616175352907, 9644.132028117363, 9690.0, 9692.030796920251, 7043.436525077981, 7077.504574679826, 7204.531705439234, 7210.747623833141, 7254.419646428379, 5066.9746651266505, 5071.619628527801, 5082.771275292546, 5142.280080788618, 5153.278541004337, 8782.165694259034, 8989.910100898907, 9089.409188402733, 9197.540122993958, 9218.21645160169, 9133.497657628894, 9233.076692330982, 9261.814763704553, 9342.205912497513, 9413.0, 5595.468430499096, 6106.786262480792, 6228.34602366745, 6343.9682801585695, 6390.584612000205, 7134.964325178341, 7394.0, 7416.592087435243, 7431.665575049027, 7440.962795185989, 6581.111549940697, 6605.2734199239, 6629.535932484872, 6962.094927659575, 7018.122734658168, 6709.899351509634, 6758.0, 6797.218319893078, 6800.251972283144, 6866.759663411756, 6486.091947127312, 6500.349965003462, 6543.836404089936, 6556.737730490727, 6559.311272316338, 4143.7306575072525, 4417.977910110429, 4442.355858400579, 4448.998975230547, 4532.682712210114, 4518.525554816697, 4523.502414734311, 4731.243001119804, 4752.691075080109, 4773.522647735199], "value": 4090.507116848867, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2424937541452, 284.8632656324964, 287.57869720858946, 293.87510308119056, 296.64550861720255, 4708.505606911276, 4726.858194254178, 4747.382840230765, 4777.187878060734, 4810.591099756516, 4654.394928659278, 4681.0, 4690.710054734949, 4699.788509517071, 4716.103940251359, 3518.5074089627537, 3624.275144971003, 3670.0, 3724.7392682512236, 3760.3795373763296, 3713.922962340918, 3739.3456145174487, 3746.063484128968, 3762.6989840812807, 3766.6986641068784, 3510.7542472026967, 3706.6478684524927, 3711.515393842458, 3714.8699795507164, 3716.293904158215, 3578.3022310649435, 3670.1558641512333, 3708.4437334400054, 3709.7774133552075, 3722.7021838252876, 3251.951220731691, 3267.15054085937, 3273.770836041478, 3273.918152046194, 3275.9344813103603, 4525.140223357552, 4539.6368290536675, 4546.52261512543, 4555.681102322838, 4566.885827854297, 3975.3440682287387, 4182.498100227962, 4203.369494575838, 4208.768517731523, 4215.936760948588, 4937.753112344404, 4940.802367905279, 4944.87637809054, 4949.653524253304, 4968.3292755477905, 3492.3713731528314, 3495.755297129202, 3504.1590018395655, 3513.367593833109, 3517.3844577199143, 5008.424031236382, 5074.868555206822, 5105.897882042338, 5114.769835357418, 5131.820386286499, 3546.627604101584, 3556.626554211822, 3561.9821900890847, 3568.0901370150445, 3582.462630605378, 3586.5158203642172, 3605.2789442111684, 3616.27674465108, 3622.3117607654463, 3622.619624939396, 4104.692148088905, 4109.876703698834, 4117.691173162025, 4125.793710314472, 4129.401236820704, 4712.468447754493, 4901.387326584177, 4939.086269040167, 4965.553100220997, 4977.776000080005, 1253.3232054690366, 1259.5402678022456, 1264.64589914824, 1266.3351740336398, 1267.7084270617809, 808.1030056637128, 810.1210186947111, 831.7296878514386, 857.9356548258905, 863.2877875752404, 4359.193549193409, 4395.384646149541, 4397.2964325707735, 4397.934030989538, 4422.115576884636, 4908.533689299511, 5006.924896126561, 5045.747712614355, 5055.51972562606, 5057.924131138036, 4245.532991370947, 4355.303151495746, 4360.454943132108, 4364.454443194601, 4368.230866499073, 2662.786977041832, 2677.072507794385, 2691.4751623433635, 2691.7039125696156, 2698.8110832241555, 4741.596964258077, 4765.26138448541, 4782.760861956888, 4792.257200133985, 4803.183458811941, 4908.828191013297, 5117.2068329409, 5134.922976155361, 5135.6918584885025, 5154.804021506689, 4790.329353890528, 4790.538885639844, 4803.231482962709, 4817.445993710769, 4820.385170967765, 5015.473375295687, 5022.8949631081105, 5024.84925452237, 5051.87370315745, 5060.443351231288, 4781.6891902026255, 4933.802647894044, 4946.925796113133, 4983.925241121314, 5089.592832573311, 4880.6095512358215, 4912.76469206503, 4917.950820491749, 4923.236898280772, 4926.753662316942, 3631.182983828723, 3635.127569383382, 3646.106703857572, 3650.393826716236, 3654.7624404413627, 4962.801487940586, 5075.187969924795, 5109.8722531937, 5117.5394214520875, 5123.692578445305, 4899.926501102557, 4901.059364381343, 4906.55840974314, 4917.360743103373, 4933.457319694902, 4941.0, 4945.208766597327, 4948.208286674115, 4956.504349565159, 4958.851234462972, 4714.952850471589, 4850.345203397496, 4879.878003049952, 4883.902321953612, 4892.192788189909, 4724.834630787906, 4834.5890599299455, 4932.3094766731965, 4957.677750946177, 4966.379202599675, 4798.688085274446, 4842.685225460334, 4849.830255941025, 4875.219964805614, 4894.535019173173], "value": 3717.5248709315947, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.8996650502424, 724.4168444402255, 733.7101844771315, 767.5624893810531, 788.0307222116793, 12489.562865299717, 12627.305498197595, 12644.241345519275, 12649.873501264985, 12662.43019064142, 13067.673308167301, 13591.728165436685, 13602.795958060613, 14157.29213539324, 14194.71610567788, 640.3756337570878, 792.6987744657037, 793.9126696063457, 796.6216047377508, 797.2904115337326, 791.4064451661254, 813.4224700462679, 813.5078277642031, 815.0748899998515, 817.456391499652, 844.1769274956898, 848.9066202717696, 851.8211175653089, 853.2235665544356, 853.6841368693592, 660.2835923023525, 827.0488937721608, 845.5772113943028, 845.8815765792793, 846.4328899637227, 625.5652321636464, 627.7143899525705, 628.3684896678809, 628.7516431009772, 629.1694962649304, 13217.273049982246, 13271.800922986164, 13277.668058298523, 13293.73412531744, 13304.13523120994, 11525.596604118815, 12018.87981120195, 12134.635960921098, 12252.958498527636, 12409.813852792215, 10059.295849290553, 10081.49592520371, 10121.139703125244, 10246.077852993267, 10322.122619577345, 3319.2531680371962, 3343.9832800836084, 3360.2439451123546, 3399.4220982433044, 3419.777714448553, 47591.28613070807, 47658.761706191246, 47728.28407573889, 48304.758476207746, 48850.75574622104, 9592.95203523978, 9770.560324785401, 9889.159421449114, 9905.504724763878, 9920.305578609572, 17058.914705426643, 17177.742333865, 17210.39763608268, 17248.741268880978, 17343.56641083983, 6450.548461607643, 6506.512011599054, 6515.0, 6518.185226846645, 6738.696758645872, 3742.5134732484603, 3867.245887052054, 3904.6003669216457, 3915.353966595537, 3996.4604778355133, 2642.1016854269255, 2758.158761577698, 2765.861706914646, 2775.9028434004713, 2786.9442611147665, 529.0582762682432, 529.1533546325848, 536.5787856532603, 540.0953403049875, 544.1130956540813, 581.282116586016, 641.5060403489288, 643.9420452159328, 660.1747815230962, 660.428729149292, 8116.715914943066, 8212.794680133044, 8315.376346774015, 8470.0393294552, 8556.700515482053, 539.6734975339941, 552.9419410961872, 572.9026065568863, 639.9808005759835, 640.3596403596404, 3818.59904710007, 3921.2157568485845, 3932.9803350983634, 3958.6437220650278, 4025.75845449274, 51758.482415175364, 55141.44858551363, 55292.44707552953, 55443.61390965258, 55514.16728749072, 46286.768566156956, 49138.26292605614, 49383.50616493861, 49643.75178124086, 51698.48301517012, 44991.32513012308, 45167.0, 45440.77279613581, 45534.0, 45786.77106614512, 7527.0, 7586.089669239505, 7627.389808815393, 7715.691372345043, 7734.303912647889, 28617.14148575546, 30754.53868191934, 31042.379152417278, 31795.682043179273, 32702.50946235856, 36973.26053478861, 40190.0, 40715.592844072366, 41037.0, 41553.58446415497, 10419.111276148038, 10473.738156546147, 10742.624008159677, 10972.506237219184, 11239.66281011571, 11575.71060723455, 11613.187076904536, 12395.93802030984, 12869.613911582668, 13013.544525941546, 11101.944490277498, 11163.832542511705, 11312.264702794291, 11353.148513861328, 11564.47959841826, 11275.718107047389, 11383.886161138282, 11453.54390723129, 11509.769804604028, 11665.183437159656, 11245.38150401703, 11314.264572802742, 11401.144914131308, 11522.308661480338, 11544.422778861192, 9316.301277404358, 9347.298952578447, 9412.717618471457, 9688.70933871985, 9744.512774361112, 9074.682386116718, 9250.444973301623, 9307.767305817139, 9350.345475816628, 9421.717348479557], "value": 6051.375023685789, "unit": "score"}], "name": "dromaeo_css", "value": 6276.196680013904, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 135.0, 129.0, 194.0, 137.0, 152.0, 153.0, 131.0, 195.0, 131.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 137.0, 75.0, 75.0, 75.0, 78.0, 112.0, 75.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 153.0, 93.0, 93.0, 93.0, 123.0, 92.0, 94.0, 135.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 69.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 86.0, 82.0, 86.0, 82.0, 80.0, 89.0, 151.0, 84.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 145.0, 142.0, 132.0, 133.0, 127.0, 130.0, 128.0, 164.0, 133.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 172.0, 171.0, 172.0, 171.0, 169.0, 173.0, 170.0, 168.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1570.4999999999995, "alertThreshold": 2.0}]} 18:46:06 INFO - Return code: 0 18:46:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:46:06 ERROR - # TBPL SUCCESS # 18:46:06 INFO - Running post-action listener: _resource_record_post_action 18:46:06 INFO - ##### 18:46:06 INFO - ##### Finished run-tests step (success) 18:46:06 INFO - ##### 18:46:06 INFO - Running post-run listener: _resource_record_post_run 18:46:06 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532799488; Read time: 8; Write time: 404400 18:46:06 INFO - TinderboxPrint: CPU usage
13.1% 18:46:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:46:06 INFO - TinderboxPrint: I/O write bytes / time
532,799,488 / 404,400 18:46:06 INFO - TinderboxPrint: CPU idle
8,326.8 (86.9%) 18:46:06 INFO - TinderboxPrint: CPU user
1,210.3 (12.6%) 18:46:06 INFO - TinderboxPrint: Swap in / out
0 / 0 18:46:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236785664; Read time: 0; Write time: 209196 18:46:06 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296013824; Read time: 8; Write time: 195204 18:46:07 INFO - Running post-run listener: _upload_blobber_files 18:46:07 INFO - Blob upload gear active. 18:46:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46:07 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 18:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:46:07 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:08 INFO - (blobuploader) - INFO - Done attempting. 18:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:13 INFO - (blobuploader) - INFO - Done attempting. 18:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:13 INFO - (blobuploader) - INFO - Done attempting. 18:46:13 INFO - (blobuploader) - INFO - Iteration through files over. 18:46:13 INFO - Return code: 0 18:46:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:46:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:46:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a96f9650eaa2b87b2175a31346aab7a1eabc2d4e09f9e61ac888011f44f35ba94a4c8a7706309e08896dfba042f3f786060b4173909b366b24f5dd494ca0b1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/041e3f2a97b9d15ff346b0335983c579d098dbb71e90cb8488f54a827f816efc887f05d582879eafd67d5933e96e2759575e83a00df9484c5241f6512611ba18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea28762613395ffa30f0a7d92dffa9ee98c857ae747ea3e84818c055d9accf2bdb8a474000816c07a8969f3cf8126d2724a1778cf5494019ebb854f652271300"} 18:46:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:46:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:46:13 INFO - Contents: 18:46:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a96f9650eaa2b87b2175a31346aab7a1eabc2d4e09f9e61ac888011f44f35ba94a4c8a7706309e08896dfba042f3f786060b4173909b366b24f5dd494ca0b1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/041e3f2a97b9d15ff346b0335983c579d098dbb71e90cb8488f54a827f816efc887f05d582879eafd67d5933e96e2759575e83a00df9484c5241f6512611ba18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea28762613395ffa30f0a7d92dffa9ee98c857ae747ea3e84818c055d9accf2bdb8a474000816c07a8969f3cf8126d2724a1778cf5494019ebb854f652271300"} 18:46:13 INFO - Running post-run listener: copy_logs_to_upload_dir 18:46:13 INFO - Copying logs to upload dir... 18:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs 18:46:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.777285 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-23 18:46:13.770935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 18:46:13.774962) ========= 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=ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a96f9650eaa2b87b2175a31346aab7a1eabc2d4e09f9e61ac888011f44f35ba94a4c8a7706309e08896dfba042f3f786060b4173909b366b24f5dd494ca0b1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/041e3f2a97b9d15ff346b0335983c579d098dbb71e90cb8488f54a827f816efc887f05d582879eafd67d5933e96e2759575e83a00df9484c5241f6512611ba18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea28762613395ffa30f0a7d92dffa9ee98c857ae747ea3e84818c055d9accf2bdb8a474000816c07a8969f3cf8126d2724a1778cf5494019ebb854f652271300"} build_url:https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/RoBXpQiORUm9eYs-0P_0gA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a96f9650eaa2b87b2175a31346aab7a1eabc2d4e09f9e61ac888011f44f35ba94a4c8a7706309e08896dfba042f3f786060b4173909b366b24f5dd494ca0b1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/041e3f2a97b9d15ff346b0335983c579d098dbb71e90cb8488f54a827f816efc887f05d582879eafd67d5933e96e2759575e83a00df9484c5241f6512611ba18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea28762613395ffa30f0a7d92dffa9ee98c857ae747ea3e84818c055d9accf2bdb8a474000816c07a8969f3cf8126d2724a1778cf5494019ebb854f652271300"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 18:46:13.801758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:46:13.802125) ========= 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=ed14279e38b05397cf4aa391000001a4-1464052985.370888-899289032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004739 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 18:46:13.887169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 18:46:13.887516) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 18:46:13.887829) ========= ========= Total master_lag: 0.16 =========