builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1469524673.93 results: success (0) buildid: 20160726014102 builduid: 98cfcf606aad42fd9dd2f89711ba4012 revision: e1ac106612412ecf23e8cc0faff7519b03728c37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:53.930544) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:53.931022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:53.931340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:53.949524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:53.949831) ========= 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=8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 02:17:54-- 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% 89.9M=0s 2016-07-26 02:17:54 (89.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116090 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:54.299135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:54.299577) ========= 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=8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019932 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:54.341262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:54.341613) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1ac106612412ecf23e8cc0faff7519b03728c37 --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 e1ac106612412ecf23e8cc0faff7519b03728c37 --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=8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 02:17:54,759 truncating revision to first 12 chars 2016-07-26 02:17:54,759 Setting DEBUG logging. 2016-07-26 02:17:54,760 attempt 1/10 2016-07-26 02:17:54,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1ac10661241?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 02:17:55,372 unpacking tar archive at: fx-team-e1ac10661241/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925876 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:55.288043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:55.288403) ========= script_repo_revision: e1ac106612412ecf23e8cc0faff7519b03728c37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:55.288850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:55.289192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 02:17:55.300065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-07-26 02:17:55.300459) ========= /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=8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:17:55 INFO - MultiFileLogger online at 20160726 02:17:55 in /builds/slave/test 02:17:55 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 02:17:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:55 INFO - {'append_to_log': False, 02:17:55 INFO - 'base_work_dir': '/builds/slave/test', 02:17:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:17:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:55 INFO - 'branch': 'Fx-Team-Non-PGO', 02:17:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:55 INFO - 'config_files': ('talos/linux_config.py',), 02:17:55 INFO - 'default_actions': ('clobber', 02:17:55 INFO - 'read-buildbot-config', 02:17:55 INFO - 'download-and-extract', 02:17:55 INFO - 'populate-webroot', 02:17:55 INFO - 'create-virtualenv', 02:17:55 INFO - 'install', 02:17:55 INFO - 'run-tests'), 02:17:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:55 INFO - 'download_minidump_stackwalk': True, 02:17:55 INFO - 'download_symbols': 'ondemand', 02:17:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:55 INFO - 'installer_path': 'installer.exe', 02:17:55 INFO - 'log_level': 'info', 02:17:55 INFO - 'log_name': 'talos', 02:17:55 INFO - 'log_to_console': True, 02:17:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:17:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:17:55 INFO - 'opt_config_files': (), 02:17:55 INFO - 'pip_index': False, 02:17:55 INFO - 'sps_profile': False, 02:17:55 INFO - 'sps_profile_interval': 0, 02:17:55 INFO - 'suite': 'dromaeojs', 02:17:55 INFO - 'system_bits': '32', 02:17:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:55 INFO - 'title': 'talos-linux64-ix-038', 02:17:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:55 INFO - 'use_talos_json': True, 02:17:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:55 INFO - 'work_dir': 'build'} 02:17:55 INFO - [mozharness: 2016-07-26 09:17:55.807624Z] Running clobber step. 02:17:55 INFO - Running pre-action listener: _resource_record_pre_action 02:17:55 INFO - Running main action method: clobber 02:17:55 INFO - rmtree: /builds/slave/test/build 02:17:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:56 INFO - Running post-action listener: _resource_record_post_action 02:17:56 INFO - [mozharness: 2016-07-26 09:17:56.287359Z] Finished clobber step (success) 02:17:56 INFO - [mozharness: 2016-07-26 09:17:56.287461Z] Running read-buildbot-config step. 02:17:56 INFO - Running pre-action listener: _resource_record_pre_action 02:17:56 INFO - Running main action method: read_buildbot_config 02:17:56 INFO - Using buildbot properties: 02:17:56 INFO - { 02:17:56 INFO - "project": "", 02:17:56 INFO - "product": "firefox", 02:17:56 INFO - "script_repo_revision": "production", 02:17:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:17:56 INFO - "repository": "", 02:17:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:17:56 INFO - "buildid": "20160726014102", 02:17:56 INFO - "pgo_build": "False", 02:17:56 INFO - "basedir": "/builds/slave/test", 02:17:56 INFO - "buildnumber": 1823, 02:17:56 INFO - "slavename": "talos-linux64-ix-038", 02:17:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:17:56 INFO - "platform": "ubuntu64_hw", 02:17:56 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:17:56 INFO - "branch": "fx-team", 02:17:56 INFO - "repo_path": "integration/fx-team", 02:17:56 INFO - "revision": "e1ac106612412ecf23e8cc0faff7519b03728c37", 02:17:56 INFO - "stage_platform": "linux64", 02:17:56 INFO - "builduid": "98cfcf606aad42fd9dd2f89711ba4012", 02:17:56 INFO - "slavebuilddir": "test" 02:17:56 INFO - } 02:17:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:17:56 INFO - Running post-action listener: _resource_record_post_action 02:17:56 INFO - [mozharness: 2016-07-26 09:17:56.289929Z] Finished read-buildbot-config step (success) 02:17:56 INFO - [mozharness: 2016-07-26 09:17:56.290017Z] Running download-and-extract step. 02:17:56 INFO - Running pre-action listener: _resource_record_pre_action 02:17:56 INFO - Running main action method: download_and_extract 02:17:56 INFO - mkdir: /builds/slave/test/build/tests 02:17:56 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')]} 02:17:56 INFO - https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:17:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:17:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:17:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:17:56 INFO - Downloaded 1361 bytes. 02:17:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:17:56 INFO - Using the following test package requirements: 02:17:56 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:56 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:17:56 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:17:56 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'jsshell-linux-x86_64.zip'], 02:17:56 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:17:56 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:56 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:17:56 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:17:56 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:17:56 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:17:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:17:56 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')]} 02:17:56 INFO - https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:17:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:17:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:17:58 INFO - Downloaded 22740815 bytes. 02:17:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:18:00 INFO - Return code: 0 02:18:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:18: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')]} 02:18:00 INFO - https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:18:20 INFO - Downloaded 22740815 bytes. 02:18:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:18:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:18:21 INFO - Return code: 0 02:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:21 INFO - https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:18:23 INFO - Downloaded 14403248 bytes. 02:18:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:18:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:18:23 INFO - Return code: 0 02:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:23 INFO - https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:18:24 INFO - Downloaded 57166520 bytes. 02:18:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:24 INFO - mkdir: /builds/slave/test/properties 02:18:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:18:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:18:24 INFO - Contents: 02:18:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:25 INFO - Running post-action listener: _resource_record_post_action 02:18:25 INFO - Running post-action listener: set_extra_try_arguments 02:18:25 INFO - [mozharness: 2016-07-26 09:18:25.394140Z] Finished download-and-extract step (success) 02:18:25 INFO - [mozharness: 2016-07-26 09:18:25.394376Z] Running populate-webroot step. 02:18:25 INFO - Running pre-action listener: _resource_record_pre_action 02:18:25 INFO - Running main action method: populate_webroot 02:18:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:18:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:18:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:18:25 INFO - '--tppagecycles', 02:18:25 INFO - '7'], 02:18:25 INFO - 'tests': ['tsvgm']}}, 02:18:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:18:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:18:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:18:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:18:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['damp', 'tps']}, 02:18:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'tests': ['damp', 'tps']}, 02:18:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['dromaeo_dom']}, 02:18:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:18:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['basic_compositor_video']}, 02:18:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:18:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['a11yr', 02:18:25 INFO - 'ts_paint', 02:18:25 INFO - 'tpaint', 02:18:25 INFO - 'sessionrestore', 02:18:25 INFO - 'sessionrestore_no_auto_restore', 02:18:25 INFO - 'tabpaint']}, 02:18:25 INFO - 'other-e10s': {'tests': ['a11yr', 02:18:25 INFO - 'ts_paint', 02:18:25 INFO - 'tpaint', 02:18:25 INFO - 'sessionrestore', 02:18:25 INFO - 'sessionrestore_no_auto_restore', 02:18:25 INFO - 'tabpaint']}, 02:18:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:18:25 INFO - 'ts_paint', 02:18:25 INFO - 'tpaint', 02:18:25 INFO - 'sessionrestore', 02:18:25 INFO - 'sessionrestore_no_auto_restore', 02:18:25 INFO - 'tabpaint']}, 02:18:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:18:25 INFO - 'ts_paint', 02:18:25 INFO - 'tpaint', 02:18:25 INFO - 'sessionrestore', 02:18:25 INFO - 'sessionrestore_no_auto_restore', 02:18:25 INFO - 'tabpaint']}, 02:18:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['a11yr', 02:18:25 INFO - 'ts_paint', 02:18:25 INFO - 'tpaint', 02:18:25 INFO - 'sessionrestore', 02:18:25 INFO - 'sessionrestore_no_auto_restore', 02:18:25 INFO - 'tabpaint']}, 02:18:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['a11yr', 02:18:25 INFO - 'ts_paint', 02:18:25 INFO - 'tpaint', 02:18:25 INFO - 'sessionrestore', 02:18:25 INFO - 'sessionrestore_no_auto_restore', 02:18:25 INFO - 'tabpaint']}, 02:18:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['tsvgx', 02:18:25 INFO - 'tsvgr_opacity', 02:18:25 INFO - 'tart', 02:18:25 INFO - 'tscrollx', 02:18:25 INFO - 'cart']}, 02:18:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:18:25 INFO - 'tsvgr_opacity', 02:18:25 INFO - 'tart', 02:18:25 INFO - 'tscrollx', 02:18:25 INFO - 'cart']}, 02:18:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'talos_options': ['--disable-e10s'], 02:18:25 INFO - 'tests': ['tp5o']}, 02:18:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'tests': ['tp5o']}, 02:18:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'talos_options': ['--disable-e10s', 02:18:25 INFO - '--xperf_path', 02:18:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:25 INFO - 'tests': ['tp5n']}, 02:18:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:18:25 INFO - 'talos_options': ['--xperf_path', 02:18:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:25 INFO - 'tests': ['tp5n']}}, 02:18:25 INFO - 'talos.zip': {'path': '', 02:18:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:18:25 INFO - Running post-action listener: _resource_record_post_action 02:18:25 INFO - [mozharness: 2016-07-26 09:18:25.409842Z] Finished populate-webroot step (success) 02:18:25 INFO - [mozharness: 2016-07-26 09:18:25.409932Z] Running create-virtualenv step. 02:18:25 INFO - Running pre-action listener: _resource_record_pre_action 02:18:25 INFO - Running main action method: create_virtualenv 02:18:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:18:25 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 02:18:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:18:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:18:25 INFO - Using real prefix '/usr' 02:18:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:18:26 INFO - Installing distribute.............................................................................................................................................................................................done. 02:18:27 INFO - Installing pip.................done. 02:18:27 INFO - Return code: 0 02:18:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:18:27 INFO - Using env: {'DISPLAY': ':0', 02:18:27 INFO - 'HOME': '/home/cltbld', 02:18:27 INFO - 'LANG': 'en_US.UTF-8', 02:18:27 INFO - 'LANGUAGE': 'en_US:en', 02:18:27 INFO - 'LOGNAME': 'cltbld', 02:18:27 INFO - 'MAIL': '/var/mail/cltbld', 02:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:27 INFO - 'MOZ_NO_REMOTE': '1', 02:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:27 INFO - 'NO_EM_RESTART': '1', 02:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:27 INFO - 'PWD': '/builds/slave/test', 02:18:27 INFO - 'SHELL': '/bin/bash', 02:18:27 INFO - 'SHLVL': '1', 02:18:27 INFO - 'TERM': 'linux', 02:18:27 INFO - 'TMOUT': '86400', 02:18:27 INFO - 'USER': 'cltbld', 02:18:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:27 INFO - '_': '/tools/buildbot/bin/python'} 02:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:28 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 02:18:28 INFO - Cleaning up... 02:18:28 INFO - Return code: 0 02:18:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:28 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:28 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 02:18:28 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 02:18:28 INFO - Using env: {'DISPLAY': ':0', 02:18:28 INFO - 'HOME': '/home/cltbld', 02:18:28 INFO - 'LANG': 'en_US.UTF-8', 02:18:28 INFO - 'LANGUAGE': 'en_US:en', 02:18:28 INFO - 'LOGNAME': 'cltbld', 02:18:28 INFO - 'MAIL': '/var/mail/cltbld', 02:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:28 INFO - 'MOZ_NO_REMOTE': '1', 02:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:28 INFO - 'NO_EM_RESTART': '1', 02:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:28 INFO - 'PWD': '/builds/slave/test', 02:18:28 INFO - 'SHELL': '/bin/bash', 02:18:28 INFO - 'SHLVL': '1', 02:18:28 INFO - 'TERM': 'linux', 02:18:28 INFO - 'TMOUT': '86400', 02:18:28 INFO - 'USER': 'cltbld', 02:18:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:28 INFO - '_': '/tools/buildbot/bin/python'} 02:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:28 INFO - Downloading/unpacking psutil>=3.1.1 02:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:18:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:30 INFO - Installing collected packages: psutil 02:18:30 INFO - Running setup.py install for psutil 02:18:30 INFO - building 'psutil._psutil_linux' extension 02:18:30 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 02:18:30 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 02:18:30 INFO - building 'psutil._psutil_posix' extension 02:18:30 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 02:18:30 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 02:18:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:30 INFO - Successfully installed psutil 02:18:30 INFO - Cleaning up... 02:18:30 INFO - Return code: 0 02:18:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:30 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:30 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 02:18:30 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 02:18:30 INFO - Using env: {'DISPLAY': ':0', 02:18:30 INFO - 'HOME': '/home/cltbld', 02:18:30 INFO - 'LANG': 'en_US.UTF-8', 02:18:30 INFO - 'LANGUAGE': 'en_US:en', 02:18:30 INFO - 'LOGNAME': 'cltbld', 02:18:30 INFO - 'MAIL': '/var/mail/cltbld', 02:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:30 INFO - 'MOZ_NO_REMOTE': '1', 02:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:30 INFO - 'NO_EM_RESTART': '1', 02:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:30 INFO - 'PWD': '/builds/slave/test', 02:18:30 INFO - 'SHELL': '/bin/bash', 02:18:30 INFO - 'SHLVL': '1', 02:18:30 INFO - 'TERM': 'linux', 02:18:30 INFO - 'TMOUT': '86400', 02:18:30 INFO - 'USER': 'cltbld', 02:18:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:30 INFO - '_': '/tools/buildbot/bin/python'} 02:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:18:33 INFO - Installing collected packages: mozsystemmonitor 02:18:33 INFO - Running setup.py install for mozsystemmonitor 02:18:33 INFO - Successfully installed mozsystemmonitor 02:18:33 INFO - Cleaning up... 02:18:33 INFO - Return code: 0 02:18:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:18:33 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')]} 02:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:33 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')]} 02:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:33 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:33 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==2.5.1'] in /builds/slave/test/build 02:18:33 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==2.5.1 02:18:33 INFO - Using env: {'DISPLAY': ':0', 02:18:33 INFO - 'HOME': '/home/cltbld', 02:18:33 INFO - 'LANG': 'en_US.UTF-8', 02:18:33 INFO - 'LANGUAGE': 'en_US:en', 02:18:33 INFO - 'LOGNAME': 'cltbld', 02:18:33 INFO - 'MAIL': '/var/mail/cltbld', 02:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:33 INFO - 'MOZ_NO_REMOTE': '1', 02:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:33 INFO - 'NO_EM_RESTART': '1', 02:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:33 INFO - 'PWD': '/builds/slave/test', 02:18:33 INFO - 'SHELL': '/bin/bash', 02:18:33 INFO - 'SHLVL': '1', 02:18:33 INFO - 'TERM': 'linux', 02:18:33 INFO - 'TMOUT': '86400', 02:18:33 INFO - 'USER': 'cltbld', 02:18:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:33 INFO - '_': '/tools/buildbot/bin/python'} 02:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:33 INFO - Downloading/unpacking jsonschema==2.5.1 02:18:33 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 02:18:33 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 02:18:33 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 02:18:33 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 02:18:33 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 02:18:33 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 02:18:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:18:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:18:35 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 02:18:35 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 02:18:35 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 02:18:35 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 02:18:35 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 02:18:35 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 02:18:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:18:35 INFO - warning: no files found matching '*.txt' 02:18:35 INFO - no previously-included directories found matching 'build' 02:18:35 INFO - no previously-included directories found matching 'dist' 02:18:35 INFO - no previously-included directories found matching '.git*' 02:18:35 INFO - Installing collected packages: jsonschema, functools32 02:18:35 INFO - Running setup.py install for functools32 02:18:35 INFO - warning: no files found matching '*.txt' 02:18:35 INFO - no previously-included directories found matching 'build' 02:18:35 INFO - no previously-included directories found matching 'dist' 02:18:35 INFO - no previously-included directories found matching '.git*' 02:18:35 INFO - Successfully installed jsonschema functools32 02:18:35 INFO - Cleaning up... 02:18:35 INFO - Return code: 0 02:18:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:18:35 INFO - Using env: {'DISPLAY': ':0', 02:18:35 INFO - 'HOME': '/home/cltbld', 02:18:35 INFO - 'LANG': 'en_US.UTF-8', 02:18:35 INFO - 'LANGUAGE': 'en_US:en', 02:18:35 INFO - 'LOGNAME': 'cltbld', 02:18:35 INFO - 'MAIL': '/var/mail/cltbld', 02:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:35 INFO - 'MOZ_NO_REMOTE': '1', 02:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:35 INFO - 'NO_EM_RESTART': '1', 02:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:35 INFO - 'PWD': '/builds/slave/test', 02:18:35 INFO - 'SHELL': '/bin/bash', 02:18:35 INFO - 'SHLVL': '1', 02:18:35 INFO - 'TERM': 'linux', 02:18:35 INFO - 'TMOUT': '86400', 02:18:35 INFO - 'USER': 'cltbld', 02:18:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:35 INFO - '_': '/tools/buildbot/bin/python'} 02:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:18:36 INFO - Cleaning up... 02:18:36 INFO - Return code: 0 02:18:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:18:36 INFO - Using env: {'DISPLAY': ':0', 02:18:36 INFO - 'HOME': '/home/cltbld', 02:18:36 INFO - 'LANG': 'en_US.UTF-8', 02:18:36 INFO - 'LANGUAGE': 'en_US:en', 02:18:36 INFO - 'LOGNAME': 'cltbld', 02:18:36 INFO - 'MAIL': '/var/mail/cltbld', 02:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:36 INFO - 'MOZ_NO_REMOTE': '1', 02:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:36 INFO - 'NO_EM_RESTART': '1', 02:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:36 INFO - 'PWD': '/builds/slave/test', 02:18:36 INFO - 'SHELL': '/bin/bash', 02:18:36 INFO - 'SHLVL': '1', 02:18:36 INFO - 'TERM': 'linux', 02:18:36 INFO - 'TMOUT': '86400', 02:18:36 INFO - 'USER': 'cltbld', 02:18:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:36 INFO - '_': '/tools/buildbot/bin/python'} 02:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:38 INFO - Downloading blobuploader-1.2.4.tar.gz 02:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:18:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:18:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 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 02:18:38 INFO - Downloading docopt-0.6.1.tar.gz 02:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:18:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:18:38 INFO - Running setup.py install for blobuploader 02:18:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:18:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:18:39 INFO - Running setup.py install for requests 02:18:39 INFO - Running setup.py install for docopt 02:18:39 INFO - Successfully installed blobuploader requests docopt 02:18:39 INFO - Cleaning up... 02:18:39 INFO - Return code: 0 02:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:39 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')]} 02:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:39 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')]} 02:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:39 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:39 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 02:18:39 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 02:18:39 INFO - Using env: {'DISPLAY': ':0', 02:18:39 INFO - 'HOME': '/home/cltbld', 02:18:39 INFO - 'LANG': 'en_US.UTF-8', 02:18:39 INFO - 'LANGUAGE': 'en_US:en', 02:18:39 INFO - 'LOGNAME': 'cltbld', 02:18:39 INFO - 'MAIL': '/var/mail/cltbld', 02:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:39 INFO - 'MOZ_NO_REMOTE': '1', 02:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:39 INFO - 'NO_EM_RESTART': '1', 02:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:39 INFO - 'PWD': '/builds/slave/test', 02:18:39 INFO - 'SHELL': '/bin/bash', 02:18:39 INFO - 'SHLVL': '1', 02:18:39 INFO - 'TERM': 'linux', 02:18:39 INFO - 'TMOUT': '86400', 02:18:39 INFO - 'USER': 'cltbld', 02:18:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:39 INFO - '_': '/tools/buildbot/bin/python'} 02:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:39 INFO - Running setup.py (path:/tmp/pip-jVv3Dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:39 INFO - Running setup.py (path:/tmp/pip-LhKbS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:39 INFO - Running setup.py (path:/tmp/pip-zWe3u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:39 INFO - Running setup.py (path:/tmp/pip-vv_3wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:40 INFO - Running setup.py (path:/tmp/pip-8zuc0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:40 INFO - Running setup.py (path:/tmp/pip-UV_DSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:40 INFO - Running setup.py (path:/tmp/pip-NDCCzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:40 INFO - Running setup.py (path:/tmp/pip-a2KEgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:40 INFO - Running setup.py (path:/tmp/pip-La8nT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:40 INFO - Running setup.py (path:/tmp/pip-SLfm66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:40 INFO - Running setup.py (path:/tmp/pip-gDpCOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:40 INFO - Running setup.py (path:/tmp/pip-MzNjy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:40 INFO - Running setup.py (path:/tmp/pip-czBFWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:40 INFO - Running setup.py (path:/tmp/pip-A9qTR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:40 INFO - Running setup.py (path:/tmp/pip-PqGWsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:40 INFO - Running setup.py (path:/tmp/pip-RsXITo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:40 INFO - Running setup.py (path:/tmp/pip-iFxaQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:18:40 INFO - Running setup.py install for manifestparser 02:18:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Running setup.py install for mozcrash 02:18:41 INFO - Running setup.py install for mozdebug 02:18:41 INFO - Running setup.py install for mozdevice 02:18:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Running setup.py install for mozfile 02:18:41 INFO - Running setup.py install for mozhttpd 02:18:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Running setup.py install for mozinfo 02:18:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Running setup.py install for mozInstall 02:18:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:18:41 INFO - Running setup.py install for mozleak 02:18:41 INFO - Running setup.py install for mozlog 02:18:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:18:42 INFO - Running setup.py install for moznetwork 02:18:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:18:42 INFO - Running setup.py install for mozprocess 02:18:42 INFO - Running setup.py install for mozprofile 02:18:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:18:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:18:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:18:42 INFO - Running setup.py install for mozrunner 02:18:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:18:42 INFO - Running setup.py install for mozscreenshot 02:18:42 INFO - Running setup.py install for moztest 02:18:42 INFO - Running setup.py install for mozversion 02:18:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:42 INFO - Cleaning up... 02:18:42 INFO - Return code: 0 02:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:42 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')]} 02:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:42 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')]} 02:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:42 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:42 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 02:18:42 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 02:18:42 INFO - Using env: {'DISPLAY': ':0', 02:18:42 INFO - 'HOME': '/home/cltbld', 02:18:42 INFO - 'LANG': 'en_US.UTF-8', 02:18:42 INFO - 'LANGUAGE': 'en_US:en', 02:18:42 INFO - 'LOGNAME': 'cltbld', 02:18:42 INFO - 'MAIL': '/var/mail/cltbld', 02:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:42 INFO - 'MOZ_NO_REMOTE': '1', 02:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:42 INFO - 'NO_EM_RESTART': '1', 02:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:42 INFO - 'PWD': '/builds/slave/test', 02:18:42 INFO - 'SHELL': '/bin/bash', 02:18:42 INFO - 'SHLVL': '1', 02:18:42 INFO - 'TERM': 'linux', 02:18:42 INFO - 'TMOUT': '86400', 02:18:42 INFO - 'USER': 'cltbld', 02:18:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:42 INFO - '_': '/tools/buildbot/bin/python'} 02:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:43 INFO - Running setup.py (path:/tmp/pip-x8283w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:43 INFO - Running setup.py (path:/tmp/pip-npBKNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:43 INFO - Running setup.py (path:/tmp/pip-Me6peL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:43 INFO - Running setup.py (path:/tmp/pip-lEb79z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:43 INFO - Running setup.py (path:/tmp/pip-odKaMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:43 INFO - Running setup.py (path:/tmp/pip-JFUA9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:43 INFO - Running setup.py (path:/tmp/pip-dtP5gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:43 INFO - Running setup.py (path:/tmp/pip-U0wTnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:43 INFO - Running setup.py (path:/tmp/pip-I9ZmDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:43 INFO - Running setup.py (path:/tmp/pip-2tgi3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:43 INFO - Running setup.py (path:/tmp/pip-3dkGzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:43 INFO - Running setup.py (path:/tmp/pip-2VVZZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:43 INFO - Running setup.py (path:/tmp/pip-SGTjwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:43 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)) 02:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:43 INFO - Running setup.py (path:/tmp/pip-MDGPcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:44 INFO - Running setup.py (path:/tmp/pip-TE8R_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:44 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)) 02:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:44 INFO - Running setup.py (path:/tmp/pip-OtII0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:44 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)) 02:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:44 INFO - Running setup.py (path:/tmp/pip-MGvCAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:44 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)) 02:18:44 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)) 02:18:44 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)) 02:18:44 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)) 02:18:44 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)) 02:18:44 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)) 02:18:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:46 INFO - Downloading blessings-1.6.tar.gz 02:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:46 INFO - Installing collected packages: blessings 02:18:46 INFO - Running setup.py install for blessings 02:18:46 INFO - Successfully installed blessings 02:18:46 INFO - Cleaning up... 02:18:46 INFO - Return code: 0 02:18:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:46 INFO - Reading from file tmpfile_stdout 02:18:46 INFO - Current package versions: 02:18:46 INFO - argparse == 1.2.1 02:18:46 INFO - blessings == 1.6 02:18:46 INFO - blobuploader == 1.2.4 02:18:46 INFO - docopt == 0.6.1 02:18:46 INFO - functools32 == 3.2.3-2 02:18:46 INFO - jsonschema == 2.5.1 02:18:46 INFO - manifestparser == 1.1 02:18:46 INFO - mozInstall == 1.12 02:18:46 INFO - mozcrash == 0.17 02:18:46 INFO - mozdebug == 0.1 02:18:46 INFO - mozdevice == 0.48 02:18:46 INFO - mozfile == 1.2 02:18:46 INFO - mozhttpd == 0.7 02:18:46 INFO - mozinfo == 0.9 02:18:46 INFO - mozleak == 0.1 02:18:46 INFO - mozlog == 3.3 02:18:46 INFO - moznetwork == 0.27 02:18:46 INFO - mozprocess == 0.23 02:18:46 INFO - mozprofile == 0.28 02:18:46 INFO - mozrunner == 6.12 02:18:46 INFO - mozscreenshot == 0.1 02:18:46 INFO - mozsystemmonitor == 0.3 02:18:46 INFO - moztest == 0.7 02:18:46 INFO - mozversion == 1.4 02:18:46 INFO - psutil == 3.1.1 02:18:46 INFO - requests == 1.2.3 02:18:46 INFO - wsgiref == 0.1.2 02:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:46 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')]} 02:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:46 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')]} 02:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:46 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:46 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 02:18:46 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 02:18:46 INFO - Using env: {'DISPLAY': ':0', 02:18:46 INFO - 'HOME': '/home/cltbld', 02:18:46 INFO - 'LANG': 'en_US.UTF-8', 02:18:46 INFO - 'LANGUAGE': 'en_US:en', 02:18:46 INFO - 'LOGNAME': 'cltbld', 02:18:46 INFO - 'MAIL': '/var/mail/cltbld', 02:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:46 INFO - 'MOZ_NO_REMOTE': '1', 02:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:46 INFO - 'NO_EM_RESTART': '1', 02:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:46 INFO - 'PWD': '/builds/slave/test', 02:18:46 INFO - 'SHELL': '/bin/bash', 02:18:46 INFO - 'SHLVL': '1', 02:18:46 INFO - 'TERM': 'linux', 02:18:46 INFO - 'TMOUT': '86400', 02:18:46 INFO - 'USER': 'cltbld', 02:18:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:46 INFO - '_': '/tools/buildbot/bin/python'} 02:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 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)) 02:18:46 INFO - Cleaning up... 02:18:46 INFO - Return code: 0 02:18:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18:46 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')]} 02:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:46 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')]} 02:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:46 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', '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 02:18:46 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 02:18:46 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 02:18:46 INFO - Using env: {'DISPLAY': ':0', 02:18:46 INFO - 'HOME': '/home/cltbld', 02:18:46 INFO - 'LANG': 'en_US.UTF-8', 02:18:46 INFO - 'LANGUAGE': 'en_US:en', 02:18:46 INFO - 'LOGNAME': 'cltbld', 02:18:46 INFO - 'MAIL': '/var/mail/cltbld', 02:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:46 INFO - 'MOZ_NO_REMOTE': '1', 02:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:46 INFO - 'NO_EM_RESTART': '1', 02:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:46 INFO - 'PWD': '/builds/slave/test', 02:18:46 INFO - 'SHELL': '/bin/bash', 02:18:46 INFO - 'SHLVL': '1', 02:18:46 INFO - 'TERM': 'linux', 02:18:46 INFO - 'TMOUT': '86400', 02:18:46 INFO - 'USER': 'cltbld', 02:18:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:46 INFO - '_': '/tools/buildbot/bin/python'} 02:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:18:47 INFO - Cleaning up... 02:18:47 INFO - Return code: 0 02:18:47 INFO - Running post-action listener: _resource_record_post_action 02:18:47 INFO - Running post-action listener: _start_resource_monitoring 02:18:47 INFO - Starting resource monitoring. 02:18:47 INFO - [mozharness: 2016-07-26 09:18:47.097193Z] Finished create-virtualenv step (success) 02:18:47 INFO - [mozharness: 2016-07-26 09:18:47.097750Z] Running install step. 02:18:47 INFO - Running pre-action listener: _resource_record_pre_action 02:18:47 INFO - Running main action method: install 02:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:47 INFO - Reading from file tmpfile_stdout 02:18:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:47 INFO - Reading from file tmpfile_stdout 02:18:47 INFO - Output received: 02:18:47 INFO - Usage: mozinstall [options] installer 02:18:47 INFO - Options: 02:18:47 INFO - -h, --help show this help message and exit 02:18:47 INFO - -d DEST, --destination=DEST 02:18:47 INFO - Directory to install application into. [default: 02:18:47 INFO - "/builds/slave/test"] 02:18:47 INFO - --app=APP Application being installed. [default: firefox] 02:18:47 INFO - mkdir: /builds/slave/test/build/application 02:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:19:03 INFO - Reading from file tmpfile_stdout 02:19:03 INFO - Output received: 02:19:03 INFO - /builds/slave/test/build/application/firefox/firefox 02:19:03 INFO - Running post-action listener: _resource_record_post_action 02:19:03 INFO - [mozharness: 2016-07-26 09:19:03.791389Z] Finished install step (success) 02:19:03 INFO - [mozharness: 2016-07-26 09:19:03.791668Z] Running run-tests step. 02:19:03 INFO - Running pre-action listener: _resource_record_pre_action 02:19:03 INFO - Running main action method: run_tests 02:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:03 INFO - Python 2.7.3 02:19:03 INFO - Return code: 0 02:19:03 INFO - grabbing minidump binary from tooltool 02:19:03 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')]} 02:19:03 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 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:03 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 02:19:03 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 02:19:03 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 02:19:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:03 INFO - Return code: 0 02:19:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:19:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:19:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:03 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/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:19:03 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/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 02:19:03 INFO - Using env: {'DISPLAY': ':0', 02:19:03 INFO - 'HOME': '/home/cltbld', 02:19:03 INFO - 'LANG': 'en_US.UTF-8', 02:19:03 INFO - 'LANGUAGE': 'en_US:en', 02:19:03 INFO - 'LOGNAME': 'cltbld', 02:19:03 INFO - 'MAIL': '/var/mail/cltbld', 02:19:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:03 INFO - 'MOZ_NO_REMOTE': '1', 02:19:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:03 INFO - 'NO_EM_RESTART': '1', 02:19:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:03 INFO - 'PWD': '/builds/slave/test', 02:19:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:03 INFO - 'SHELL': '/bin/bash', 02:19:03 INFO - 'SHLVL': '1', 02:19:03 INFO - 'TERM': 'linux', 02:19:03 INFO - 'TMOUT': '86400', 02:19:03 INFO - 'USER': 'cltbld', 02:19:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343', 02:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:03 INFO - '_': '/tools/buildbot/bin/python'} 02:19:03 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/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:19:04 INFO - mozversion application_buildid: 20160726014102 02:19:04 INFO - mozversion application_changeset: e1ac106612412ecf23e8cc0faff7519b03728c37 02:19:04 INFO - mozversion application_display_name: Nightly 02:19:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:04 INFO - mozversion application_name: Firefox 02:19:04 INFO - mozversion application_remotingname: firefox 02:19:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:19:04 INFO - mozversion application_vendor: Mozilla 02:19:04 INFO - mozversion application_version: 50.0a1 02:19:04 INFO - mozversion platform_buildid: 20160726014102 02:19:04 INFO - mozversion platform_changeset: e1ac106612412ecf23e8cc0faff7519b03728c37 02:19:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:19:04 INFO - mozversion platform_version: 50.0a1 02:19:04 INFO - using testdate: 1469524744 02:19:04 INFO - actual date: 1469524744 02:19:04 INFO - starting webserver on 'localhost:34975' 02:19:04 INFO - SUITE-START | Running 2 tests 02:19:04 INFO - TEST-START | dromaeo_css 02:19:04 INFO - operating with platform_type : linux_ 02:19:04 INFO - Initialising browser for dromaeo_css test... 02:19:04 INFO - TEST-INFO | started process 2196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3291jR/profile http://localhost:34975/getInfo.html) 02:19:08 INFO - PROCESS | 2196 | JavaScript error: , line 0: uncaught exception: undefined 02:19:09 INFO - PROCESS | 2196 | __metrics Screen width/height:1600/1200 02:19:09 INFO - PROCESS | 2196 | colorDepth:24 02:19:09 INFO - PROCESS | 2196 | Browser inner width/height: 1024/697 02:19:09 INFO - PROCESS | 2196 | __metrics 02:19:10 INFO - PROCESS | 2196 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:19:10 INFO - PROCESS | 2196 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:19:11 INFO - TEST-INFO | 2196: exit 0 02:19:11 INFO - Browser initialized. 02:19:11 INFO - Running cycle 1/1 for dromaeo_css test... 02:19:11 INFO - TEST-INFO | started process 2274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3291jR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:23 INFO - PROCESS | 2274 | RSS: Main: 159092736 02:19:23 INFO - PROCESS | 2274 | 02:20:15 INFO - PROCESS | 2274 | 1469524815199 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] 02:22:27 INFO - PROCESS | 2274 | Cycle 1(1): loaded http://localhost:34975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34975/tests/dromaeo/cssquery-ext.html) 02:22:28 INFO - PROCESS | 2274 | RSS: Main: 240754688 02:22:28 INFO - PROCESS | 2274 | 02:25:31 INFO - PROCESS | 2274 | Cycle 1(1): loaded http://localhost:34975/tests/dromaeo/cssquery-ext.html (next: http://localhost:34975/tests/dromaeo/cssquery-jquery.html) 02:25:31 INFO - PROCESS | 2274 | RSS: Main: 242515968 02:25:31 INFO - PROCESS | 2274 | 02:28:33 INFO - PROCESS | 2274 | Cycle 1(1): loaded http://localhost:34975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34975/tests/dromaeo/cssquery-mootools.html) 02:28:34 INFO - PROCESS | 2274 | RSS: Main: 221224960 02:28:34 INFO - PROCESS | 2274 | 02:31:36 INFO - PROCESS | 2274 | Cycle 1(1): loaded http://localhost:34975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34975/tests/dromaeo/cssquery-prototype.html) 02:31:37 INFO - PROCESS | 2274 | RSS: Main: 190529536 02:31:37 INFO - PROCESS | 2274 | 02:34:40 INFO - PROCESS | 2274 | Cycle 1(1): loaded http://localhost:34975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34975/tests/dromaeo/cssquery-yui.html) 02:34:40 INFO - PROCESS | 2274 | RSS: Main: 190627840 02:34:40 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | Cycle 1(1): loaded http://localhost:34975/tests/dromaeo/cssquery-yui.html (next: http://localhost:34975/tests/dromaeo/cssquery-dojo.html) 02:37:44 INFO - PROCESS | 2274 | RSS: Main: 279576576 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | __start_tp_report 02:37:44 INFO - PROCESS | 2274 | _x_x_mozilla_page_load 02:37:44 INFO - PROCESS | 2274 | _x_x_mozilla_page_load_details 02:37:44 INFO - PROCESS | 2274 | |i|pagename|runs| 02:37:44 INFO - PROCESS | 2274 | |0;dojo.html;2633.1442281258596;2633.8946442142314;2647.073524266506;2671.171936699623;2682.7853771698265;4641.327007583898;4726.503717109706;4728.692634978728;4841.055994081155;4846.563809257171;4740.905181896369;4786.3059856320815;4790.640701947351;4821.397325334333;4856.10162120008;4359.607635312821;4368.694191406603;4444.155610434023;4498.955010449903;4553.863384098466;4456.79944402501;4506.481754598214;4524.253498172798;4528.660350473728;4544.704594201383;4291.506476755182;4321.783910804479;4332.740035597874;4388.451443569554;4451.599356057938;4364.934525982113;4398.560143985608;4415.425994620711;4453.1316393303;4481.619062379702;4326.134773045404;4348.152110338485;4366.323219900921;4392;4394.121175764828;4736.999999999965;4776.020915712271;4821.397325334333;4830.0339932013385;4838.564529192389;4987.47631498691;5059.342285502861;5063.620228482879;5106.693598384109;5158.40678321994;5056.823011194628;5174.016936781999;5178.14560597501;5181.35233095863;5188.429272779991;4650.558196971282;4816.56650901417;4824.228123500223;4830.033993201374;4844.515548445127;5229.346331708536;5256.474352564789;5258.579313654898;5303.973480132652;5315.548178404879;5043.52086551777;5048.444671086178;5054.342935418372;5101.311322971425;5107.233914912793;5029.64792464524;5125.231215317732;5182;5185.792568297301;5187.610929180327;4975;4995.550400463976;5002.324686167393;5072.82245121419;5081.339425874613;4985.252212168204;4991.176455884738;4994.925076123861;4999.3000979862845;5057.140286151363;4318.870433886988;4326.394304797331;4332.393464914914;4337.306031035019;4377.3871657967275;3771.453139294787;3773.4528493368307;3782.791946442972;3788.1287303919703;3828.310904037244;4427.29163333865;4431.158079964861;4460.888477788081;4474.26174681174;4480.462344518679;5143.897122057538;5175.922361164586;5181.4300426953005;5186.870328241824;5232.581393488512;4278.764667943293;4346.6522678185665;4375.934360984587;4412.24991751403;4468.396766436555;4578.1301552705545;4614.238650622609;4619.2609182531305;4638.536146385334;4652.813887444532;4803.495632958489;4805.687630304019;4811.350467686818;4814.061258054646;4857.149998750205;5064.265681476091;5074.06129865976;5112.309838171799;5127.923081153711;5180.378354597472;4774.188387974123;4821.252705830602;4822.083804077214;4851.684640498356;4858.514148585114;5028.34631497903;5031.760118863534;5037;5044.394672639307;5078.898422031612;5013.749312534432;5045.646804723634;5110.8466745997675;5122.692638441706;5175.534201921845;4939.086269040239;4969.453360130455;4982.925256121233;5023.09584274834;5024.547790698854;5002.799888004439;5016.523430274118;5019.372578427697;5019.372578427697;5072.82245121419;4791.4729379767505;4824.662273640952;4942.036302920896;4948.109340318777;4989.650724449254;4958.801647934042;5003.724795136302;5007.39911210657;5042.873928151826;5085.364329458817;4917.975410122926;4935.481774413634;4942.159832828356;4944.233643785219;4985.551300382983 02:37:44 INFO - PROCESS | 2274 | |1;ext.html;571.8255931940757;578.3753546170136;578.467809615154;581.3285655068395;582.8222392170389;27709.168724938234;39912;41081.79459102708;41153.99999999993;44456.88745794226;41360.58639413605;41689.791551042275;41731;41733.16533669325;41751.37372939409;7612.885806712918;7756.340711039568;7756.379489640815;7761.3402860756905;7764.689412423496;7359.116905971264;9847.359921605073;10080.697579072603;10102.444365559892;10436.895631043706;10232.07911287984;10233;10236.897631023707;10249.948750256275;10309.948450257776;9889.802203955916;9937.254705897087;9972.301938864282;9973.900260997443;9978.251631127621;9898.109170174646;9956.95021524895;9972.451515166664;9979.451130187837;9981.600735970553;38633.42049869254;38943.61056389457;38976.80511597452;39009;39039.21921561581;2940.6324209473814;2974.3456439583256;3007.639083309995;3115.875364985398;3123.6563977962405;29159.271018224503;29588.112356629335;29609.40781184364;29962.85018574915;30453.39093218123;3332.266901281714;3363.865445382182;3386.6782655647676;3417.7650087386255;3447.931041379158;188745;189535;191286;192134;192205;31916.680833191836;33076.17309567232;33087.66912330846;54026.45973540293;54520;33168.33663326768;33256.833715831264;33274.3345133096;33333.166670832936;33336.33327333488;13616.727665446833;13722;13729.244891531062;13732.931335343259;13733.244671543162;10138.543765530569;11345.489452974636;11391.088712902947;11451.312921224753;11451.88548114525;7760.534367937942;7916.960415197887;7943.761687149395;7956.761297160979;7957.562334071682;2986.148947549938;3077.3076057886797;3078.98460507696;3086.382723455318;3107.3319236363836;856.8329175810782;899.2150581096519;903.4488961733338;943.8820147481565;1007.1640538353296;26376.20871373862;26615.467690646077;26835.194944151706;27904.581431278548;27929.301767455978;920;951.1154626197703;956.660385563129;968.8692026576463;1007.9042490963346;14276.286185690675;14587.562373128823;14684.926575367055;14737.410503579737;14824.481143159937;426541;433361;435192;435396;435812;49130.26304605434;49662.25506617404;49746.75126624344;49753.751231244336;49768.50231497639;1082.2965072702648;1161.8780028097096;1172.7771723372532;1185.6917201527492;1208.697825543614;27354.179374618794;27881.581776272968;28333.716662833933;28753.568696469152;28814;42092;42440.787796060824;42454;42528.14943701171;42568;325282.97736180574;326297;326436;327681;327716;24797.752022480265;25514.362140946625;25917.6112358311;25937.351566210997;26974.1907742768;40510.797446012584;40584;41181.382279266436;41762;41921.79039104785;35085.122871928404;35349;35359;35859.282814344086;35989.82005089958;35340.29319413649;35616.643833561335;35716.64283357237;35825.283494329444;35971.64028359787;34508.48237276493;37615.86225515136;37960;38835.41746873856;40906;36266.27467450689;37693.81153094217;37699.24601508009;37907.24185516219;38181;29723.108306750833;30006;30312.393752125274;30900.22749431282;30966 02:37:44 INFO - PROCESS | 2274 | |2;jquery.html;346.1622872648191;367;372.11251165969156;375.86468871206375;391.6807801641662;12807.935960320197;15972.84027159728;16479.670406591875;17641.294348226056;17782.46652600421;16868;16972.83027169728;17032.06323652202;17056.403025894095;17228.483145505623;4998.750062496879;5063.417706963691;5136.64043516954;5161.509656582619;5163.225516172585;3685.281370132812;5101.183810590306;5181.404138524081;5781.913271300934;6083.543734219929;6077.361877002917;6110.663913484756;6121.785737499188;6126.448619624255;6128.662923539204;5926.466618004379;6023.096535519685;6163.506919446433;6173.1048997895505;6173.81478555644;5182.818601348972;5435.782568697247;5437.945620543784;5441.483059109379;5444.891102177934;20601.79398206014;20883.164673413045;20947.8952605236;20984;20992.790072099237;1907.5803323268997;1908.9045547722696;2354.9175778847657;2444.963325550118;2463.913763018286;12533;12969.157004794659;13168.209907405586;13195.802062969064;13777;1694.1613901118901;1766.2669991953323;1776.8312010358995;1806.5122416947481;1809.80092189859;65815.67092164556;65898;66871.66564167196;67611.32388676099;68362.65818670925;9531.094546018117;9568.138867501959;9721.222302215805;9805.509724513888;9928.553215105338;13490;13490.662733431547;13491.123076999964;13497.122687025312;13527.32363381827;7279.963600181965;7466.402687784964;7469.701211951461;7617.124030736425;7631.3513351364645;7233.168185658611;7269.927300726925;7415.703371865173;7509.286617771303;7522.962385188149;5968.253968253968;6101.572889897665;6148;6178.41305076017;6344.841378965562;1709.1881356355632;1730.2041061111777;1766.2934826069675;1791.8387345139;1812.4743824290808;670.909427227318;819.4919150126959;825.7481468152151;880.4849163239448;904.4799240436776;16542.83457165437;16782.244798984077;17147.399841005506;17392.65214695699;17804.732929005815;843.5529169540154;855.6320782063648;906.6282824042111;944.8015916657579;971.3491960386558;9615.90384096164;10071.798564028679;10115.898841011644;10164.644237451654;10268.127209187303;355257;414874;415664;417976;423262;85592.57203713941;86291.56854215689;86799;88097;89195;889.5996801439378;899.8020435504178;936.1387523478417;941.1811723800338;944.1691311645845;14787.630309241924;15882.920585397462;16109.838901610834;16169.110698911672;16902;38880.80559597184;39900.60099398969;40201;41161;42830.571694282655;53148.2027769576;53644.46355536551;54043;54198.72900635472;54471.455285448224;6471.902921456276;7204.4956853019785;7353.191148973716;7419.258074192538;7616.543007419573;7858.332041776513;9059.547022648972;9953.950230249093;11555.364454955059;12272;9204.815903681754;9471.526423678652;9706.369086009387;9878.901210987799;10306.587736490756;10112.191024718151;10141.239407044353;10561.894381056398;10670.946645266724;10782.353058816496;9523.190528804853;10142.949285253822;10346.948265258625;10366;10372.429516376369;7324.560526368435;7425.740099096506;7555.848883022419;7676.769696909102;7730.072391313079;9499.572519236513;9815.803683926424;10082;10316.43259620728;10496.21278404138 02:37:44 INFO - PROCESS | 2274 | |3;mootools.html;1349.5816296947946;1422.4594654031466;1440.582231152965;1634.3707672546066;1662.8420300071489;7900.130985591588;8184.468009579381;8245.83508329833;8249.133840946704;8258.174182581739;6690.63201523916;7363.5581865088;7544.849103017937;7561.962190189041;8103.837923241546;2233.05095334483;2256.6615007748806;2258.435391152212;2258.954820903581;2264.1056782570877;2164.751053628837;2210.2264207527396;2214.7785221477884;2215.7230346206725;2217.1020736601704;1881.9153138108818;1945.1830231302886;1951.6877299632063;1957.109515170601;2099;2187.1688758271835;2218.622834118196;2228.9665655015187;2229.598672238996;2231.2190733243397;2232.5088480534255;2241.8991145398495;2249.8650080995194;2251.8311126665567;2287.633978563422;8050.194980501961;8134.227248411392;8137.186281371874;8181.590920453954;8187.0994190638985;4573.565511276423;4710.623150148014;4713.387259656257;4716.056788642285;4716.976415117937;2786.21985843964;2904.0997290839696;2938.9706102938912;2952.1438782752975;2953.586497890297;867.7223288547667;905.2305540290766;912.8037471943564;913.7258822353267;920.456930411054;10893.07408870247;10929.945350273198;10940.781184376268;10947.34315941046;10959.671209863716;3977.482927219443;4370.934435983463;4410.977945110254;4516.36770852081;4531.207038768268;9404.764880878032;9439.433633981984;9446.244300455946;9450.621975121056;9454.90545094554;4815.374001379868;4819.518048195152;4824.589909857631;4832.565069143794;4833.564979151894;4271.914561708749;4388.539203383599;4403.097365040159;4406.581374769392;4407.294832826732;3685.7788532688123;3699.7780133191554;3775.5091838060875;3798.7340886137704;3818.522684664417;1191.1304747534175;1202.1224506110589;1203.536638394207;1205.951761929513;1217.379136640302;681.7716065118142;682.4403988729194;744.3003576637943;824.3322908444179;824.7608193623902;5294.629375943647;5296.496832800878;5366.7853285868905;5402.837914862561;5618.0449323615085;404.82390160280374;412.6492481390854;413.8944569134912;418.4894428796863;426.6565414841021;3613.94579081314;3659.2315613720884;3684.3920753075977;3703.777773333609;3738.794366309879;9797.510124493747;10096.69709908704;10199.38803671782;10211;10230.335028223142;10087.899121008842;10178.847317290247;10204.897951020543;10208.030237127461;10232.334898231591;7540;7582.507137036075;7603.01160849086;7621.123570789319;7637.42719296055;5288.68267903927;5423.891522169455;5451.236826844166;5461.290032295776;5734.569907257056;8756.387052906235;8897.599608017525;9036.096390360912;9042.412243204171;9154.038825923182;9064.229540489132;9189.954050229706;9292.39599426035;9396.107369799858;9474.57364418589;6961.199462061928;7144.071270734771;7530.359919406693;7701.922980770345;7703.845923081619;7322.121345438582;7376.373008294355;7382.815429614303;7385.335319821242;7389.371903388273;5672.631278966854;6639.900401493885;6785.117934668461;6798.184217893884;6918.688659010256;5879.794207202727;6664.633445160563;6788.389044985975;6790.320967903368;6797.286284940208;5843.094320380348;6006.909896351471;6057.061155520902;6377.362263773585;6441.581297215666;4519.435070616173;4607.124646317189;4622.2835460503675;4708.952910470988;4876.390451193601;4397.516273209881;4506.031203291308;4666.0434610904;4666.206744853451;4705.270683044134 02:37:44 INFO - PROCESS | 2274 | |4;prototype.html;302.6066114051733;304.812540287723;313.0748637775373;313.7960325788239;313.8273949327869;4808.663393562452;4907.3129761833325;4920.212765957447;4925.926111108327;4942.6540142190015;4870.439899411569;4872.220444728844;4875.317455556216;4885.511448855113;4891.559759621633;3621.841010876527;3727.6458736419995;3729.216864458467;3800.752951058186;3883.359245724452;3855.1133239354967;3872.5159355080614;3885.358915778893;3890.9805450972704;3931.1351502669368;3821.254855303217;3835.408305553192;3837.2325534892993;3840.7695538267653;3845.730798844082;3613.963860361402;3710.868185203525;3828.349180639298;3838.2707285615925;3847.1728578355787;3421.716856178933;3422.058933793202;3429.382711111999;3434.0384692286198;3447.5690538682666;4749.572538471554;4778.235482322812;4790.5448982346625;4806.567408933178;4816.56650901417;4191.811368488426;4355.825766969318;4393.53867843875;4462.152191083684;4468.486124095738;5065.4174769901565;5077.847664570032;5080.568151707109;5091.287219789232;5104.310918026056;3716.1267102230954;3727.459518369821;3746.7002639788752;3748.6626203641804;3762.285165818513;5027.798888044474;5293.179557168645;5417.187421886709;5436.619436639437;5441.619086663935;3647.1976165243605;3649.85400583979;3660.5424321959754;3668.651478109629;3673.485712000322;3731.197792474631;3732.2162345907122;3735.159589092487;3743.026813028632;3756.2487502499607;4308.849190278325;4325.589069038437;4325.826966921288;4328.679752675402;4336.76147811867;5053.494650534917;5100.923486147636;5102.5278943495205;5106.923396149061;5111.702951596274;1336.2650542201945;1341.9798703019462;1344.892408607309;1349.8447678517095;1364.7679894417774;818.43119032272;856.2978357746588;876.6887754846938;881.7487016200353;894.7116152740034;4404.295312749945;4494.483134439516;4495.955040449554;4511.70673906195;4525.683202175816;5233.633645644768;5242.213667949762;5244.842654720364;5251.396089449762;5271.65734227274;4509.6392288616835;4516.141933032779;4531.886702832456;4546.363509108727;4555.2711566149255;2663.600459930987;2825.2230636574695;2828.9009884653938;2831.66020077592;2836.432713457317;5013.473585273494;5015.799368025311;5015.949840501548;5019.322391477177;5039.899202015939;5309.36287645485;5444.50999410055;5447.5641948644015;5464.153056276284;5477.315335583052;4874.780634871439;4883;4946.950530494721;4955.3805774278935;4962.478939711278;5229.267902493578;5239.921401179062;5252.343457067866;5258.605604579749;5263.815766448309;4963.875903102306;5160.690358578498;5165.66423182492;5169.715665638276;5184;4951.3810773653295;4953.3065370848835;4956.182229932021;4961.6030717543235;4971.477994810638;3381;3389.271306669078;3397.4733916242035;3417.401954657875;3432.982835085809;4594.609458196091;4745.667803253739;4769.66612337133;4771.95228047715;4791.377120974251;4564.589186973189;4569.954300456953;4583.289590113538;4589.196890544074;4619.390044624776;4534.795934182904;4545.545445455428;4572.611328037154;4578.771061446848;4587.6788624795945;4338.02845051141;4482.574155455227;4501.752403617701;4512.796924138487;4547;4596.770161491845;4623.861643828687;4839;4963.255511673278;5145.279660847409;4984.081128765524;5003.1238285642885;5012.448630650552;5025.522575355335;5030.698158110525 02:37:44 INFO - PROCESS | 2274 | |5;yui.html;570.2074116977402;640.2828831708484;654.7839213059691;669.9598024118553;673.2157037051834;12096.516139354415;13128.540501082463;13139.080264381486;13147.47410103596;13910.721785564283;12650.620481385573;13747.725045499084;13814;13852.861471385308;13965.44138234472;759.8822182561698;786.8622990976585;788.0189164490217;788.3023524181084;788.5899332347204;621.9129321894916;638.8019713888687;741.3809469093287;764.9273319034683;781.4568874632133;805.814662627596;806.8587997100514;807.6527093349857;807.8626633472294;808.0747544062045;799.6441583495347;800.747764454195;800.7998000499904;801.0307527891258;801.1747899663357;478.6577597018149;568.6275489554348;585.0084107437895;585.6690969602162;587.6591576885396;12467.563635272722;12628.68428289291;12647.49410023598;12674.556390526379;12705.555305564354;11303.265287756269;11435;11540.134489913205;11671.358075305854;12072.517099316105;11894.345810980392;11935.701607459883;11961.026430638934;11970.162088653798;12017.699557511132;4173.812178451946;4233.322668373045;4243.257429949746;4266.317389217741;4268.103698223377;64655.3534464654;65356.82470553329;65450.3454965449;65942.3405765941;66480.66759666218;9399.060093990684;9714.562844672007;9749.171320437701;10052.54763535628;10515.579376824995;19289;19334.226630934605;19341.80658193428;19373;19437.8056219436;6641.933580664228;6668.366505182;6773.085633439423;6934.653267336613;6968.128983877015;3619.7466177367332;3639.29033838399;3640.3993341098953;3658.8902332930056;3686.705063594906;2748.628935093777;2860.4565132624734;2865.7134286571595;2865.785066120049;2868.096549586915;492.83736366998806;503.22252120473956;503.61221859168234;509.987250318745;510.30853193922445;477.40086191829727;517.3352242368538;519.7037688517509;539.1885212754858;540.835045311176;6846.8378955734715;6994.33553812387;7027.472939529555;7131.0729605151;7250.274972502813;458.21416271095234;491.64847134299146;516.40097486915;521.9608529360237;524.2764984321688;3402.2004828865197;3460.8788692395647;3484.425069863444;3505.5267538881926;3585.713142948558;49555.25667114996;49863;49900.50099498958;50448.747756260986;55844.72077639586;79950;80364.59817700874;81107;82925;84745;44699.55300447019;47727.28409073866;65306.67346663236;66298;73892.63053684698;7266.309700578437;7369.963150184215;7546.3962882968135;8002;8151.79620509492;32254.677453226104;33462.16344591405;42752.08351039546;45077.54922450733;45311;64242;64995.67502162459;65006;65557;65881.67059164673;9709.126178643955;9915.900840991499;9957.253206009433;9983.450910200008;10567.365958042543;10513.579456821948;10644.520996555328;10893.727656808644;11102.666919992413;11119.27724697892;9208.953955230449;9699.854502182614;10255.333403329058;10333;10962.232643714864;8685.39202255836;8720.956395217983;9115;10281;10468.581256749645;9861.556229969812;10143.746406339606;10152;10860.348379097279;10862.131029517777;7697.499662522142;7903.293866507669;7945.960270198612;8002.59987000636;8066.435349525712;7755.302022817974;7938.880916786137;8111.513309201467;8152.510849349058;8169.223923727474 02:37:44 INFO - PROCESS | 2274 | __end_tp_report 02:37:44 INFO - PROCESS | 2274 | __start_cc_report 02:37:44 INFO - PROCESS | 2274 | _x_x_mozilla_cycle_collect,1134 02:37:44 INFO - PROCESS | 2274 | __end_cc_report 02:37:44 INFO - PROCESS | 2274 | __startTimestamp1469525864308__endTimestamp 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | ------- Summary: start ------- 02:37:44 INFO - PROCESS | 2274 | Number of tests: 6 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | [#0] dojo.html Cycles:165 Average:4732.97 Median:4846.56 stddev:496.73 (10.2%) stddev-sans-first:470.15 02:37:44 INFO - PROCESS | 2274 | Values: 2633.1 2633.9 2647.1 2671.2 2682.8 4641.3 4726.5 4728.7 4841.1 4846.6 4740.9 4786.3 4790.6 4821.4 4856.1 4359.6 4368.7 4444.2 4499.0 4553.9 4456.8 4506.5 4524.3 4528.7 4544.7 4291.5 4321.8 4332.7 4388.5 4451.6 4364.9 4398.6 4415.4 4453.1 4481.6 4326.1 4348.2 4366.3 4392.0 4394.1 4737.0 4776.0 4821.4 4830.0 4838.6 4987.5 5059.3 5063.6 5106.7 5158.4 5056.8 5174.0 5178.1 5181.4 5188.4 4650.6 4816.6 4824.2 4830.0 4844.5 5229.3 5256.5 5258.6 5304.0 5315.5 5043.5 5048.4 5054.3 5101.3 5107.2 5029.6 5125.2 5182.0 5185.8 5187.6 4975.0 4995.6 5002.3 5072.8 5081.3 4985.3 4991.2 4994.9 4999.3 5057.1 4318.9 4326.4 4332.4 4337.3 4377.4 3771.5 3773.5 3782.8 3788.1 3828.3 4427.3 4431.2 4460.9 4474.3 4480.5 5143.9 5175.9 5181.4 5186.9 5232.6 4278.8 4346.7 4375.9 4412.2 4468.4 4578.1 4614.2 4619.3 4638.5 4652.8 4803.5 4805.7 4811.4 4814.1 4857.1 5064.3 5074.1 5112.3 5127.9 5180.4 4774.2 4821.3 4822.1 4851.7 4858.5 5028.3 5031.8 5037.0 5044.4 5078.9 5013.7 5045.6 5110.8 5122.7 5175.5 4939.1 4969.5 4982.9 5023.1 5024.5 5002.8 5016.5 5019.4 5019.4 5072.8 4791.5 4824.7 4942.0 4948.1 4989.7 4958.8 5003.7 5007.4 5042.9 5085.4 4918.0 4935.5 4942.2 4944.2 4985.6 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | [#1] ext.html Cycles:180 Average:46500.07 Median:35212.71 stddev:87989.05 (249.9%) stddev-sans-first:88168.31 02:37:44 INFO - PROCESS | 2274 | Values: 571.8 578.4 578.5 581.3 582.8 27709.2 39912.0 41081.8 41154.0 44456.9 41360.6 41689.8 41731.0 41733.2 41751.4 7612.9 7756.3 7756.4 7761.3 7764.7 7359.1 9847.4 10080.7 10102.4 10436.9 10232.1 10233.0 10236.9 10249.9 10309.9 9889.8 9937.3 9972.3 9973.9 9978.3 9898.1 9957.0 9972.5 9979.5 9981.6 38633.4 38943.6 38976.8 39009.0 39039.2 2940.6 2974.3 3007.6 3115.9 3123.7 29159.3 29588.1 29609.4 29962.9 30453.4 3332.3 3363.9 3386.7 3417.8 3447.9 188745.0 189535.0 191286.0 192134.0 192205.0 31916.7 33076.2 33087.7 54026.5 54520.0 33168.3 33256.8 33274.3 33333.2 33336.3 13616.7 13722.0 13729.2 13732.9 13733.2 10138.5 11345.5 11391.1 11451.3 11451.9 7760.5 7917.0 7943.8 7956.8 7957.6 2986.1 3077.3 3079.0 3086.4 3107.3 856.8 899.2 903.4 943.9 1007.2 26376.2 26615.5 26835.2 27904.6 27929.3 920.0 951.1 956.7 968.9 1007.9 14276.3 14587.6 14684.9 14737.4 14824.5 426541.0 433361.0 435192.0 435396.0 435812.0 49130.3 49662.3 49746.8 49753.8 49768.5 1082.3 1161.9 1172.8 1185.7 1208.7 27354.2 27881.6 28333.7 28753.6 28814.0 42092.0 42440.8 42454.0 42528.1 42568.0 325283.0 326297.0 326436.0 327681.0 327716.0 24797.8 25514.4 25917.6 25937.4 26974.2 40510.8 40584.0 41181.4 41762.0 41921.8 35085.1 35349.0 35359.0 35859.3 35989.8 35340.3 35616.6 35716.6 35825.3 35971.6 34508.5 37615.9 37960.0 38835.4 40906.0 36266.3 37693.8 37699.2 37907.2 38181.0 29723.1 30006.0 30312.4 30900.2 30966.0 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | [#2] jquery.html Cycles:180 Average:25290.77 Median:5172.31 stddev:67193.21 (1299.1%) stddev-sans-first:67355.60 02:37:44 INFO - PROCESS | 2274 | Values: 346.2 367.0 372.1 375.9 391.7 12807.9 15972.8 16479.7 17641.3 17782.5 16868.0 16972.8 17032.1 17056.4 17228.5 4998.8 5063.4 5136.6 5161.5 5163.2 3685.3 5101.2 5181.4 5781.9 6083.5 6077.4 6110.7 6121.8 6126.4 6128.7 5926.5 6023.1 6163.5 6173.1 6173.8 5182.8 5435.8 5437.9 5441.5 5444.9 20601.8 20883.2 20947.9 20984.0 20992.8 1907.6 1908.9 2354.9 2445.0 2463.9 12533.0 12969.2 13168.2 13195.8 13777.0 1694.2 1766.3 1776.8 1806.5 1809.8 65815.7 65898.0 66871.7 67611.3 68362.7 9531.1 9568.1 9721.2 9805.5 9928.6 13490.0 13490.7 13491.1 13497.1 13527.3 7280.0 7466.4 7469.7 7617.1 7631.4 7233.2 7269.9 7415.7 7509.3 7523.0 5968.3 6101.6 6148.0 6178.4 6344.8 1709.2 1730.2 1766.3 1791.8 1812.5 670.9 819.5 825.7 880.5 904.5 16542.8 16782.2 17147.4 17392.7 17804.7 843.6 855.6 906.6 944.8 971.3 9615.9 10071.8 10115.9 10164.6 10268.1 355257.0 414874.0 415664.0 417976.0 423262.0 85592.6 86291.6 86799.0 88097.0 89195.0 889.6 899.8 936.1 941.2 944.2 14787.6 15882.9 16109.8 16169.1 16902.0 38880.8 39900.6 40201.0 41161.0 42830.6 53148.2 53644.5 54043.0 54198.7 54471.5 6471.9 7204.5 7353.2 7419.3 7616.5 7858.3 9059.5 9954.0 11555.4 12272.0 9204.8 9471.5 9706.4 9878.9 10306.6 10112.2 10141.2 10561.9 10670.9 10782.4 9523.2 10142.9 10346.9 10366.0 10372.4 7324.6 7425.7 7555.8 7676.8 7730.1 9499.6 9815.8 10082.0 10316.4 10496.2 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | [#3] mootools.html Cycles:180 Average:5242.74 Median:4714.72 stddev:3002.49 (63.7%) stddev-sans-first:2996.66 02:37:44 INFO - PROCESS | 2274 | Values: 1349.6 1422.5 1440.6 1634.4 1662.8 7900.1 8184.5 8245.8 8249.1 8258.2 6690.6 7363.6 7544.8 7562.0 8103.8 2233.1 2256.7 2258.4 2259.0 2264.1 2164.8 2210.2 2214.8 2215.7 2217.1 1881.9 1945.2 1951.7 1957.1 2099.0 2187.2 2218.6 2229.0 2229.6 2231.2 2232.5 2241.9 2249.9 2251.8 2287.6 8050.2 8134.2 8137.2 8181.6 8187.1 4573.6 4710.6 4713.4 4716.1 4717.0 2786.2 2904.1 2939.0 2952.1 2953.6 867.7 905.2 912.8 913.7 920.5 10893.1 10929.9 10940.8 10947.3 10959.7 3977.5 4370.9 4411.0 4516.4 4531.2 9404.8 9439.4 9446.2 9450.6 9454.9 4815.4 4819.5 4824.6 4832.6 4833.6 4271.9 4388.5 4403.1 4406.6 4407.3 3685.8 3699.8 3775.5 3798.7 3818.5 1191.1 1202.1 1203.5 1206.0 1217.4 681.8 682.4 744.3 824.3 824.8 5294.6 5296.5 5366.8 5402.8 5618.0 404.8 412.6 413.9 418.5 426.7 3613.9 3659.2 3684.4 3703.8 3738.8 9797.5 10096.7 10199.4 10211.0 10230.3 10087.9 10178.8 10204.9 10208.0 10232.3 7540.0 7582.5 7603.0 7621.1 7637.4 5288.7 5423.9 5451.2 5461.3 5734.6 8756.4 8897.6 9036.1 9042.4 9154.0 9064.2 9190.0 9292.4 9396.1 9474.6 6961.2 7144.1 7530.4 7701.9 7703.8 7322.1 7376.4 7382.8 7385.3 7389.4 5672.6 6639.9 6785.1 6798.2 6918.7 5879.8 6664.6 6788.4 6790.3 6797.3 5843.1 6006.9 6057.1 6377.4 6441.6 4519.4 4607.1 4622.3 4709.0 4876.4 4397.5 4506.0 4666.0 4666.2 4705.3 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | [#4] prototype.html Cycles:180 Average:4180.28 Median:4581.03 stddev:1198.95 (26.2%) stddev-sans-first:1166.46 02:37:44 INFO - PROCESS | 2274 | Values: 302.6 304.8 313.1 313.8 313.8 4808.7 4907.3 4920.2 4925.9 4942.7 4870.4 4872.2 4875.3 4885.5 4891.6 3621.8 3727.6 3729.2 3800.8 3883.4 3855.1 3872.5 3885.4 3891.0 3931.1 3821.3 3835.4 3837.2 3840.8 3845.7 3614.0 3710.9 3828.3 3838.3 3847.2 3421.7 3422.1 3429.4 3434.0 3447.6 4749.6 4778.2 4790.5 4806.6 4816.6 4191.8 4355.8 4393.5 4462.2 4468.5 5065.4 5077.8 5080.6 5091.3 5104.3 3716.1 3727.5 3746.7 3748.7 3762.3 5027.8 5293.2 5417.2 5436.6 5441.6 3647.2 3649.9 3660.5 3668.7 3673.5 3731.2 3732.2 3735.2 3743.0 3756.2 4308.8 4325.6 4325.8 4328.7 4336.8 5053.5 5100.9 5102.5 5106.9 5111.7 1336.3 1342.0 1344.9 1349.8 1364.8 818.4 856.3 876.7 881.7 894.7 4404.3 4494.5 4496.0 4511.7 4525.7 5233.6 5242.2 5244.8 5251.4 5271.7 4509.6 4516.1 4531.9 4546.4 4555.3 2663.6 2825.2 2828.9 2831.7 2836.4 5013.5 5015.8 5015.9 5019.3 5039.9 5309.4 5444.5 5447.6 5464.2 5477.3 4874.8 4883.0 4947.0 4955.4 4962.5 5229.3 5239.9 5252.3 5258.6 5263.8 4963.9 5160.7 5165.7 5169.7 5184.0 4951.4 4953.3 4956.2 4961.6 4971.5 3381.0 3389.3 3397.5 3417.4 3433.0 4594.6 4745.7 4769.7 4772.0 4791.4 4564.6 4570.0 4583.3 4589.2 4619.4 4534.8 4545.5 4572.6 4578.8 4587.7 4338.0 4482.6 4501.8 4512.8 4547.0 4596.8 4623.9 4839.0 4963.3 5145.3 4984.1 5003.1 5012.4 5025.5 5030.7 02:37:44 INFO - PROCESS | 2274 | 02:37:44 INFO - PROCESS | 2274 | [#5] yui.html Cycles:180 Average:15651.05 Median:523.12 stddev:21441.32 (4098.7%) stddev-sans-first:21471.56 02:37:44 INFO - PROCESS | 2274 | Values: 570.2 640.3 654.8 670.0 673.2 12096.5 13128.5 13139.1 13147.5 13910.7 12650.6 13747.7 13814.0 13852.9 13965.4 759.9 786.9 788.0 788.3 788.6 621.9 638.8 741.4 764.9 781.5 805.8 806.9 807.7 807.9 808.1 799.6 800.7 800.8 801.0 801.2 478.7 568.6 585.0 585.7 587.7 12467.6 12628.7 12647.5 12674.6 12705.6 11303.3 11435.0 11540.1 11671.4 12072.5 11894.3 11935.7 11961.0 11970.2 12017.7 4173.8 4233.3 4243.3 4266.3 4268.1 64655.4 65356.8 65450.3 65942.3 66480.7 9399.1 9714.6 9749.2 10052.5 10515.6 19289.0 19334.2 19341.8 19373.0 19437.8 6641.9 6668.4 6773.1 6934.7 6968.1 3619.7 3639.3 3640.4 3658.9 3686.7 2748.6 2860.5 2865.7 2865.8 2868.1 492.8 503.2 503.6 510.0 510.3 477.4 517.3 519.7 539.2 540.8 6846.8 6994.3 7027.5 7131.1 7250.3 458.2 491.6 516.4 522.0 524.3 3402.2 3460.9 3484.4 3505.5 3585.7 49555.3 49863.0 49900.5 50448.7 55844.7 79950.0 80364.6 81107.0 82925.0 84745.0 44699.6 47727.3 65306.7 66298.0 73892.6 7266.3 7370.0 7546.4 8002.0 8151.8 32254.7 33462.2 42752.1 45077.5 45311.0 64242.0 64995.7 65006.0 65557.0 65881.7 9709.1 9915.9 9957.3 9983.5 10567.4 10513.6 10644.5 10893.7 11102.7 11119.3 9209.0 9699.9 10255.3 10333.0 10962.2 8685.4 8721.0 9115.0 10281.0 10468.6 9861.6 10143.7 10152.0 10860.3 10862.1 7697.5 7903.3 7946.0 8002.6 8066.4 7755.3 7938.9 8111.5 8152.5 8169.2 02:37:44 INFO - PROCESS | 2274 | -------- Summary: end -------- 02:37:44 INFO - PROCESS | 2274 | 02:37:45 INFO - TEST-INFO | 2274: exit 0 02:37:45 INFO - TEST-OK | dromaeo_css | took 1121126ms 02:37:45 INFO - TEST-START | kraken 02:37:45 INFO - operating with platform_type : linux_ 02:37:45 INFO - Initialising browser for kraken test... 02:37:45 INFO - TEST-INFO | started process 2548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphz46im/profile http://localhost:34975/getInfo.html) 02:37:49 INFO - PROCESS | 2548 | JavaScript error: , line 0: uncaught exception: undefined 02:37:50 INFO - PROCESS | 2548 | __metrics Screen width/height:1600/1200 02:37:50 INFO - PROCESS | 2548 | colorDepth:24 02:37:50 INFO - PROCESS | 2548 | Browser inner width/height: 1024/697 02:37:50 INFO - PROCESS | 2548 | __metrics 02:37:51 INFO - PROCESS | 2548 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:37:51 INFO - PROCESS | 2548 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:37:52 INFO - TEST-INFO | 2548: exit 0 02:37:52 INFO - Browser initialized. 02:37:52 INFO - Running cycle 1/1 for kraken test... 02:37:52 INFO - TEST-INFO | started process 2629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphz46im/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:04 INFO - PROCESS | 2629 | RSS: Main: 159272960 02:38:04 INFO - PROCESS | 2629 | 02:38:06 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34975/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:07 INFO - PROCESS | 2629 | RSS: Main: 215891968 02:38:07 INFO - PROCESS | 2629 | 02:38:10 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34975/tests/kraken/driver.html?testName=audio-dft) 02:38:11 INFO - PROCESS | 2629 | RSS: Main: 189423616 02:38:11 INFO - PROCESS | 2629 | 02:38:14 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34975/tests/kraken/driver.html?testName=audio-fft) 02:38:15 INFO - PROCESS | 2629 | RSS: Main: 273592320 02:38:15 INFO - PROCESS | 2629 | 02:38:17 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34975/tests/kraken/driver.html?testName=audio-oscillator) 02:38:17 INFO - PROCESS | 2629 | RSS: Main: 182382592 02:38:17 INFO - PROCESS | 2629 | 02:38:20 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:38:20 INFO - PROCESS | 2629 | RSS: Main: 186691584 02:38:20 INFO - PROCESS | 2629 | 02:38:23 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34975/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:24 INFO - PROCESS | 2629 | RSS: Main: 223162368 02:38:24 INFO - PROCESS | 2629 | 02:38:27 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34975/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:28 INFO - PROCESS | 2629 | RSS: Main: 221937664 02:38:28 INFO - PROCESS | 2629 | 02:38:31 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34975/tests/kraken/driver.html?testName=json-parse-financial) 02:38:32 INFO - PROCESS | 2629 | RSS: Main: 222113792 02:38:32 INFO - PROCESS | 2629 | 02:38:33 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:38:34 INFO - PROCESS | 2629 | RSS: Main: 186667008 02:38:34 INFO - PROCESS | 2629 | 02:38:36 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:38:36 INFO - PROCESS | 2629 | RSS: Main: 190976000 02:38:36 INFO - PROCESS | 2629 | 02:38:38 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:38:39 INFO - PROCESS | 2629 | RSS: Main: 197017600 02:38:39 INFO - PROCESS | 2629 | 02:38:42 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:43 INFO - PROCESS | 2629 | RSS: Main: 191053824 02:38:43 INFO - PROCESS | 2629 | 02:38:45 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:46 INFO - PROCESS | 2629 | RSS: Main: 194293760 02:38:46 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | Cycle 1(1): loaded http://localhost:34975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34975/tests/kraken/driver.html?testName=ai-astar) 02:38:48 INFO - PROCESS | 2629 | RSS: Main: 245309440 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | __start_tp_report 02:38:48 INFO - PROCESS | 2629 | _x_x_mozilla_page_load 02:38:48 INFO - PROCESS | 2629 | _x_x_mozilla_page_load_details 02:38:48 INFO - PROCESS | 2629 | |i|pagename|runs| 02:38:48 INFO - PROCESS | 2629 | |0;ai-astar;104;114;113;115;113;114;113;115;114;116 02:38:48 INFO - PROCESS | 2629 | |1;audio-beat-detection;141;122;127;190;122;124;142;121;159;126 02:38:48 INFO - PROCESS | 2629 | |2;audio-dft;161;160;160;160;160;162;161;160;163;161 02:38:48 INFO - PROCESS | 2629 | |3;audio-fft;75;75;77;128;75;76;75;75;102;76 02:38:48 INFO - PROCESS | 2629 | |4;audio-oscillator;85;87;118;85;84;85;122;85;85;130 02:38:48 INFO - PROCESS | 2629 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 02:38:48 INFO - PROCESS | 2629 | |6;imaging-darkroom;147;147;147;146;146;146;147;146;146;146 02:38:48 INFO - PROCESS | 2629 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 02:38:48 INFO - PROCESS | 2629 | |8;json-parse-financial;60;61;61;60;62;62;62;60;60;60 02:38:48 INFO - PROCESS | 2629 | |9;json-stringify-tinderbox;65;66;65;65;66;65;66;66;66;66 02:38:48 INFO - PROCESS | 2629 | |10;stanford-crypto-aes;79;88;79;78;88;79;78;81;77;82 02:38:48 INFO - PROCESS | 2629 | |11;stanford-crypto-ccm;133;137;138;144;125;147;128;136;204;134 02:38:48 INFO - PROCESS | 2629 | |12;stanford-crypto-pbkdf2;162;163;170;165;160;164;162;166;165;160 02:38:48 INFO - PROCESS | 2629 | |13;stanford-crypto-sha256-iterative;66;67;65;65;68;66;65;68;65;67 02:38:48 INFO - PROCESS | 2629 | __end_tp_report 02:38:48 INFO - PROCESS | 2629 | __start_cc_report 02:38:48 INFO - PROCESS | 2629 | _x_x_mozilla_cycle_collect,1931 02:38:48 INFO - PROCESS | 2629 | __end_cc_report 02:38:48 INFO - PROCESS | 2629 | __startTimestamp1469525928559__endTimestamp 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | ------- Summary: start ------- 02:38:48 INFO - PROCESS | 2629 | Number of tests: 14 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.35 (2.9%) stddev-sans-first:1.05 02:38:48 INFO - PROCESS | 2629 | Values: 104.0 114.0 113.0 115.0 113.0 114.0 113.0 115.0 114.0 116.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:134.00 stddev:22.18 (16.6%) stddev-sans-first:23.49 02:38:48 INFO - PROCESS | 2629 | Values: 141.0 122.0 127.0 190.0 122.0 124.0 142.0 121.0 159.0 126.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 02:38:48 INFO - PROCESS | 2629 | Values: 161.0 160.0 160.0 160.0 160.0 162.0 161.0 160.0 163.0 161.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:17.76 (23.7%) stddev-sans-first:18.57 02:38:48 INFO - PROCESS | 2629 | Values: 75.0 75.0 77.0 128.0 75.0 76.0 75.0 75.0 102.0 76.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.00 stddev:18.69 (22.0%) stddev-sans-first:19.34 02:38:48 INFO - PROCESS | 2629 | Values: 85.0 87.0 118.0 85.0 84.0 85.0 122.0 85.0 85.0 130.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:38:48 INFO - PROCESS | 2629 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:38:48 INFO - PROCESS | 2629 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:38:48 INFO - PROCESS | 2629 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 02:38:48 INFO - PROCESS | 2629 | Values: 60.0 61.0 61.0 60.0 62.0 62.0 62.0 60.0 60.0 60.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 02:38:48 INFO - PROCESS | 2629 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:4.01 (5.0%) stddev-sans-first:4.20 02:38:48 INFO - PROCESS | 2629 | Values: 79.0 88.0 79.0 78.0 88.0 79.0 78.0 81.0 77.0 82.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:137.50 stddev:22.55 (16.4%) stddev-sans-first:23.65 02:38:48 INFO - PROCESS | 2629 | Values: 133.0 137.0 138.0 144.0 125.0 147.0 128.0 136.0 204.0 134.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.50 stddev:3.02 (1.8%) stddev-sans-first:3.14 02:38:48 INFO - PROCESS | 2629 | Values: 162.0 163.0 170.0 165.0 160.0 164.0 162.0 166.0 165.0 160.0 02:38:48 INFO - PROCESS | 2629 | 02:38:48 INFO - PROCESS | 2629 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.23 (1.8%) stddev-sans-first:1.30 02:38:48 INFO - PROCESS | 2629 | Values: 66.0 67.0 65.0 65.0 68.0 66.0 65.0 68.0 65.0 67.0 02:38:48 INFO - PROCESS | 2629 | -------- Summary: end -------- 02:38:48 INFO - PROCESS | 2629 | 02:38:49 INFO - TEST-INFO | 2629: exit 0 02:38:49 INFO - TEST-OK | kraken | took 64446ms 02:38:49 INFO - SUITE-END | took 1185s 02:38:49 INFO - Completed test suite (00:19:45) 02:38:49 INFO - javascript benchmark 02:38:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2633.1442281258596, 2633.8946442142314, 2647.073524266506, 2671.171936699623, 2682.7853771698265, 4641.327007583898, 4726.503717109706, 4728.692634978728, 4841.055994081155, 4846.563809257171, 4740.905181896369, 4786.3059856320815, 4790.640701947351, 4821.397325334333, 4856.10162120008, 4359.607635312821, 4368.694191406603, 4444.155610434023, 4498.955010449903, 4553.863384098466, 4456.79944402501, 4506.481754598214, 4524.253498172798, 4528.660350473728, 4544.704594201383, 4291.506476755182, 4321.783910804479, 4332.740035597874, 4388.451443569554, 4451.599356057938, 4364.934525982113, 4398.560143985608, 4415.425994620711, 4453.1316393303, 4481.619062379702, 4326.134773045404, 4348.152110338485, 4366.323219900921, 4392.0, 4394.121175764828, 4736.999999999965, 4776.020915712271, 4821.397325334333, 4830.0339932013385, 4838.564529192389, 4987.47631498691, 5059.342285502861, 5063.620228482879, 5106.693598384109, 5158.40678321994, 5056.823011194628, 5174.016936781999, 5178.14560597501, 5181.35233095863, 5188.429272779991, 4650.558196971282, 4816.56650901417, 4824.228123500223, 4830.033993201374, 4844.515548445127, 5229.346331708536, 5256.474352564789, 5258.579313654898, 5303.973480132652, 5315.548178404879, 5043.52086551777, 5048.444671086178, 5054.342935418372, 5101.311322971425, 5107.233914912793, 5029.64792464524, 5125.231215317732, 5182.0, 5185.792568297301, 5187.610929180327, 4975.0, 4995.550400463976, 5002.324686167393, 5072.82245121419, 5081.339425874613, 4985.252212168204, 4991.176455884738, 4994.925076123861, 4999.3000979862845, 5057.140286151363, 4318.870433886988, 4326.394304797331, 4332.393464914914, 4337.306031035019, 4377.3871657967275, 3771.453139294787, 3773.4528493368307, 3782.791946442972, 3788.1287303919703, 3828.310904037244, 4427.29163333865, 4431.158079964861, 4460.888477788081, 4474.26174681174, 4480.462344518679, 5143.897122057538, 5175.922361164586, 5181.4300426953005, 5186.870328241824, 5232.581393488512, 4278.764667943293, 4346.6522678185665, 4375.934360984587, 4412.24991751403, 4468.396766436555, 4578.1301552705545, 4614.238650622609, 4619.2609182531305, 4638.536146385334, 4652.813887444532, 4803.495632958489, 4805.687630304019, 4811.350467686818, 4814.061258054646, 4857.149998750205, 5064.265681476091, 5074.06129865976, 5112.309838171799, 5127.923081153711, 5180.378354597472, 4774.188387974123, 4821.252705830602, 4822.083804077214, 4851.684640498356, 4858.514148585114, 5028.34631497903, 5031.760118863534, 5037.0, 5044.394672639307, 5078.898422031612, 5013.749312534432, 5045.646804723634, 5110.8466745997675, 5122.692638441706, 5175.534201921845, 4939.086269040239, 4969.453360130455, 4982.925256121233, 5023.09584274834, 5024.547790698854, 5002.799888004439, 5016.523430274118, 5019.372578427697, 5019.372578427697, 5072.82245121419, 4791.4729379767505, 4824.662273640952, 4942.036302920896, 4948.109340318777, 4989.650724449254, 4958.801647934042, 5003.724795136302, 5007.39911210657, 5042.873928151826, 5085.364329458817, 4917.975410122926, 4935.481774413634, 4942.159832828356, 4944.233643785219, 4985.551300382983], "value": 4700.968742315351, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.8255931940757, 578.3753546170136, 578.467809615154, 581.3285655068395, 582.8222392170389, 27709.168724938234, 39912.0, 41081.79459102708, 41153.99999999993, 44456.88745794226, 41360.58639413605, 41689.791551042275, 41731.0, 41733.16533669325, 41751.37372939409, 7612.885806712918, 7756.340711039568, 7756.379489640815, 7761.3402860756905, 7764.689412423496, 7359.116905971264, 9847.359921605073, 10080.697579072603, 10102.444365559892, 10436.895631043706, 10232.07911287984, 10233.0, 10236.897631023707, 10249.948750256275, 10309.948450257776, 9889.802203955916, 9937.254705897087, 9972.301938864282, 9973.900260997443, 9978.251631127621, 9898.109170174646, 9956.95021524895, 9972.451515166664, 9979.451130187837, 9981.600735970553, 38633.42049869254, 38943.61056389457, 38976.80511597452, 39009.0, 39039.21921561581, 2940.6324209473814, 2974.3456439583256, 3007.639083309995, 3115.875364985398, 3123.6563977962405, 29159.271018224503, 29588.112356629335, 29609.40781184364, 29962.85018574915, 30453.39093218123, 3332.266901281714, 3363.865445382182, 3386.6782655647676, 3417.7650087386255, 3447.931041379158, 188745.0, 189535.0, 191286.0, 192134.0, 192205.0, 31916.680833191836, 33076.17309567232, 33087.66912330846, 54026.45973540293, 54520.0, 33168.33663326768, 33256.833715831264, 33274.3345133096, 33333.166670832936, 33336.33327333488, 13616.727665446833, 13722.0, 13729.244891531062, 13732.931335343259, 13733.244671543162, 10138.543765530569, 11345.489452974636, 11391.088712902947, 11451.312921224753, 11451.88548114525, 7760.534367937942, 7916.960415197887, 7943.761687149395, 7956.761297160979, 7957.562334071682, 2986.148947549938, 3077.3076057886797, 3078.98460507696, 3086.382723455318, 3107.3319236363836, 856.8329175810782, 899.2150581096519, 903.4488961733338, 943.8820147481565, 1007.1640538353296, 26376.20871373862, 26615.467690646077, 26835.194944151706, 27904.581431278548, 27929.301767455978, 920.0, 951.1154626197703, 956.660385563129, 968.8692026576463, 1007.9042490963346, 14276.286185690675, 14587.562373128823, 14684.926575367055, 14737.410503579737, 14824.481143159937, 426541.0, 433361.0, 435192.0, 435396.0, 435812.0, 49130.26304605434, 49662.25506617404, 49746.75126624344, 49753.751231244336, 49768.50231497639, 1082.2965072702648, 1161.8780028097096, 1172.7771723372532, 1185.6917201527492, 1208.697825543614, 27354.179374618794, 27881.581776272968, 28333.716662833933, 28753.568696469152, 28814.0, 42092.0, 42440.787796060824, 42454.0, 42528.14943701171, 42568.0, 325282.97736180574, 326297.0, 326436.0, 327681.0, 327716.0, 24797.752022480265, 25514.362140946625, 25917.6112358311, 25937.351566210997, 26974.1907742768, 40510.797446012584, 40584.0, 41181.382279266436, 41762.0, 41921.79039104785, 35085.122871928404, 35349.0, 35359.0, 35859.282814344086, 35989.82005089958, 35340.29319413649, 35616.643833561335, 35716.64283357237, 35825.283494329444, 35971.64028359787, 34508.48237276493, 37615.86225515136, 37960.0, 38835.41746873856, 40906.0, 36266.27467450689, 37693.81153094217, 37699.24601508009, 37907.24185516219, 38181.0, 29723.108306750833, 30006.0, 30312.393752125274, 30900.22749431282, 30966.0], "value": 16912.778396149242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.1622872648191, 367.0, 372.11251165969156, 375.86468871206375, 391.6807801641662, 12807.935960320197, 15972.84027159728, 16479.670406591875, 17641.294348226056, 17782.46652600421, 16868.0, 16972.83027169728, 17032.06323652202, 17056.403025894095, 17228.483145505623, 4998.750062496879, 5063.417706963691, 5136.64043516954, 5161.509656582619, 5163.225516172585, 3685.281370132812, 5101.183810590306, 5181.404138524081, 5781.913271300934, 6083.543734219929, 6077.361877002917, 6110.663913484756, 6121.785737499188, 6126.448619624255, 6128.662923539204, 5926.466618004379, 6023.096535519685, 6163.506919446433, 6173.1048997895505, 6173.81478555644, 5182.818601348972, 5435.782568697247, 5437.945620543784, 5441.483059109379, 5444.891102177934, 20601.79398206014, 20883.164673413045, 20947.8952605236, 20984.0, 20992.790072099237, 1907.5803323268997, 1908.9045547722696, 2354.9175778847657, 2444.963325550118, 2463.913763018286, 12533.0, 12969.157004794659, 13168.209907405586, 13195.802062969064, 13777.0, 1694.1613901118901, 1766.2669991953323, 1776.8312010358995, 1806.5122416947481, 1809.80092189859, 65815.67092164556, 65898.0, 66871.66564167196, 67611.32388676099, 68362.65818670925, 9531.094546018117, 9568.138867501959, 9721.222302215805, 9805.509724513888, 9928.553215105338, 13490.0, 13490.662733431547, 13491.123076999964, 13497.122687025312, 13527.32363381827, 7279.963600181965, 7466.402687784964, 7469.701211951461, 7617.124030736425, 7631.3513351364645, 7233.168185658611, 7269.927300726925, 7415.703371865173, 7509.286617771303, 7522.962385188149, 5968.253968253968, 6101.572889897665, 6148.0, 6178.41305076017, 6344.841378965562, 1709.1881356355632, 1730.2041061111777, 1766.2934826069675, 1791.8387345139, 1812.4743824290808, 670.909427227318, 819.4919150126959, 825.7481468152151, 880.4849163239448, 904.4799240436776, 16542.83457165437, 16782.244798984077, 17147.399841005506, 17392.65214695699, 17804.732929005815, 843.5529169540154, 855.6320782063648, 906.6282824042111, 944.8015916657579, 971.3491960386558, 9615.90384096164, 10071.798564028679, 10115.898841011644, 10164.644237451654, 10268.127209187303, 355257.0, 414874.0, 415664.0, 417976.0, 423262.0, 85592.57203713941, 86291.56854215689, 86799.0, 88097.0, 89195.0, 889.5996801439378, 899.8020435504178, 936.1387523478417, 941.1811723800338, 944.1691311645845, 14787.630309241924, 15882.920585397462, 16109.838901610834, 16169.110698911672, 16902.0, 38880.80559597184, 39900.60099398969, 40201.0, 41161.0, 42830.571694282655, 53148.2027769576, 53644.46355536551, 54043.0, 54198.72900635472, 54471.455285448224, 6471.902921456276, 7204.4956853019785, 7353.191148973716, 7419.258074192538, 7616.543007419573, 7858.332041776513, 9059.547022648972, 9953.950230249093, 11555.364454955059, 12272.0, 9204.815903681754, 9471.526423678652, 9706.369086009387, 9878.901210987799, 10306.587736490756, 10112.191024718151, 10141.239407044353, 10561.894381056398, 10670.946645266724, 10782.353058816496, 9523.190528804853, 10142.949285253822, 10346.948265258625, 10366.0, 10372.429516376369, 7324.560526368435, 7425.740099096506, 7555.848883022419, 7676.769696909102, 7730.072391313079, 9499.572519236513, 9815.803683926424, 10082.0, 10316.43259620728, 10496.21278404138], "value": 8471.50107216453, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.5816296947946, 1422.4594654031466, 1440.582231152965, 1634.3707672546066, 1662.8420300071489, 7900.130985591588, 8184.468009579381, 8245.83508329833, 8249.133840946704, 8258.174182581739, 6690.63201523916, 7363.5581865088, 7544.849103017937, 7561.962190189041, 8103.837923241546, 2233.05095334483, 2256.6615007748806, 2258.435391152212, 2258.954820903581, 2264.1056782570877, 2164.751053628837, 2210.2264207527396, 2214.7785221477884, 2215.7230346206725, 2217.1020736601704, 1881.9153138108818, 1945.1830231302886, 1951.6877299632063, 1957.109515170601, 2099.0, 2187.1688758271835, 2218.622834118196, 2228.9665655015187, 2229.598672238996, 2231.2190733243397, 2232.5088480534255, 2241.8991145398495, 2249.8650080995194, 2251.8311126665567, 2287.633978563422, 8050.194980501961, 8134.227248411392, 8137.186281371874, 8181.590920453954, 8187.0994190638985, 4573.565511276423, 4710.623150148014, 4713.387259656257, 4716.056788642285, 4716.976415117937, 2786.21985843964, 2904.0997290839696, 2938.9706102938912, 2952.1438782752975, 2953.586497890297, 867.7223288547667, 905.2305540290766, 912.8037471943564, 913.7258822353267, 920.456930411054, 10893.07408870247, 10929.945350273198, 10940.781184376268, 10947.34315941046, 10959.671209863716, 3977.482927219443, 4370.934435983463, 4410.977945110254, 4516.36770852081, 4531.207038768268, 9404.764880878032, 9439.433633981984, 9446.244300455946, 9450.621975121056, 9454.90545094554, 4815.374001379868, 4819.518048195152, 4824.589909857631, 4832.565069143794, 4833.564979151894, 4271.914561708749, 4388.539203383599, 4403.097365040159, 4406.581374769392, 4407.294832826732, 3685.7788532688123, 3699.7780133191554, 3775.5091838060875, 3798.7340886137704, 3818.522684664417, 1191.1304747534175, 1202.1224506110589, 1203.536638394207, 1205.951761929513, 1217.379136640302, 681.7716065118142, 682.4403988729194, 744.3003576637943, 824.3322908444179, 824.7608193623902, 5294.629375943647, 5296.496832800878, 5366.7853285868905, 5402.837914862561, 5618.0449323615085, 404.82390160280374, 412.6492481390854, 413.8944569134912, 418.4894428796863, 426.6565414841021, 3613.94579081314, 3659.2315613720884, 3684.3920753075977, 3703.777773333609, 3738.794366309879, 9797.510124493747, 10096.69709908704, 10199.38803671782, 10211.0, 10230.335028223142, 10087.899121008842, 10178.847317290247, 10204.897951020543, 10208.030237127461, 10232.334898231591, 7540.0, 7582.507137036075, 7603.01160849086, 7621.123570789319, 7637.42719296055, 5288.68267903927, 5423.891522169455, 5451.236826844166, 5461.290032295776, 5734.569907257056, 8756.387052906235, 8897.599608017525, 9036.096390360912, 9042.412243204171, 9154.038825923182, 9064.229540489132, 9189.954050229706, 9292.39599426035, 9396.107369799858, 9474.57364418589, 6961.199462061928, 7144.071270734771, 7530.359919406693, 7701.922980770345, 7703.845923081619, 7322.121345438582, 7376.373008294355, 7382.815429614303, 7385.335319821242, 7389.371903388273, 5672.631278966854, 6639.900401493885, 6785.117934668461, 6798.184217893884, 6918.688659010256, 5879.794207202727, 6664.633445160563, 6788.389044985975, 6790.320967903368, 6797.286284940208, 5843.094320380348, 6006.909896351471, 6057.061155520902, 6377.362263773585, 6441.581297215666, 4519.435070616173, 4607.124646317189, 4622.2835460503675, 4708.952910470988, 4876.390451193601, 4397.516273209881, 4506.031203291308, 4666.0434610904, 4666.206744853451, 4705.270683044134], "value": 4116.355923926953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6066114051733, 304.812540287723, 313.0748637775373, 313.7960325788239, 313.8273949327869, 4808.663393562452, 4907.3129761833325, 4920.212765957447, 4925.926111108327, 4942.6540142190015, 4870.439899411569, 4872.220444728844, 4875.317455556216, 4885.511448855113, 4891.559759621633, 3621.841010876527, 3727.6458736419995, 3729.216864458467, 3800.752951058186, 3883.359245724452, 3855.1133239354967, 3872.5159355080614, 3885.358915778893, 3890.9805450972704, 3931.1351502669368, 3821.254855303217, 3835.408305553192, 3837.2325534892993, 3840.7695538267653, 3845.730798844082, 3613.963860361402, 3710.868185203525, 3828.349180639298, 3838.2707285615925, 3847.1728578355787, 3421.716856178933, 3422.058933793202, 3429.382711111999, 3434.0384692286198, 3447.5690538682666, 4749.572538471554, 4778.235482322812, 4790.5448982346625, 4806.567408933178, 4816.56650901417, 4191.811368488426, 4355.825766969318, 4393.53867843875, 4462.152191083684, 4468.486124095738, 5065.4174769901565, 5077.847664570032, 5080.568151707109, 5091.287219789232, 5104.310918026056, 3716.1267102230954, 3727.459518369821, 3746.7002639788752, 3748.6626203641804, 3762.285165818513, 5027.798888044474, 5293.179557168645, 5417.187421886709, 5436.619436639437, 5441.619086663935, 3647.1976165243605, 3649.85400583979, 3660.5424321959754, 3668.651478109629, 3673.485712000322, 3731.197792474631, 3732.2162345907122, 3735.159589092487, 3743.026813028632, 3756.2487502499607, 4308.849190278325, 4325.589069038437, 4325.826966921288, 4328.679752675402, 4336.76147811867, 5053.494650534917, 5100.923486147636, 5102.5278943495205, 5106.923396149061, 5111.702951596274, 1336.2650542201945, 1341.9798703019462, 1344.892408607309, 1349.8447678517095, 1364.7679894417774, 818.43119032272, 856.2978357746588, 876.6887754846938, 881.7487016200353, 894.7116152740034, 4404.295312749945, 4494.483134439516, 4495.955040449554, 4511.70673906195, 4525.683202175816, 5233.633645644768, 5242.213667949762, 5244.842654720364, 5251.396089449762, 5271.65734227274, 4509.6392288616835, 4516.141933032779, 4531.886702832456, 4546.363509108727, 4555.2711566149255, 2663.600459930987, 2825.2230636574695, 2828.9009884653938, 2831.66020077592, 2836.432713457317, 5013.473585273494, 5015.799368025311, 5015.949840501548, 5019.322391477177, 5039.899202015939, 5309.36287645485, 5444.50999410055, 5447.5641948644015, 5464.153056276284, 5477.315335583052, 4874.780634871439, 4883.0, 4946.950530494721, 4955.3805774278935, 4962.478939711278, 5229.267902493578, 5239.921401179062, 5252.343457067866, 5258.605604579749, 5263.815766448309, 4963.875903102306, 5160.690358578498, 5165.66423182492, 5169.715665638276, 5184.0, 4951.3810773653295, 4953.3065370848835, 4956.182229932021, 4961.6030717543235, 4971.477994810638, 3381.0, 3389.271306669078, 3397.4733916242035, 3417.401954657875, 3432.982835085809, 4594.609458196091, 4745.667803253739, 4769.66612337133, 4771.95228047715, 4791.377120974251, 4564.589186973189, 4569.954300456953, 4583.289590113538, 4589.196890544074, 4619.390044624776, 4534.795934182904, 4545.545445455428, 4572.611328037154, 4578.771061446848, 4587.6788624795945, 4338.02845051141, 4482.574155455227, 4501.752403617701, 4512.796924138487, 4547.0, 4596.770161491845, 4623.861643828687, 4839.0, 4963.255511673278, 5145.279660847409, 4984.081128765524, 5003.1238285642885, 5012.448630650552, 5025.522575355335, 5030.698158110525], "value": 3805.33485825681, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.2074116977402, 640.2828831708484, 654.7839213059691, 669.9598024118553, 673.2157037051834, 12096.516139354415, 13128.540501082463, 13139.080264381486, 13147.47410103596, 13910.721785564283, 12650.620481385573, 13747.725045499084, 13814.0, 13852.861471385308, 13965.44138234472, 759.8822182561698, 786.8622990976585, 788.0189164490217, 788.3023524181084, 788.5899332347204, 621.9129321894916, 638.8019713888687, 741.3809469093287, 764.9273319034683, 781.4568874632133, 805.814662627596, 806.8587997100514, 807.6527093349857, 807.8626633472294, 808.0747544062045, 799.6441583495347, 800.747764454195, 800.7998000499904, 801.0307527891258, 801.1747899663357, 478.6577597018149, 568.6275489554348, 585.0084107437895, 585.6690969602162, 587.6591576885396, 12467.563635272722, 12628.68428289291, 12647.49410023598, 12674.556390526379, 12705.555305564354, 11303.265287756269, 11435.0, 11540.134489913205, 11671.358075305854, 12072.517099316105, 11894.345810980392, 11935.701607459883, 11961.026430638934, 11970.162088653798, 12017.699557511132, 4173.812178451946, 4233.322668373045, 4243.257429949746, 4266.317389217741, 4268.103698223377, 64655.3534464654, 65356.82470553329, 65450.3454965449, 65942.3405765941, 66480.66759666218, 9399.060093990684, 9714.562844672007, 9749.171320437701, 10052.54763535628, 10515.579376824995, 19289.0, 19334.226630934605, 19341.80658193428, 19373.0, 19437.8056219436, 6641.933580664228, 6668.366505182, 6773.085633439423, 6934.653267336613, 6968.128983877015, 3619.7466177367332, 3639.29033838399, 3640.3993341098953, 3658.8902332930056, 3686.705063594906, 2748.628935093777, 2860.4565132624734, 2865.7134286571595, 2865.785066120049, 2868.096549586915, 492.83736366998806, 503.22252120473956, 503.61221859168234, 509.987250318745, 510.30853193922445, 477.40086191829727, 517.3352242368538, 519.7037688517509, 539.1885212754858, 540.835045311176, 6846.8378955734715, 6994.33553812387, 7027.472939529555, 7131.0729605151, 7250.274972502813, 458.21416271095234, 491.64847134299146, 516.40097486915, 521.9608529360237, 524.2764984321688, 3402.2004828865197, 3460.8788692395647, 3484.425069863444, 3505.5267538881926, 3585.713142948558, 49555.25667114996, 49863.0, 49900.50099498958, 50448.747756260986, 55844.72077639586, 79950.0, 80364.59817700874, 81107.0, 82925.0, 84745.0, 44699.55300447019, 47727.28409073866, 65306.67346663236, 66298.0, 73892.63053684698, 7266.309700578437, 7369.963150184215, 7546.3962882968135, 8002.0, 8151.79620509492, 32254.677453226104, 33462.16344591405, 42752.08351039546, 45077.54922450733, 45311.0, 64242.0, 64995.67502162459, 65006.0, 65557.0, 65881.67059164673, 9709.126178643955, 9915.900840991499, 9957.253206009433, 9983.450910200008, 10567.365958042543, 10513.579456821948, 10644.520996555328, 10893.727656808644, 11102.666919992413, 11119.27724697892, 9208.953955230449, 9699.854502182614, 10255.333403329058, 10333.0, 10962.232643714864, 8685.39202255836, 8720.956395217983, 9115.0, 10281.0, 10468.581256749645, 9861.556229969812, 10143.746406339606, 10152.0, 10860.348379097279, 10862.131029517777, 7697.499662522142, 7903.293866507669, 7945.960270198612, 8002.59987000636, 8066.435349525712, 7755.302022817974, 7938.880916786137, 8111.513309201467, 8152.510849349058, 8169.223923727474], "value": 6081.236147206496, "unit": "score"}], "name": "dromaeo_css", "value": 6327.295950389033, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 115.0, 113.0, 114.0, 113.0, 115.0, 114.0, 116.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 122.0, 127.0, 190.0, 122.0, 124.0, 142.0, 121.0, 159.0, 126.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 163.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 128.0, 75.0, 76.0, 75.0, 75.0, 102.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 118.0, 85.0, 84.0, 85.0, 122.0, 85.0, 85.0, 130.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 62.0, 62.0, 62.0, 60.0, 60.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 79.0, 78.0, 88.0, 79.0, 78.0, 81.0, 77.0, 82.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 138.0, 144.0, 125.0, 147.0, 128.0, 136.0, 204.0, 134.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 170.0, 165.0, 160.0, 164.0, 162.0, 166.0, 165.0, 160.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 68.0, 66.0, 65.0, 68.0, 65.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1529.5, "alertThreshold": 2.0}]} 02:38:49 INFO - Return code: 0 02:38:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:38:49 INFO - # TBPL SUCCESS # 02:38:49 INFO - Running post-action listener: _resource_record_post_action 02:38:49 INFO - [mozharness: 2016-07-26 09:38:49.868473Z] Finished run-tests step (success) 02:38:49 INFO - Running post-run listener: _resource_record_post_run 02:38:49 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 547844096; Read time: 544; Write time: 1539584 02:38:49 INFO - TinderboxPrint: CPU usage
13.1% 02:38:49 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 544 02:38:49 INFO - TinderboxPrint: I/O write bytes / time
547,844,096 / 1,539,584 02:38:49 INFO - TinderboxPrint: CPU idle
8,331.8 (86.8%) 02:38:49 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 02:38:49 INFO - TinderboxPrint: Swap in / out
0 / 0 02:38:49 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 258560000; Read time: 0; Write time: 821412 02:38:49 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289284096; Read time: 532; Write time: 718172 02:38:50 INFO - Running post-run listener: _upload_blobber_files 02:38:50 INFO - Blob upload gear active. 02:38:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38:50 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 02:38:50 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'] 02:38:50 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 02:38:50 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:51 INFO - (blobuploader) - INFO - Done attempting. 02:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:41 INFO - (blobuploader) - INFO - Done attempting. 02:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:43 INFO - (blobuploader) - INFO - Done attempting. 02:39:43 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:43 INFO - Return code: 0 02:39:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d9e781d7c3781ece9e3980858d9c3edfb02d1f1ba11f7e29a664ca43d3b8264dda1ed914abbcf5e1875fb3121047e656adb7dd1bbb2fa2bee1f126c5eb68410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f4a6c2aadd7ddb9977ed1da19f4525d2bef44ea60994acda9754d55cd9399c00b2514c2681e45e34655847fa3cabc421d1fbea5d8e7bd30a39b320d78d7d017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd28c6688cc36b40f9560c0a463a86a5eebf3c2ad61624620cfc443bd4e0608ba9644b6deb3a46bf567a9ec2977a6c0290270d2553412d0668b5884126c788d8"} 02:39:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:43 INFO - Contents: 02:39:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d9e781d7c3781ece9e3980858d9c3edfb02d1f1ba11f7e29a664ca43d3b8264dda1ed914abbcf5e1875fb3121047e656adb7dd1bbb2fa2bee1f126c5eb68410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f4a6c2aadd7ddb9977ed1da19f4525d2bef44ea60994acda9754d55cd9399c00b2514c2681e45e34655847fa3cabc421d1fbea5d8e7bd30a39b320d78d7d017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd28c6688cc36b40f9560c0a463a86a5eebf3c2ad61624620cfc443bd4e0608ba9644b6deb3a46bf567a9ec2977a6c0290270d2553412d0668b5884126c788d8"} 02:39:43 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:43 INFO - Copying logs to upload dir... 02:39:43 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.637486 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-07-26 02:39:42.962146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 02:39:42.965415) ========= 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=8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343 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/2d9e781d7c3781ece9e3980858d9c3edfb02d1f1ba11f7e29a664ca43d3b8264dda1ed914abbcf5e1875fb3121047e656adb7dd1bbb2fa2bee1f126c5eb68410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f4a6c2aadd7ddb9977ed1da19f4525d2bef44ea60994acda9754d55cd9399c00b2514c2681e45e34655847fa3cabc421d1fbea5d8e7bd30a39b320d78d7d017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd28c6688cc36b40f9560c0a463a86a5eebf3c2ad61624620cfc443bd4e0608ba9644b6deb3a46bf567a9ec2977a6c0290270d2553412d0668b5884126c788d8"} build_url:https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/Hd-KqKDPQeCOUjDoiZhdqA/artifacts/public/build/firefox-50.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/2d9e781d7c3781ece9e3980858d9c3edfb02d1f1ba11f7e29a664ca43d3b8264dda1ed914abbcf5e1875fb3121047e656adb7dd1bbb2fa2bee1f126c5eb68410", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f4a6c2aadd7ddb9977ed1da19f4525d2bef44ea60994acda9754d55cd9399c00b2514c2681e45e34655847fa3cabc421d1fbea5d8e7bd30a39b320d78d7d017", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd28c6688cc36b40f9560c0a463a86a5eebf3c2ad61624620cfc443bd4e0608ba9644b6deb3a46bf567a9ec2977a6c0290270d2553412d0668b5884126c788d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 02:39:42.990979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:39:42.991341) ========= 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=8783db0840cc980e80bb0bd400000236-1469524563.64949-1807116343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:39:43.073508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 02:39:43.073859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 02:39:43.074235) ========= ========= Total master_lag: 0.39 =========