builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0366 starttime: 1490908134.06 results: success (0) buildid: 20170330120906 builduid: da2f53d64c714e02b0aebb4f3c6c3057 revision: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.059687) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.060210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.060532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.087708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.088096) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XigHlFHJuk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-30 14:08:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 142M=0s 2017-03-30 14:08:54 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.288730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.289048) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XigHlFHJuk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.038756 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.349545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:54.349898) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XigHlFHJuk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-30 14:08:54,460 truncating revision to first 12 chars 2017-03-30 14:08:54,460 Setting DEBUG logging. 2017-03-30 14:08:54,461 attempt 1/10 2017-03-30 14:08:54,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0a36cc120d6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 14:08:55,148 unpacking tar archive at: mozilla-beta-0a36cc120d6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:55.338354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:55.338671) ========= script_repo_revision: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:55.339056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:55.339336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 14:08:55.358813) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-30 14:08:55.359143) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XigHlFHJuk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:08:55 INFO - MultiFileLogger online at 20170330 14:08:55 in /builds/slave/test 14:08:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:08:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:55 INFO - {'append_to_log': False, 14:08:55 INFO - 'base_work_dir': '/builds/slave/test', 14:08:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:08:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:55 INFO - 'branch': 'Mozilla-Beta', 14:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:55 INFO - 'config_files': ('talos/mac_config.py',), 14:08:55 INFO - 'default_actions': ('clobber', 14:08:55 INFO - 'read-buildbot-config', 14:08:55 INFO - 'download-and-extract', 14:08:55 INFO - 'populate-webroot', 14:08:55 INFO - 'create-virtualenv', 14:08:55 INFO - 'install', 14:08:55 INFO - 'run-tests'), 14:08:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:55 INFO - 'download_minidump_stackwalk': True, 14:08:55 INFO - 'download_symbols': 'ondemand', 14:08:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:55 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:55 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:55 INFO - 'installer_path': 'installer.exe', 14:08:55 INFO - 'log_level': 'info', 14:08:55 INFO - 'log_name': 'talos', 14:08:55 INFO - 'log_to_console': True, 14:08:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:08:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:08:55 INFO - 'opt_config_files': (), 14:08:55 INFO - 'pip_index': False, 14:08:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:55 INFO - 'cmd': ('bash', 14:08:55 INFO - '-c', 14:08:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:55 INFO - 'enabled': True, 14:08:55 INFO - 'halt_on_failure': False, 14:08:55 INFO - 'name': 'check_screen_resolution'},), 14:08:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:55 INFO - 'cmd': ('bash', 14:08:55 INFO - '-c', 14:08:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:55 INFO - 'enabled': True, 14:08:55 INFO - 'halt_on_failure': False, 14:08:55 INFO - 'name': 'check_screen_resolution'},), 14:08:55 INFO - 'run_cmd_checks_enabled': True, 14:08:55 INFO - 'sps_profile': False, 14:08:55 INFO - 'sps_profile_interval': 0, 14:08:55 INFO - 'suite': 'dromaeojs', 14:08:55 INFO - 'system_bits': '32', 14:08:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:55 INFO - 'title': 't-yosemite-r7-0366', 14:08:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:55 INFO - 'use_talos_json': True, 14:08:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:55 INFO - 'work_dir': 'build'} 14:08:55 INFO - [mozharness: 2017-03-30 21:08:55.574529Z] Running clobber step. 14:08:55 INFO - Running pre-action listener: _resource_record_pre_action 14:08:55 INFO - Running main action method: clobber 14:08:55 INFO - rmtree: /builds/slave/test/build 14:08:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:57 INFO - Running post-action listener: _resource_record_post_action 14:08:57 INFO - [mozharness: 2017-03-30 21:08:57.983952Z] Finished clobber step (success) 14:08:57 INFO - [mozharness: 2017-03-30 21:08:57.984081Z] Running read-buildbot-config step. 14:08:57 INFO - Running pre-action listener: _resource_record_pre_action 14:08:57 INFO - Running main action method: read_buildbot_config 14:08:57 INFO - Using buildbot properties: 14:08:57 INFO - { 14:08:57 INFO - "project": "", 14:08:57 INFO - "product": "firefox", 14:08:57 INFO - "script_repo_revision": "production", 14:08:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:08:57 INFO - "repository": "", 14:08:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:08:57 INFO - "buildid": "20170330120906", 14:08:57 INFO - "pgo_build": "False", 14:08:57 INFO - "basedir": "/builds/slave/test", 14:08:57 INFO - "buildnumber": 24, 14:08:57 INFO - "slavename": "t-yosemite-r7-0366", 14:08:57 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:08:57 INFO - "platform": "yosemite_r7", 14:08:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:08:57 INFO - "branch": "mozilla-beta", 14:08:57 INFO - "repo_path": "releases/mozilla-beta", 14:08:57 INFO - "revision": "0a36cc120d6e7b8bc19176f5efac6b00dd9ad072", 14:08:57 INFO - "stage_platform": "macosx64", 14:08:57 INFO - "builduid": "da2f53d64c714e02b0aebb4f3c6c3057", 14:08:57 INFO - "slavebuilddir": "test" 14:08:57 INFO - } 14:08:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 14:08:57 INFO - Running post-action listener: _resource_record_post_action 14:08:57 INFO - [mozharness: 2017-03-30 21:08:57.987273Z] Finished read-buildbot-config step (success) 14:08:57 INFO - [mozharness: 2017-03-30 21:08:57.987381Z] Running download-and-extract step. 14:08:57 INFO - Running pre-action listener: _resource_record_pre_action 14:08:57 INFO - Running main action method: download_and_extract 14:08:57 INFO - mkdir: /builds/slave/test/build/tests 14:08:57 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:57 INFO - trying https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 14:08:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 14:08:59 INFO - Downloaded 1165 bytes. 14:08:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:08:59 INFO - Using the following test package requirements: 14:08:59 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:08:59 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:08:59 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 14:08:59 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:08:59 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 14:08:59 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:08:59 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:08:59 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 14:08:59 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:08:59 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:08:59 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 14:08:59 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:08:59 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 14:08:59 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:08:59 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 14:08:59 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:08:59 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 14:08:59 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 14:08:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:08:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:08:59 INFO - Fetch https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:09:00 INFO - Expected file size: 16108833 14:09:00 INFO - Obtained file size: 16108833 14:09:06 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:09:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:09:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:09:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:09:07 INFO - Expected file size: 16108833 14:09:07 INFO - Obtained file size: 16108833 14:09:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 14:09:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 14:09:14 INFO - Fetch https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 14:09:15 INFO - Expected file size: 14403663 14:09:15 INFO - Obtained file size: 14403663 14:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:15 INFO - trying https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:09:15 INFO - Downloading https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 14:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 14:09:17 INFO - Downloaded 58692004 bytes. 14:09:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:09:17 INFO - mkdir: /builds/slave/test/properties 14:09:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:17 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:17 INFO - Contents: 14:09:17 INFO - build_url:https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:09:18 INFO - Running post-action listener: _resource_record_post_action 14:09:18 INFO - Running post-action listener: set_extra_try_arguments 14:09:18 INFO - [mozharness: 2017-03-30 21:09:18.082556Z] Finished download-and-extract step (success) 14:09:18 INFO - [mozharness: 2017-03-30 21:09:18.082664Z] Running populate-webroot step. 14:09:18 INFO - Running pre-action listener: _resource_record_pre_action 14:09:18 INFO - Running main action method: populate_webroot 14:09:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:18 INFO - '--tppagecycles', 14:09:18 INFO - '7'], 14:09:18 INFO - 'tests': ['tsvgm']}}, 14:09:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['damp', 'tps']}, 14:09:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:09:18 INFO - 'tests': ['damp', 'tps']}, 14:09:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['dromaeo_dom']}, 14:09:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['basic_compositor_video']}, 14:09:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:09:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['a11yr', 14:09:18 INFO - 'ts_paint', 14:09:18 INFO - 'tpaint', 14:09:18 INFO - 'sessionrestore', 14:09:18 INFO - 'sessionrestore_no_auto_restore', 14:09:18 INFO - 'tabpaint']}, 14:09:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tsvgx', 14:09:18 INFO - 'tsvgr_opacity', 14:09:18 INFO - 'tart', 14:09:18 INFO - 'tscrollx', 14:09:18 INFO - 'cart', 14:09:18 INFO - 'tsvg_static']}, 14:09:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:18 INFO - 'tsvgr_opacity', 14:09:18 INFO - 'tart', 14:09:18 INFO - 'tscrollx', 14:09:18 INFO - 'cart', 14:09:18 INFO - 'tsvg_static']}, 14:09:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s'], 14:09:18 INFO - 'tests': ['tp5o']}, 14:09:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:09:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:09:18 INFO - 'talos_options': ['--disable-e10s', 14:09:18 INFO - '--xperf_path', 14:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:18 INFO - 'tests': ['tp5n']}, 14:09:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:09:18 INFO - 'talos_options': ['--xperf_path', 14:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:18 INFO - 'tests': ['tp5n']}}, 14:09:18 INFO - 'talos.zip': {'path': '', 14:09:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:18 INFO - Running post-action listener: _resource_record_post_action 14:09:18 INFO - [mozharness: 2017-03-30 21:09:18.100723Z] Finished populate-webroot step (success) 14:09:18 INFO - [mozharness: 2017-03-30 21:09:18.100831Z] Running create-virtualenv step. 14:09:18 INFO - Running pre-action listener: _resource_record_pre_action 14:09:18 INFO - Running main action method: create_virtualenv 14:09:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:18 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 14:09:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:18 INFO - Using real prefix '/tools/python27' 14:09:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:18 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:21 INFO - Installing pip.................done. 14:09:21 INFO - Return code: 0 14:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:09:22 INFO - Reading from file tmpfile_stdout 14:09:22 INFO - Output received: 14:09:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:09:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:22 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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09:22 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 14:09:22 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 14:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:22 INFO - 'HOME': '/Users/cltbld', 14:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:22 INFO - 'LOGNAME': 'cltbld', 14:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:22 INFO - 'MOZ_NO_REMOTE': '1', 14:09:22 INFO - 'NO_EM_RESTART': '1', 14:09:22 INFO - 'PAGER': '/bin/cat', 14:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:22 INFO - 'PWD': '/builds/slave/test', 14:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:22 INFO - 'SHELL': '/bin/bash', 14:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:22 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:22 INFO - 'USER': 'cltbld', 14:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:22 INFO - 'XPC_FLAGS': '0x0', 14:09:22 INFO - 'XPC_SERVICE_NAME': '0', 14:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:22 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 14:09:22 INFO - Cleaning up... 14:09:22 INFO - Return code: 0 14:09:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:22 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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09:22 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 14:09:22 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 14:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:22 INFO - 'HOME': '/Users/cltbld', 14:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:22 INFO - 'LOGNAME': 'cltbld', 14:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:22 INFO - 'MOZ_NO_REMOTE': '1', 14:09:22 INFO - 'NO_EM_RESTART': '1', 14:09:22 INFO - 'PAGER': '/bin/cat', 14:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:22 INFO - 'PWD': '/builds/slave/test', 14:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:22 INFO - 'SHELL': '/bin/bash', 14:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:22 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:22 INFO - 'USER': 'cltbld', 14:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:22 INFO - 'XPC_FLAGS': '0x0', 14:09:22 INFO - 'XPC_SERVICE_NAME': '0', 14:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:22 INFO - Downloading/unpacking psutil>=3.1.1 14:09:22 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 14:09:22 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 14:09:22 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 14:09:22 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 14:09:22 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 14:09:22 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 14:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:26 INFO - Installing collected packages: psutil 14:09:26 INFO - Running setup.py install for psutil 14:09:26 INFO - building 'psutil._psutil_osx' extension 14:09:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:09:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:09:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:09:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:09:26 INFO - building 'psutil._psutil_posix' extension 14:09:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:09:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:09:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:09:27 INFO - ^ 14:09:27 INFO - 1 warning generated. 14:09:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:27 INFO - Successfully installed psutil 14:09:27 INFO - Cleaning up... 14:09:27 INFO - Return code: 0 14:09:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:09: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 mozsystemmonitor==0.3 14:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:27 INFO - 'HOME': '/Users/cltbld', 14:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:27 INFO - 'LOGNAME': 'cltbld', 14:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:27 INFO - 'MOZ_NO_REMOTE': '1', 14:09:27 INFO - 'NO_EM_RESTART': '1', 14:09:27 INFO - 'PAGER': '/bin/cat', 14:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:27 INFO - 'PWD': '/builds/slave/test', 14:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:27 INFO - 'SHELL': '/bin/bash', 14:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:27 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:27 INFO - 'USER': 'cltbld', 14:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:27 INFO - 'XPC_FLAGS': '0x0', 14:09:27 INFO - 'XPC_SERVICE_NAME': '0', 14:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:09:30 INFO - Installing collected packages: mozsystemmonitor 14:09:30 INFO - Running setup.py install for mozsystemmonitor 14:09:30 INFO - Successfully installed mozsystemmonitor 14:09:30 INFO - Cleaning up... 14:09:30 INFO - Return code: 0 14:09:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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', '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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:09: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 jsonschema==2.5.1 14:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:30 INFO - 'HOME': '/Users/cltbld', 14:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:30 INFO - 'LOGNAME': 'cltbld', 14:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:30 INFO - 'MOZ_NO_REMOTE': '1', 14:09:30 INFO - 'NO_EM_RESTART': '1', 14:09:30 INFO - 'PAGER': '/bin/cat', 14:09:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:30 INFO - 'PWD': '/builds/slave/test', 14:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:30 INFO - 'SHELL': '/bin/bash', 14:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:30 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:30 INFO - 'USER': 'cltbld', 14:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:30 INFO - 'XPC_FLAGS': '0x0', 14:09:30 INFO - 'XPC_SERVICE_NAME': '0', 14:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:30 INFO - Downloading/unpacking jsonschema==2.5.1 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:33 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:33 INFO - warning: no files found matching '*.txt' 14:09:33 INFO - no previously-included directories found matching 'build' 14:09:33 INFO - no previously-included directories found matching 'dist' 14:09:33 INFO - no previously-included directories found matching '.git*' 14:09:33 INFO - Installing collected packages: jsonschema, functools32 14:09:33 INFO - Running setup.py install for functools32 14:09:34 INFO - warning: no files found matching '*.txt' 14:09:34 INFO - no previously-included directories found matching 'build' 14:09:34 INFO - no previously-included directories found matching 'dist' 14:09:34 INFO - no previously-included directories found matching '.git*' 14:09:34 INFO - Successfully installed jsonschema functools32 14:09:34 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:09:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:34 INFO - 'HOME': '/Users/cltbld', 14:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PAGER': '/bin/cat', 14:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:34 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - 'XPC_FLAGS': '0x0', 14:09:34 INFO - 'XPC_SERVICE_NAME': '0', 14:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:09:34 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:34 INFO - 'HOME': '/Users/cltbld', 14:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PAGER': '/bin/cat', 14:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:34 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - 'XPC_FLAGS': '0x0', 14:09:34 INFO - 'XPC_SERVICE_NAME': '0', 14:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:34 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:37 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:38 INFO - Downloading docopt-0.6.1.tar.gz 14:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:38 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:38 INFO - Running setup.py install for blobuploader 14:09:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:38 INFO - Running setup.py install for requests 14:09:39 INFO - Running setup.py install for docopt 14:09:39 INFO - Successfully installed blobuploader requests docopt 14:09:39 INFO - Cleaning up... 14:09:39 INFO - Return code: 0 14:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09: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 14:09: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 14:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:39 INFO - 'HOME': '/Users/cltbld', 14:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:39 INFO - 'LOGNAME': 'cltbld', 14:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:39 INFO - 'MOZ_NO_REMOTE': '1', 14:09:39 INFO - 'NO_EM_RESTART': '1', 14:09:39 INFO - 'PAGER': '/bin/cat', 14:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:39 INFO - 'PWD': '/builds/slave/test', 14:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:39 INFO - 'SHELL': '/bin/bash', 14:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:39 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:39 INFO - 'USER': 'cltbld', 14:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:39 INFO - 'XPC_FLAGS': '0x0', 14:09:39 INFO - 'XPC_SERVICE_NAME': '0', 14:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:39 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-koQBvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:39 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-XYxW4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-K52Ygp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-k0HCJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-0cGYu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-PkLLiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-XJGnTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Nqs8ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-orXLci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-r91QoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-5aUH_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:40 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-dwaJ8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:41 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-B4GYWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:41 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-zubDi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:41 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-O0YBTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:41 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-TUrle7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:41 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Dt64Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:41 INFO - Running setup.py install for manifestparser 14:09:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:41 INFO - Running setup.py install for mozcrash 14:09:41 INFO - Running setup.py install for mozdebug 14:09:42 INFO - Running setup.py install for mozdevice 14:09:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozfile 14:09:42 INFO - Running setup.py install for mozhttpd 14:09:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozinfo 14:09:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozInstall 14:09:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:42 INFO - Running setup.py install for mozleak 14:09:42 INFO - Running setup.py install for mozlog 14:09:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Running setup.py install for moznetwork 14:09:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Running setup.py install for mozprocess 14:09:43 INFO - Running setup.py install for mozprofile 14:09:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Running setup.py install for mozrunner 14:09:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:43 INFO - Running setup.py install for mozscreenshot 14:09:43 INFO - Running setup.py install for moztest 14:09:44 INFO - Running setup.py install for mozversion 14:09:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:44 INFO - Cleaning up... 14:09:44 INFO - Return code: 0 14:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:44 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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09:44 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 14:09:44 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 14:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:44 INFO - 'HOME': '/Users/cltbld', 14:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:44 INFO - 'LOGNAME': 'cltbld', 14:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:44 INFO - 'MOZ_NO_REMOTE': '1', 14:09:44 INFO - 'NO_EM_RESTART': '1', 14:09:44 INFO - 'PAGER': '/bin/cat', 14:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:44 INFO - 'PWD': '/builds/slave/test', 14:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:44 INFO - 'SHELL': '/bin/bash', 14:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:44 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:44 INFO - 'USER': 'cltbld', 14:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:44 INFO - 'XPC_FLAGS': '0x0', 14:09:44 INFO - 'XPC_SERVICE_NAME': '0', 14:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-sbXFYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-YbZ614-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-rapomh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-gwWj5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-IGj59D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:44 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)) 14:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:44 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-SGTcjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:45 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Oxu2lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:45 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-T_yya6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:45 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-p9yQ4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:45 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-qdu2iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-17lbGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:45 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Dky23I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-IAfS_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:45 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-umsbSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:45 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-X_CFaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:46 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)) 14:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:46 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-W0nApm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:46 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-0ANFsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:46 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)) 14:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:46 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)) 14:09:46 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:46 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 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 14:09:46 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 14:09:48 INFO - Downloading blessings-1.6.tar.gz 14:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:48 INFO - Installing collected packages: blessings 14:09:48 INFO - Running setup.py install for blessings 14:09:49 INFO - Successfully installed blessings 14:09:49 INFO - Cleaning up... 14:09:49 INFO - Return code: 0 14:09:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:49 INFO - Reading from file tmpfile_stdout 14:09:49 INFO - Current package versions: 14:09:49 INFO - blessings == 1.6 14:09:49 INFO - blobuploader == 1.2.4 14:09:49 INFO - docopt == 0.6.1 14:09:49 INFO - functools32 == 3.2.3-2 14:09:49 INFO - jsonschema == 2.5.1 14:09:49 INFO - manifestparser == 1.1 14:09:49 INFO - mozInstall == 1.12 14:09:49 INFO - mozcrash == 1.0 14:09:49 INFO - mozdebug == 0.1 14:09:49 INFO - mozdevice == 0.49 14:09:49 INFO - mozfile == 1.2 14:09:49 INFO - mozhttpd == 0.7 14:09:49 INFO - mozinfo == 0.9 14:09:49 INFO - mozleak == 0.1 14:09:49 INFO - mozlog == 3.4 14:09:49 INFO - moznetwork == 0.27 14:09:49 INFO - mozprocess == 0.24 14:09:49 INFO - mozprofile == 0.28 14:09:49 INFO - mozrunner == 6.13 14:09:49 INFO - mozscreenshot == 0.1 14:09:49 INFO - mozsystemmonitor == 0.3 14:09:49 INFO - moztest == 0.8 14:09:49 INFO - mozversion == 1.4 14:09:49 INFO - psutil == 3.1.1 14:09:49 INFO - requests == 1.2.3 14:09:49 INFO - wsgiref == 0.1.2 14:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09:50 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 14:09:50 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 14:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:50 INFO - 'HOME': '/Users/cltbld', 14:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:50 INFO - 'LOGNAME': 'cltbld', 14:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:50 INFO - 'MOZ_NO_REMOTE': '1', 14:09:50 INFO - 'NO_EM_RESTART': '1', 14:09:50 INFO - 'PAGER': '/bin/cat', 14:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:50 INFO - 'PWD': '/builds/slave/test', 14:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:50 INFO - 'SHELL': '/bin/bash', 14:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:50 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:50 INFO - 'USER': 'cltbld', 14:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:50 INFO - 'XPC_FLAGS': '0x0', 14:09:50 INFO - 'XPC_SERVICE_NAME': '0', 14:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 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)) 14:09:50 INFO - Cleaning up... 14:09:50 INFO - Return code: 0 14:09:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:51 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 0x106122b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106125768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2024a7210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:09:51 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 14:09:51 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 14:09:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:09:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:51 INFO - 'HOME': '/Users/cltbld', 14:09:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:51 INFO - 'LOGNAME': 'cltbld', 14:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:51 INFO - 'MOZ_NO_REMOTE': '1', 14:09:51 INFO - 'NO_EM_RESTART': '1', 14:09:51 INFO - 'PAGER': '/bin/cat', 14:09:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:51 INFO - 'PWD': '/builds/slave/test', 14:09:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:51 INFO - 'SHELL': '/bin/bash', 14:09:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:09:51 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:09:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:51 INFO - 'USER': 'cltbld', 14:09:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:51 INFO - 'XPC_FLAGS': '0x0', 14:09:51 INFO - 'XPC_SERVICE_NAME': '0', 14:09:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:51 INFO - Cleaning up... 14:09:51 INFO - Return code: 0 14:09:51 INFO - Running post-action listener: _resource_record_post_action 14:09:51 INFO - Running post-action listener: _start_resource_monitoring 14:09:51 INFO - Starting resource monitoring. 14:09:51 INFO - [mozharness: 2017-03-30 21:09:51.528516Z] Finished create-virtualenv step (success) 14:09:51 INFO - [mozharness: 2017-03-30 21:09:51.529448Z] Running install step. 14:09:51 INFO - Running pre-action listener: _resource_record_pre_action 14:09:51 INFO - Running main action method: install 14:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:51 INFO - Reading from file tmpfile_stdout 14:09:51 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:51 INFO - Reading from file tmpfile_stdout 14:09:51 INFO - Output received: 14:09:51 INFO - Usage: mozinstall [options] installer 14:09:51 INFO - Options: 14:09:51 INFO - -h, --help show this help message and exit 14:09:51 INFO - -d DEST, --destination=DEST 14:09:51 INFO - Directory to install application into. [default: 14:09:51 INFO - "/builds/slave/test"] 14:09:51 INFO - --app=APP Application being installed. [default: firefox] 14:09:51 INFO - mkdir: /builds/slave/test/build/application 14:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:10:06 INFO - Reading from file tmpfile_stdout 14:10:06 INFO - Output received: 14:10:06 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:10:06 INFO - Running post-action listener: _resource_record_post_action 14:10:06 INFO - [mozharness: 2017-03-30 21:10:06.581751Z] Finished install step (success) 14:10:06 INFO - [mozharness: 2017-03-30 21:10:06.581902Z] Running run-tests step. 14:10:06 INFO - Running pre-action listener: _resource_record_pre_action 14:10:06 INFO - Running main action method: run_tests 14:10:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:10:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:10:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:10:06 INFO - 2017-03-30 14:10:06.596 screenresolution[1631:7507] starting screenresolution argv=screenresolution get 14:10:06 INFO - 2017-03-30 14:10:06.598 screenresolution[1631:7507] Display 0: 1600x1200x32@60 14:10:06 INFO - 2017-03-30 14:10:06.604 screenresolution[1632:7509] starting screenresolution argv=screenresolution list 14:10:06 INFO - Available Modes on Display 0 14:10:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:10:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:10:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:10:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:10:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:10:06 INFO - Intel Iris: 14:10:06 INFO - Chipset Model: Intel Iris 14:10:06 INFO - Type: GPU 14:10:06 INFO - Bus: Built-In 14:10:06 INFO - VRAM (Dynamic, Max): 1536 MB 14:10:06 INFO - Vendor: Intel (0x8086) 14:10:06 INFO - Device ID: 0x0a2e 14:10:06 INFO - Revision ID: 0x0009 14:10:06 INFO - Displays: 14:10:06 INFO - Display: 14:10:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:10:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:10:06 INFO - Display Serial Number: 1600x1200 60 14:10:06 INFO - Main Display: Yes 14:10:06 INFO - Mirror: Off 14:10:06 INFO - Online: Yes 14:10:06 INFO - Rotation: Supported 14:10:06 INFO - Return code: 0 14:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:06 INFO - Python 2.7.3 14:10:06 INFO - Return code: 0 14:10:06 INFO - grabbing minidump binary from tooltool 14:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:06 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/macosx64/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 0x105f00d30>, '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 0x105e27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:06 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:10:06 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:10:06 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:10:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:06 INFO - Return code: 0 14:10:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:10:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:10:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--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 14:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0366 --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 14:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XigHlFHJuk/Render', 14:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:06 INFO - 'HOME': '/Users/cltbld', 14:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:06 INFO - 'LOGNAME': 'cltbld', 14:10:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:06 INFO - 'MOZ_NO_REMOTE': '1', 14:10:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:06 INFO - 'NO_EM_RESTART': '1', 14:10:06 INFO - 'PAGER': '/bin/cat', 14:10:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:06 INFO - 'PWD': '/builds/slave/test', 14:10:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:06 INFO - 'SHELL': '/bin/bash', 14:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners', 14:10:06 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 14:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:06 INFO - 'USER': 'cltbld', 14:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:06 INFO - 'XPC_FLAGS': '0x0', 14:10:06 INFO - 'XPC_SERVICE_NAME': '0', 14:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--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 14:10:07 INFO - mozversion application_buildid: 20170330120906 14:10:07 INFO - mozversion application_changeset: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 14:10:07 INFO - mozversion application_display_name: Firefox 14:10:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:07 INFO - mozversion application_name: Firefox 14:10:07 INFO - mozversion application_remotingname: firefox 14:10:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:10:07 INFO - mozversion application_vendor: Mozilla 14:10:07 INFO - mozversion application_version: 53.0 14:10:07 INFO - mozversion platform_buildid: 20170330120906 14:10:07 INFO - mozversion platform_changeset: 0a36cc120d6e7b8bc19176f5efac6b00dd9ad072 14:10:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:10:07 INFO - mozversion platform_version: 53.0 14:10:07 INFO - using testdate: 1490908207 14:10:07 INFO - actual date: 1490908207 14:10:07 INFO - starting webserver on 'localhost:49243' 14:10:07 INFO - SUITE-START | Running 2 tests 14:10:07 INFO - TEST-START | dromaeo_css 14:10:07 INFO - operating with platform_type : mac_ 14:10:07 INFO - Initialising browser for dromaeo_css test... 14:10:07 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpKWuYdO/profile http://localhost:49243/getInfo.html) 14:10:09 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 14:10:09 INFO - PROCESS | 1642 | colorDepth:24 14:10:09 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 14:10:09 INFO - PROCESS | 1642 | __metrics 14:10:09 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:10:09 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:10:10 INFO - TEST-INFO | 1642: exit 0 14:10:10 INFO - Browser initialized. 14:10:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:10 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpKWuYdO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:22 INFO - PROCESS | 1645 | RSS: Main: 167686144 14:10:22 INFO - PROCESS | 1645 | 14:13:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 14:13:26 INFO - PROCESS | 1645 | RSS: Main: 299880448 14:13:26 INFO - PROCESS | 1645 | 14:16:29 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 14:16:30 INFO - PROCESS | 1645 | RSS: Main: 306696192 14:16:30 INFO - PROCESS | 1645 | 14:19:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 14:19:33 INFO - PROCESS | 1645 | RSS: Main: 277467136 14:19:33 INFO - PROCESS | 1645 | 14:22:35 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 14:22:36 INFO - PROCESS | 1645 | RSS: Main: 284905472 14:22:36 INFO - PROCESS | 1645 | 14:25:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 14:25:40 INFO - PROCESS | 1645 | RSS: Main: 264941568 14:25:40 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 14:28:43 INFO - PROCESS | 1645 | RSS: Main: 543621120 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | __start_tp_report 14:28:43 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 14:28:43 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 14:28:43 INFO - PROCESS | 1645 | |i|pagename|runs| 14:28:43 INFO - PROCESS | 1645 | |0;dojo.html;3387.1193489692682;3399.1332210286373;3410.931781364373;3450.1374656335884;3469.4448888177894;5711.371749107595;5774.769009239636;5784.248047753791;5801.100829371444;5806.941930580693;5691.971540142304;5729.684867332295;5759.1937128802;5781.739821708023;5797.36229014808;4772.856814295576;5027.723475208881;5176.663516871401;5209.296744939423;5209.609279304048;5128.589712822965;5146.716930568818;5150.613703972198;5184.974075129619;5281.313429254192;5212.661177023481;5245.632805703603;5263.921041184385;5276.577873770108;5277.683338999653;5258.737063146847;5272.815451459181;5273.314469119028;5284.101702710548;5327.413984461706;5009.098362294785;5134.460881607415;5206.687598744087;5214.322138122057;5214.957008598296;5704.572157088235;5710.857228569319;5794.739236734357;5796.362400135981;5828.912566311508;6300.842478938063;6309.621422714652;6314.71583778731;6319.74721011159;6355.396237357444;6238.220222472191;6268.561200715952;6280.466160376328;6291.402316779899;6294.181756371689;4358.738475691469;5693.77224911003;5750.281214848144;5782.10377391505;5826.796062137805;6302.810915672537;6314.336994615591;6320.304766475684;6327.3988971047675;6331.430171284606;6103.35914728956;6134.9693251534345;6141.7543298267565;6143.96928015366;6165.722542485599;6202.906956395657;6217.222847144107;6239.688015599202;6261.96869015652;6262.937370626236;6298.230649127788;6315.494760419156;6319.6208227506495;6323.52573556985;6336.778212762531;6331.398517140864;6336.619802811846;6349.301576826545;6355.428011478896;6356.586821856565;4767.070421267889;4871.196252618349;4875.07373599015;4996.90006199874;5027.069992051483;4383.991681913114;4426.911461770746;4440.933385999213;4444.7110937789585;4511.70673906195;5129.512696293846;5724.856878578069;5789.710514474259;5791.305043394819;5796.188533605298;5169.948300517022;6142.713648198282;6289.245290565162;6325.683715814191;6337.144485494399;5590.189422533791;5710.057840456361;5712.971435142881;5720.342160651495;5725.856853578611;5430.701311427831;5435.130379139318;5436.184572314105;5436.945630543723;5442.809501667422;6210.285817130997;6257.43683068526;6267.310595834455;6275.968620156961;6277.027060805491;6264.248290205204;6339.809805705836;6341.4292713656;6343.175387199819;6343.333949935375;6310.305866354789;6312.558120931674;6313.558050936574;6330.272018717907;6346.365363463801;6102.176206212104;6149.139120523041;6150.907736383869;6226.813195604139;6266.373362663697;5282.76227569768;6232.937670623236;6260.311365749855;6302.936970630235;6327.525435592257;5998.490128338965;6189.84525386869;6199.783007594712;6209.906851397323;6212.471939884979;6028.909566356596;6208.782692605737;6221.911165545921;6225.844353891189;6235.532335074797;5927.614705044159;5960.970195148997;5991.520678345809;6043.184170136975;6111.96944015277;6158.943040753452;6184.288806787277;6189.257289125334;6190.907136392868;6193.504519638508;5964.373740757158;6027.879442411215;6034.879302414015;6038.9396106038375;6045.758169673164 14:28:43 INFO - PROCESS | 1645 | |1;ext.html;482.857557020679;497.7536119620786;503.8035166285152;509.47524050228265;533.4718628557729;32576.185595360097;42174.367384489255;44209.33685994705;44274.999999999956;46593.767031164796;45563.08873822522;46100;46101;46151;46182.76908615452;9654.806903861936;9838.852417213711;9847.064528869781;9852.802943941117;9860.901390986106;9030.322725795559;9265.583048762788;9278.72163835086;9389.906100939006;9390.342676012682;10129.442880641562;12195.390230488485;12206.328651924141;12361.134720569564;12407.50369985204;12003.3398163101;12082.456289466994;12090.697732556757;12100.213486123417;12113.273203607812;11908.404579771064;11927.761444771142;11971.401429928468;11972.940135299355;11994.460249288803;42932.57067429317;43229.91925201863;43342.13315733699;43368;43418.78290608558;4057.472528571296;4123.072308730541;4125.608067233608;4131.421600975866;4146.129312844307;30834.383312333626;31621.841890790627;31886.84056579702;32971.51628176738;33263.6673633263;3356.5300857879915;3366.8484918178497;3392.423288041039;3422.110251334646;3543.875964341236;502099.4895025538;502642.9735702669;502857;502994;504895;66574;68501.65749171222;69054.30945690478;69171.65414172897;69340.30659693439;63716.68141659355;73345.6332718333;73432.26567734254;73469.63265183747;73539.26460735324;18134.09329533518;18403.53991150232;18427.355042573447;18444.262229510936;18492.35276765307;14082.014259001771;14188.006839521135;14194.787078193835;14214.862810975097;14215.076020058663;16863;17219.913900430416;17440.06278573914;19023.52441188981;19222.8077719221;7090.4327653788605;7225.747098851515;7281.963590182015;7423.8144046399275;7460.365868901095;766.3907193780957;893.6684340332857;903.6927444668844;912.1015799437548;920.374145580998;30960.535591966138;31014.844925775225;31164.53253201204;31362.372752544823;31717;1104.6962085426571;1112.5827814569536;1116.3636727065496;1146.220570012383;1148.4085695866636;15642.530724078295;16297.266623001757;16308;16435.83564164367;16575.83424165767;617951;622503;623133;623191;624690;57336.853262934506;58285;64630.38424039436;64984.350156498775;65260.67369663122;1488.2038109611306;1491.0531812299268;1494.6263434141465;1502.8121484814617;1511.463430482185;25421.491570168862;31925;32520.34959300848;32611.510827338083;33318.666813331554;55890.441095588525;57323.42676573181;57508.71245643745;60169.495762604536;60272.79454410975;597595;645307;645863;783812;784464;25246;25493;25509.61735573931;25814.61278080868;25873.870630646725;44815.775921120185;44871;45022;45248;45358.77320613376;29897.70102298949;30487.695123048485;30621.40482872533;31023.379532408773;31817.5227371585;31000.53499197559;31026.953360092568;31126.066218013497;31464.685353146175;31500.054998350086;36051.819740901126;36747.44878826873;36937.63062369342;36948.44577331396;36970.8151459241;29795;30457.781688732204;30605.540916886708;31127;31599.36801264008;24124.638130427706;24375.75624243806;24540.877295614122;24620.1382951603;24679.25962221136 14:28:43 INFO - PROCESS | 1645 | |2;jquery.html;400.75954427343595;403.9495063117112;408.6016134269087;414.39705228891967;434.1924021320344;20560.177592896285;20569.074391652375;21667.566648667016;21856.907154642286;22103.115875364987;20479.897600512013;21319.467013324676;21481.67777483339;22412.215572454967;22422.439439014033;5862;6133.6626485543275;6137.447629713325;6147.47746441553;6151.784687535937;5896.852578685546;6021.5182785377065;6034.125051867477;6055.565792029163;6072.332043475214;6014.548908831834;6020.668863212543;6027.7287522061615;6028.517718582503;6038.57729958903;5820.883582328351;5976.193213916131;5987.34139244685;6042.667653279068;6057.848553786146;5104.106781313255;5281.973590132063;5314.096603577363;5321.600879933982;5323.840284791462;22389;22840.543189136126;22857;25397;26585.73414265852;2649.4038841260754;2711.9728802712116;2713.8643067846724;2719.415325704983;2725.68654604721;10193.592256309812;10207;10713.928607139302;13499.66250843727;14576.271186440636;1474;1635.1497221444781;1717.6516434598905;1826.1599664154505;1844.8339649431482;101983.94048178567;110365;122225;130325.34837325847;144989.2750536251;11577.942110289394;11950.163488555718;11981.880181198076;12008.819867701992;12010.519579216734;15781.36874525029;15864.60338491547;15867.127307998171;15873.285702143432;15877.761833572506;8654.437461564978;8998.055204203465;9013.369064165445;9063.501507417155;9103.726888193365;8822.470651760916;8826.735197944072;8851.380403371832;9002.684906028258;9022.14289642483;3987.362022076512;4000.2599519089063;4811.591014763714;4850.024368270995;4901.485344038896;1668.3910372713872;2047.9692804607944;2054.1269960266827;2059.969100463494;2061.154926480136;682.4717586031352;807.6284908941952;815.9347252219808;833.9416240863081;843.9240468357877;20930.790692092884;21002.264920727703;22065.11739530433;22081.889590551946;22174.334769956928;765.2882818978293;811.9201462055452;854.4189950833369;890.5013192612158;896.1083721696823;10921.399323037309;11320.773584528264;11364.886351136549;11387.772244555063;11430.199886008066;802399;816357;823269;832656;843696;166079;170034;170819;172507.6873078183;174744;1009.106940357774;1046.9895301047045;1091.252492042953;1092.4646923007829;1095.0637205189607;19378.321758738377;19712.310069147512;20078;20145.899270503553;20184.49538761543;64195;64268.71462570629;64391;65157.67421162864;65510.34489655042;93746.53126734322;97185;98341;98770.01229987896;100043.4993475113;7422.14645315774;8148.551829649189;8316.625751841302;8811.383203175716;8911.598978045873;7431.3683336916965;10486.318389304672;11995.340256285988;13317.467301308227;13826.723465530431;11305.15211359135;11566.016888564567;11935.224210426295;11948.402579871146;12059.03527717798;10698.62554810578;10829.458527073457;11034.944825275823;11094;11342.092632589538;11460.598879039193;11520.769584608428;11785.764284714429;12084.39578021113;12118.75762484763;7554.395648348229;7684;7685.346745526693;7858.921410785819;8021.157778433414;8529.189726976176;10520.842187367043;11755.647330580096;12064.733203013557;12064.819027714766 14:28:43 INFO - PROCESS | 1645 | |3;mootools.html;1296.9805452918208;1458.3510337899631;1478.970420591589;1482.2292407947868;1485.4058376649332;7456.7762967111075;8275.255227029566;8554.631258998554;8631.784205394853;8640.74077777667;7113.502054856162;7609.315161635452;7907.604619769003;7920.9207907921045;8257.710980115697;2379.940501487459;2423.09134074722;2424.854508729473;2430.2101816909485;2430.3195105370523;2380.6191009438494;2426.5632186206476;2429.6841410616685;2435.537247922889;2439.865807380593;2102.568973360457;2200.570888676709;2320.791128798408;2381.345130089222;2402.027178992511;2367.633016882386;2375.8218133639875;2382.976170238293;2389.2115601851433;2389.7012873390827;2360.055977608953;2382.7617238276207;2428.659987601737;2428.854268743881;2431.9392015199583;8535.189157030072;8594.914050859474;8602.956985215096;8617.612207450617;8624.223819856243;5169.302144210558;5318.574514038906;5328.440513746078;5328.733563321857;5339.439358867341;3365.5456513370627;3368.8147151906637;3649.7810131392202;3653.3789255826573;3655.2872189922978;1136.3409222650844;1241.6895776055985;1284.0690499387963;1291.1671971578373;1307.4312673986847;10950.39772812495;10970.451477426097;10987.175961802817;10992.230543861933;10993.61522346714;3743.644353786386;4755.762211889391;4826.276058591239;4830.903381932412;4833.758312084382;9600.855987160197;9608.711738647851;9611.375260608178;9646.372985755903;9688.176504997155;5297.099493086184;5396.0556902542685;5399.514043736082;5401.864953376118;5403.162509810985;4441.111777644484;4501.144782491317;4610.446746390455;4917.827876024322;4921.138800709933;3855.363864962306;3918.4710064141545;4025.496812898388;4030.879073627796;4069.348904175318;1279.5073896549895;1280.8270883430805;1298.662377750918;1308.5943357558997;1311.8360204974379;925.5696101312788;932.9813403732023;950.4059962523423;959.203860795538;1002.3484734922358;4836.322914791932;5385.7307134643115;5511;5698.886022279531;6072.997955337408;575.815738963536;580.7938181945433;591.4351794036685;598.86525531755;602.9577929544978;3742.7567208131386;3748.606396328401;3799.601041890617;3866.729328947003;3892.9805350973065;9866.260030497742;10068;10228.925962773801;10234.744131396774;10238.385696858213;10146.949265253626;10169.03394177552;10176.796464070678;10189.54147063384;10210.336328138646;7524.247575242432;7808;7937.960310198412;7946.205379462008;8025.518468891885;5212.791488340424;5782.132680098019;5864.618799778001;5972.432618901197;5997.10043493462;9275.350725449423;9491.952540237255;9517.714468565953;9530.809383812146;9555.761105972406;7933.722319718782;9114.908850911406;9286.814263714823;9410.717678469657;9497.810043798947;6774.830629234309;7002.544834585736;7255.020572222682;7419.517731347445;7424.703011879465;7655.770326890202;7943.324817390587;7983.5209887406945;8120.796980075545;8221.424500284922;6985.965070174617;7093.893591596027;7111.644417779194;7135.5361901476235;7231.457640676865;6352.396522330371;6971.163460384786;6988.40598549129;6996.580205187705;7054.08296921397;6512.283648798533;6578.572392794453;6623.602583844792;6642.169728783902;6643.2360278568585;5096.388433388017;5138.665986710852;5139.6145289104215;5154.8969020620125;5198.4801519849225;5045.293658887832;5056.62075344358;5161.483851614808;5233.581313494988;5265.763040663102 14:28:43 INFO - PROCESS | 1645 | |4;prototype.html;374.18241143102324;379.18853653182197;383.8656769246876;392.6426951474159;397.67192066545107;5248.737563121843;5308.946910530898;5358.839234822952;5377.580088959969;5380.435054319299;4741.502142275054;4965.404151501825;5091.338126043609;5136.229565565167;5197.66215196012;4070.903484705379;4115.8971025724295;4141.151064031881;4151.501819781615;4176.728512646683;3428.8971330860113;4081.8775436736796;4178.498580170384;4190.7485550866895;4208.663306935453;3288.3752087103494;3971.344728119857;4144.896377590554;4150.501939767232;4157.334826427772;3732.5147730795093;3988.1624858779546;4107.137501124767;4116.341385378325;4120.876373708794;3647.598764135943;3657.085728567858;3665.9450108248398;3671.5777685566236;3681.5214022177215;4796.973443742179;4860.031687166703;4956.3804524434445;5159.25190847325;5195.636305458619;4250.469830860888;4370.8033138508845;4767.451743049559;4790.592799612037;4795.088933102699;5622.550195984352;5624.29696287964;5625.1843482695185;5652.74562644682;5656.490915817596;3848.230353929225;4068.044009657728;4073.97963010186;4099.938500922489;4105.2494828464705;5165.483451654842;5311.194193974067;5750.79872204475;5791.276090488689;5857.589968702193;4133.8966525837095;4149.672104926394;4155.958440415558;4186.874393768192;4187.895302617398;3565.625609310985;4229.703920725519;4259.0621267323295;4270.7010509264055;4288.935665965013;3854.5759966403675;4538.155414368495;4681.555252251031;4729.287509305248;4753.738544380023;5151.459096794858;5567.9142567199815;5570.164475328733;5607.691576963306;5615.1470014894985;1276.3363051213316;1315.6184706435026;1343.7849944008913;1354.1265883505282;1382.9696875827372;923.132255679659;932.9690691785615;964.81668482988;984.8621193032981;989.1542730965065;4406.713563618355;4517.864464066083;4608.976955115203;4808.1820996593815;4894.216925291937;5349;5429.267048948342;5431.619786614978;5437.945620543744;5467.6719396836315;3765.3222419964122;4144.48193975753;4591.977040114778;4630;4863.80544778212;2478.5414698280874;2820.3513191965963;2845.39646223703;2849.6295481587676;2852.8288302701903;4838.903221935541;5060.671056381323;5346.97326513365;5396.865078373072;5586.91619625706;4905.087016063738;5450.29146210998;5631.915521267102;5663.998081017067;5668.489835914787;4819.638527110411;4892.804287828518;5440.7551660174595;5644;5678.082123334886;5022.347094877642;5289.867753306198;5309.681419114865;5377.623566350318;5383.973080134574;4821.807127714992;5124.104081489872;5205.58355331565;5421.132618780976;5435.293411856592;5553.888922221614;5680.261565996394;5680.693440508623;5694.829155125353;5704.486596206361;3409.573803274591;3496.9542817452075;3708.9629103708617;3775.754575952554;3844.519435070616;5196.246544251138;5352.357717073976;5354.223637572608;5406.324209473816;5416.106342453609;4659.324397962344;5181.844544663666;5239.685618862881;5274.7890084396195;5278.551323137576;4329.631981281626;4477.798499067485;4796.040791841576;4987.80048798044;5226.451222621722;4917.582005529427;5078.873028174326;5105.617078719037;5106.617003724809;5216.869578260574;4935.580475659609;5059.139946209079;5155.484451554815;5267.73661316925;5595.412481689364;4820.228763397839;5000.5999520037585;5459.235707001102;5477.698726569917;5481.232627432242 14:28:43 INFO - PROCESS | 1645 | |5;yui.html;697.3549466743261;748.2218492767522;766.7891329884282;777.0675189772271;880.4497189256715;13295.601131966032;15308.617284567878;15616.453424130157;15800.288986995583;15863.920680396597;14323.283835808194;14359.856401435982;14366.569002929902;14418.134911905267;14427.422903083863;736.2196072163497;759.388692102857;762.2491845532146;762.572959142879;915.6108653822132;765.490948519234;765.689895592286;893.865920111982;923.5474617437475;935.948522831244;865.5109862927458;991.5092029445435;993.0417147452707;997.997013001932;1001.9729776978619;988.7033889833057;990.7325022244025;996.9551370188359;997.6657819630433;1000.4947501511763;750.1523278695095;751.5528260684938;751.9285667861544;752.3943225703307;752.7892190186757;15375.231238438146;15508.92245538765;15757.763633545506;15818.209089545591;15869.682606347924;14804.777928331083;15045.247737613076;15156.772648410282;15359.001664891857;15369.154696491689;11708.414579271002;11753.529858805638;11844.703882402922;11907.404629768476;12139.575114870937;3893.377059670439;3898.7075969302414;3955.805071647231;3995.580464051262;4038.2932986727205;94593;95800.52099739526;101798.4910075445;109198;110635;11192.888071119185;11494.597689080842;11620.244684095507;11649.47577359021;11658.125640576991;22991.655125173136;23093;23389.181378651665;23484.765152348256;23494.530109397718;7792.259735325135;7893.526388416713;7966;8064.919350806535;8138.267555919877;3809.3143234218105;4432.889177770581;4465.977670111693;4480.215962206601;4540.704854184468;3644.344018076719;3666.816659167031;3694.2980833641523;3708.35103856824;3733.1040550268285;675.7398401615316;683.1665368250726;685.5817951049855;690.8963655451622;693.6774399903968;663.2240278873729;669.6015870557011;677.2313424263497;679.2629996453804;698.3435570563654;10389.156012275507;10871.945640271748;11281.32312061279;11366.829497557543;11518.84761576528;595.7140572525212;631.3370960491466;632.8386261503288;663.3318295167803;727.5485406613734;4397.912041759147;5029.170186919117;5253.4221235664045;5264.815731449381;5290.9735451322495;96963;98642;99134.50432747934;100030.4998475003;102162;69833.3016669837;88353.67469487964;88654;90090;90956;58742.82514349689;78851.81722274056;79302.99999999885;79665.60167199127;79885;10906.72733181645;11180.832287515856;11543;11553.537858485903;11585.594504192313;39742;43321.78339108284;47547;49992;52510;60542;63757.362426376996;70515;70809;73309;13097.607071787861;13255.80116298237;13312.934965202567;13397.464101436224;13780.173189608655;14778.63053423673;15045.398184072514;15104;15277.6180595486;15840.76238856395;13453.394597242952;13639.977001725108;14138.293085345485;14173.858261417254;14190.645233869236;9273.629054838;13134.671633209246;13965.511207107702;13992.370343334778;14217.009618653603;10883.945580272048;13254.469821207043;13524;14007.579772606838;14220;9812.607495700378;10251.38491690501;10355.94822025885;10390;10501.369917804956;9772.706818795448;9887.604495820087;11171.832422513506;11430.942845285721;11467.541298347973 14:28:43 INFO - PROCESS | 1645 | __end_tp_report 14:28:43 INFO - PROCESS | 1645 | __start_cc_report 14:28:43 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1319 14:28:43 INFO - PROCESS | 1645 | __end_cc_report 14:28:43 INFO - PROCESS | 1645 | __startTimestamp1490909323282__endTimestamp 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | ------- Summary: start ------- 14:28:43 INFO - PROCESS | 1645 | Number of tests: 6 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5757.84 Median:6027.88 stddev:663.02 (11.0%) stddev-sans-first:638.43 14:28:43 INFO - PROCESS | 1645 | Values: 3387.1 3399.1 3410.9 3450.1 3469.4 5711.4 5774.8 5784.2 5801.1 5806.9 5692.0 5729.7 5759.2 5781.7 5797.4 4772.9 5027.7 5176.7 5209.3 5209.6 5128.6 5146.7 5150.6 5185.0 5281.3 5212.7 5245.6 5263.9 5276.6 5277.7 5258.7 5272.8 5273.3 5284.1 5327.4 5009.1 5134.5 5206.7 5214.3 5215.0 5704.6 5710.9 5794.7 5796.4 5828.9 6300.8 6309.6 6314.7 6319.7 6355.4 6238.2 6268.6 6280.5 6291.4 6294.2 4358.7 5693.8 5750.3 5782.1 5826.8 6302.8 6314.3 6320.3 6327.4 6331.4 6103.4 6135.0 6141.8 6144.0 6165.7 6202.9 6217.2 6239.7 6262.0 6262.9 6298.2 6315.5 6319.6 6323.5 6336.8 6331.4 6336.6 6349.3 6355.4 6356.6 4767.1 4871.2 4875.1 4996.9 5027.1 4384.0 4426.9 4440.9 4444.7 4511.7 5129.5 5724.9 5789.7 5791.3 5796.2 5169.9 6142.7 6289.2 6325.7 6337.1 5590.2 5710.1 5713.0 5720.3 5725.9 5430.7 5435.1 5436.2 5436.9 5442.8 6210.3 6257.4 6267.3 6276.0 6277.0 6264.2 6339.8 6341.4 6343.2 6343.3 6310.3 6312.6 6313.6 6330.3 6346.4 6102.2 6149.1 6150.9 6226.8 6266.4 5282.8 6232.9 6260.3 6302.9 6327.5 5998.5 6189.8 6199.8 6209.9 6212.5 6028.9 6208.8 6221.9 6225.8 6235.5 5927.6 5961.0 5991.5 6043.2 6112.0 6158.9 6184.3 6189.3 6190.9 6193.5 5964.4 6027.9 6034.9 6038.9 6045.8 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:74112.80 Median:19797.85 stddev:163915.48 (827.9%) stddev-sans-first:164282.09 14:28:43 INFO - PROCESS | 1645 | Values: 482.9 497.8 503.8 509.5 533.5 32576.2 42174.4 44209.3 44275.0 46593.8 45563.1 46100.0 46101.0 46151.0 46182.8 9654.8 9838.9 9847.1 9852.8 9860.9 9030.3 9265.6 9278.7 9389.9 9390.3 10129.4 12195.4 12206.3 12361.1 12407.5 12003.3 12082.5 12090.7 12100.2 12113.3 11908.4 11927.8 11971.4 11972.9 11994.5 42932.6 43229.9 43342.1 43368.0 43418.8 4057.5 4123.1 4125.6 4131.4 4146.1 30834.4 31621.8 31886.8 32971.5 33263.7 3356.5 3366.8 3392.4 3422.1 3543.9 502099.5 502643.0 502857.0 502994.0 504895.0 66574.0 68501.7 69054.3 69171.7 69340.3 63716.7 73345.6 73432.3 73469.6 73539.3 18134.1 18403.5 18427.4 18444.3 18492.4 14082.0 14188.0 14194.8 14214.9 14215.1 16863.0 17219.9 17440.1 19023.5 19222.8 7090.4 7225.7 7282.0 7423.8 7460.4 766.4 893.7 903.7 912.1 920.4 30960.5 31014.8 31164.5 31362.4 31717.0 1104.7 1112.6 1116.4 1146.2 1148.4 15642.5 16297.3 16308.0 16435.8 16575.8 617951.0 622503.0 623133.0 623191.0 624690.0 57336.9 58285.0 64630.4 64984.4 65260.7 1488.2 1491.1 1494.6 1502.8 1511.5 25421.5 31925.0 32520.3 32611.5 33318.7 55890.4 57323.4 57508.7 60169.5 60272.8 597595.0 645307.0 645863.0 783812.0 784464.0 25246.0 25493.0 25509.6 25814.6 25873.9 44815.8 44871.0 45022.0 45248.0 45358.8 29897.7 30487.7 30621.4 31023.4 31817.5 31000.5 31027.0 31126.1 31464.7 31500.1 36051.8 36747.4 36937.6 36948.4 36970.8 29795.0 30457.8 30605.5 31127.0 31599.4 24124.6 24375.8 24540.9 24620.1 24679.3 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:43681.35 Median:22848.77 stddev:137023.19 (599.7%) stddev-sans-first:137369.04 14:28:43 INFO - PROCESS | 1645 | Values: 400.8 403.9 408.6 414.4 434.2 20560.2 20569.1 21667.6 21856.9 22103.1 20479.9 21319.5 21481.7 22412.2 22422.4 5862.0 6133.7 6137.4 6147.5 6151.8 5896.9 6021.5 6034.1 6055.6 6072.3 6014.5 6020.7 6027.7 6028.5 6038.6 5820.9 5976.2 5987.3 6042.7 6057.8 5104.1 5282.0 5314.1 5321.6 5323.8 22389.0 22840.5 22857.0 25397.0 26585.7 2649.4 2712.0 2713.9 2719.4 2725.7 10193.6 10207.0 10713.9 13499.7 14576.3 1474.0 1635.1 1717.7 1826.2 1844.8 101983.9 110365.0 122225.0 130325.3 144989.3 11577.9 11950.2 11981.9 12008.8 12010.5 15781.4 15864.6 15867.1 15873.3 15877.8 8654.4 8998.1 9013.4 9063.5 9103.7 8822.5 8826.7 8851.4 9002.7 9022.1 3987.4 4000.3 4811.6 4850.0 4901.5 1668.4 2048.0 2054.1 2060.0 2061.2 682.5 807.6 815.9 833.9 843.9 20930.8 21002.3 22065.1 22081.9 22174.3 765.3 811.9 854.4 890.5 896.1 10921.4 11320.8 11364.9 11387.8 11430.2 802399.0 816357.0 823269.0 832656.0 843696.0 166079.0 170034.0 170819.0 172507.7 174744.0 1009.1 1047.0 1091.3 1092.5 1095.1 19378.3 19712.3 20078.0 20145.9 20184.5 64195.0 64268.7 64391.0 65157.7 65510.3 93746.5 97185.0 98341.0 98770.0 100043.5 7422.1 8148.6 8316.6 8811.4 8911.6 7431.4 10486.3 11995.3 13317.5 13826.7 11305.2 11566.0 11935.2 11948.4 12059.0 10698.6 10829.5 11034.9 11094.0 11342.1 11460.6 11520.8 11785.8 12084.4 12118.8 7554.4 7684.0 7685.3 7858.9 8021.2 8529.2 10520.8 11755.6 12064.7 12064.8 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5499.68 Median:5223.19 stddev:2987.39 (57.2%) stddev-sans-first:2979.07 14:28:43 INFO - PROCESS | 1645 | Values: 1297.0 1458.4 1479.0 1482.2 1485.4 7456.8 8275.3 8554.6 8631.8 8640.7 7113.5 7609.3 7907.6 7920.9 8257.7 2379.9 2423.1 2424.9 2430.2 2430.3 2380.6 2426.6 2429.7 2435.5 2439.9 2102.6 2200.6 2320.8 2381.3 2402.0 2367.6 2375.8 2383.0 2389.2 2389.7 2360.1 2382.8 2428.7 2428.9 2431.9 8535.2 8594.9 8603.0 8617.6 8624.2 5169.3 5318.6 5328.4 5328.7 5339.4 3365.5 3368.8 3649.8 3653.4 3655.3 1136.3 1241.7 1284.1 1291.2 1307.4 10950.4 10970.5 10987.2 10992.2 10993.6 3743.6 4755.8 4826.3 4830.9 4833.8 9600.9 9608.7 9611.4 9646.4 9688.2 5297.1 5396.1 5399.5 5401.9 5403.2 4441.1 4501.1 4610.4 4917.8 4921.1 3855.4 3918.5 4025.5 4030.9 4069.3 1279.5 1280.8 1298.7 1308.6 1311.8 925.6 933.0 950.4 959.2 1002.3 4836.3 5385.7 5511.0 5698.9 6073.0 575.8 580.8 591.4 598.9 603.0 3742.8 3748.6 3799.6 3866.7 3893.0 9866.3 10068.0 10228.9 10234.7 10238.4 10146.9 10169.0 10176.8 10189.5 10210.3 7524.2 7808.0 7938.0 7946.2 8025.5 5212.8 5782.1 5864.6 5972.4 5997.1 9275.4 9492.0 9517.7 9530.8 9555.8 7933.7 9114.9 9286.8 9410.7 9497.8 6774.8 7002.5 7255.0 7419.5 7424.7 7655.8 7943.3 7983.5 8120.8 8221.4 6986.0 7093.9 7111.6 7135.5 7231.5 6352.4 6971.2 6988.4 6996.6 7054.1 6512.3 6578.6 6623.6 6642.2 6643.2 5096.4 5138.7 5139.6 5154.9 5198.5 5045.3 5056.6 5161.5 5233.6 5265.8 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4437.54 Median:4893.51 stddev:1288.18 (26.3%) stddev-sans-first:1255.17 14:28:43 INFO - PROCESS | 1645 | Values: 374.2 379.2 383.9 392.6 397.7 5248.7 5308.9 5358.8 5377.6 5380.4 4741.5 4965.4 5091.3 5136.2 5197.7 4070.9 4115.9 4141.2 4151.5 4176.7 3428.9 4081.9 4178.5 4190.7 4208.7 3288.4 3971.3 4144.9 4150.5 4157.3 3732.5 3988.2 4107.1 4116.3 4120.9 3647.6 3657.1 3665.9 3671.6 3681.5 4797.0 4860.0 4956.4 5159.3 5195.6 4250.5 4370.8 4767.5 4790.6 4795.1 5622.6 5624.3 5625.2 5652.7 5656.5 3848.2 4068.0 4074.0 4099.9 4105.2 5165.5 5311.2 5750.8 5791.3 5857.6 4133.9 4149.7 4156.0 4186.9 4187.9 3565.6 4229.7 4259.1 4270.7 4288.9 3854.6 4538.2 4681.6 4729.3 4753.7 5151.5 5567.9 5570.2 5607.7 5615.1 1276.3 1315.6 1343.8 1354.1 1383.0 923.1 933.0 964.8 984.9 989.2 4406.7 4517.9 4609.0 4808.2 4894.2 5349.0 5429.3 5431.6 5437.9 5467.7 3765.3 4144.5 4592.0 4630.0 4863.8 2478.5 2820.4 2845.4 2849.6 2852.8 4838.9 5060.7 5347.0 5396.9 5586.9 4905.1 5450.3 5631.9 5664.0 5668.5 4819.6 4892.8 5440.8 5644.0 5678.1 5022.3 5289.9 5309.7 5377.6 5384.0 4821.8 5124.1 5205.6 5421.1 5435.3 5553.9 5680.3 5680.7 5694.8 5704.5 3409.6 3497.0 3709.0 3775.8 3844.5 5196.2 5352.4 5354.2 5406.3 5416.1 4659.3 5181.8 5239.7 5274.8 5278.6 4329.6 4477.8 4796.0 4987.8 5226.5 4917.6 5078.9 5105.6 5106.6 5216.9 4935.6 5059.1 5155.5 5267.7 5595.4 4820.2 5000.6 5459.2 5477.7 5481.2 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20231.08 Median:3927.26 stddev:28416.34 (723.6%) stddev-sans-first:28458.20 14:28:43 INFO - PROCESS | 1645 | Values: 697.4 748.2 766.8 777.1 880.4 13295.6 15308.6 15616.5 15800.3 15863.9 14323.3 14359.9 14366.6 14418.1 14427.4 736.2 759.4 762.2 762.6 915.6 765.5 765.7 893.9 923.5 935.9 865.5 991.5 993.0 998.0 1002.0 988.7 990.7 997.0 997.7 1000.5 750.2 751.6 751.9 752.4 752.8 15375.2 15508.9 15757.8 15818.2 15869.7 14804.8 15045.2 15156.8 15359.0 15369.2 11708.4 11753.5 11844.7 11907.4 12139.6 3893.4 3898.7 3955.8 3995.6 4038.3 94593.0 95800.5 101798.5 109198.0 110635.0 11192.9 11494.6 11620.2 11649.5 11658.1 22991.7 23093.0 23389.2 23484.8 23494.5 7792.3 7893.5 7966.0 8064.9 8138.3 3809.3 4432.9 4466.0 4480.2 4540.7 3644.3 3666.8 3694.3 3708.4 3733.1 675.7 683.2 685.6 690.9 693.7 663.2 669.6 677.2 679.3 698.3 10389.2 10871.9 11281.3 11366.8 11518.8 595.7 631.3 632.8 663.3 727.5 4397.9 5029.2 5253.4 5264.8 5291.0 96963.0 98642.0 99134.5 100030.5 102162.0 69833.3 88353.7 88654.0 90090.0 90956.0 58742.8 78851.8 79303.0 79665.6 79885.0 10906.7 11180.8 11543.0 11553.5 11585.6 39742.0 43321.8 47547.0 49992.0 52510.0 60542.0 63757.4 70515.0 70809.0 73309.0 13097.6 13255.8 13312.9 13397.5 13780.2 14778.6 15045.4 15104.0 15277.6 15840.8 13453.4 13640.0 14138.3 14173.9 14190.6 9273.6 13134.7 13965.5 13992.4 14217.0 10883.9 13254.5 13524.0 14007.6 14220.0 9812.6 10251.4 10355.9 10390.0 10501.4 9772.7 9887.6 11171.8 11430.9 11467.5 14:28:43 INFO - PROCESS | 1645 | -------- Summary: end -------- 14:28:43 INFO - PROCESS | 1645 | 14:28:43 INFO - TEST-INFO | 1645: exit 0 14:28:43 INFO - TEST-OK | dromaeo_css | took 1116803ms 14:28:43 INFO - TEST-START | kraken 14:28:43 INFO - operating with platform_type : mac_ 14:28:43 INFO - Initialising browser for kraken test... 14:28:43 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmp5LrYFi/profile http://localhost:49243/getInfo.html) 14:28:46 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 14:28:46 INFO - PROCESS | 1655 | colorDepth:24 14:28:46 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 14:28:46 INFO - PROCESS | 1655 | __metrics 14:28:46 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:28:46 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:46 INFO - TEST-INFO | 1655: exit 0 14:28:46 INFO - Browser initialized. 14:28:46 INFO - Running cycle 1/1 for kraken test... 14:28:46 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmp5LrYFi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:58 INFO - PROCESS | 1657 | RSS: Main: 163835904 14:28:58 INFO - PROCESS | 1657 | 14:29:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 14:29:02 INFO - PROCESS | 1657 | RSS: Main: 214196224 14:29:02 INFO - PROCESS | 1657 | 14:29:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 14:29:05 INFO - PROCESS | 1657 | RSS: Main: 228470784 14:29:05 INFO - PROCESS | 1657 | 14:29:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 14:29:09 INFO - PROCESS | 1657 | RSS: Main: 325500928 14:29:09 INFO - PROCESS | 1657 | 14:29:11 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 14:29:11 INFO - PROCESS | 1657 | RSS: Main: 228458496 14:29:11 INFO - PROCESS | 1657 | 14:29:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:14 INFO - PROCESS | 1657 | RSS: Main: 229670912 14:29:14 INFO - PROCESS | 1657 | 14:29:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:17 INFO - PROCESS | 1657 | RSS: Main: 269991936 14:29:17 INFO - PROCESS | 1657 | 14:29:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:21 INFO - PROCESS | 1657 | RSS: Main: 269619200 14:29:21 INFO - PROCESS | 1657 | 14:29:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 14:29:24 INFO - PROCESS | 1657 | RSS: Main: 267939840 14:29:24 INFO - PROCESS | 1657 | 14:29:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:27 INFO - PROCESS | 1657 | RSS: Main: 245493760 14:29:27 INFO - PROCESS | 1657 | 14:29:28 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:29 INFO - PROCESS | 1657 | RSS: Main: 247537664 14:29:29 INFO - PROCESS | 1657 | 14:29:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:32 INFO - PROCESS | 1657 | RSS: Main: 255676416 14:29:32 INFO - PROCESS | 1657 | 14:29:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:35 INFO - PROCESS | 1657 | RSS: Main: 261795840 14:29:35 INFO - PROCESS | 1657 | 14:29:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:39 INFO - PROCESS | 1657 | RSS: Main: 262942720 14:29:39 INFO - PROCESS | 1657 | 14:29:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 14:29:41 INFO - PROCESS | 1657 | RSS: Main: 307556352 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | __start_tp_report 14:29:41 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 14:29:41 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 14:29:41 INFO - PROCESS | 1657 | |i|pagename|runs| 14:29:41 INFO - PROCESS | 1657 | |0;ai-astar;103;113;113;114;114;115;114;113;113;114 14:29:41 INFO - PROCESS | 1657 | |1;audio-beat-detection;141;108;106;143;107;129;144;119;125;106 14:29:41 INFO - PROCESS | 1657 | |2;audio-dft;181;183;183;184;247;198;182;181;183;181 14:29:41 INFO - PROCESS | 1657 | |3;audio-fft;83;57;58;84;61;59;55;58;70;57 14:29:41 INFO - PROCESS | 1657 | |4;audio-oscillator;84;69;85;70;68;68;80;67;69;80 14:29:41 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;94;131;107;83;86;83;87;84;86;83 14:29:41 INFO - PROCESS | 1657 | |6;imaging-darkroom;93;93;92;95;93;113;137;95;93;92 14:29:41 INFO - PROCESS | 1657 | |7;imaging-desaturate;89;87;84;88;85;87;84;81;84;86 14:29:41 INFO - PROCESS | 1657 | |8;json-parse-financial;55;53;54;51;54;56;54;56;54;54 14:29:41 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;63;75;69;72;72;67;66;73;99;101 14:29:41 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;84;84;83;81;81;86;86;88;117;85 14:29:41 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;136;132;131;132;117;133;145;140;170;132 14:29:41 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;163;163;162;161;161;161;161;161;163;161 14:29:41 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;64;65;65;64;62;64;63;65;63;63 14:29:41 INFO - PROCESS | 1657 | __end_tp_report 14:29:41 INFO - PROCESS | 1657 | __start_cc_report 14:29:41 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1941 14:29:41 INFO - PROCESS | 1657 | __end_cc_report 14:29:41 INFO - PROCESS | 1657 | __startTimestamp1490909381224__endTimestamp 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | ------- Summary: start ------- 14:29:41 INFO - PROCESS | 1657 | Number of tests: 14 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.44 (3.0%) stddev-sans-first:0.71 14:29:41 INFO - PROCESS | 1657 | Values: 103.0 113.0 113.0 114.0 114.0 115.0 114.0 113.0 113.0 114.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:127.00 stddev:15.92 (12.5%) stddev-sans-first:15.46 14:29:41 INFO - PROCESS | 1657 | Values: 141.0 108.0 106.0 143.0 107.0 129.0 144.0 119.0 125.0 106.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:190.30 Median:183.00 stddev:20.55 (11.2%) stddev-sans-first:21.52 14:29:41 INFO - PROCESS | 1657 | Values: 181.0 183.0 183.0 184.0 247.0 198.0 182.0 181.0 183.0 181.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:64.20 Median:60.00 stddev:10.96 (18.3%) stddev-sans-first:9.28 14:29:41 INFO - PROCESS | 1657 | Values: 83.0 57.0 58.0 84.0 61.0 59.0 55.0 58.0 70.0 57.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:74.00 Median:75.00 stddev:7.30 (9.7%) stddev-sans-first:6.79 14:29:41 INFO - PROCESS | 1657 | Values: 84.0 69.0 85.0 70.0 68.0 68.0 80.0 67.0 69.0 80.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:85.00 stddev:15.46 (18.2%) stddev-sans-first:16.39 14:29:41 INFO - PROCESS | 1657 | Values: 94.0 131.0 107.0 83.0 86.0 83.0 87.0 84.0 86.0 83.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:93.00 stddev:14.57 (15.7%) stddev-sans-first:15.26 14:29:41 INFO - PROCESS | 1657 | Values: 93.0 93.0 92.0 95.0 93.0 113.0 137.0 95.0 93.0 92.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.50 stddev:2.37 (2.7%) stddev-sans-first:2.15 14:29:41 INFO - PROCESS | 1657 | Values: 89.0 87.0 84.0 88.0 85.0 87.0 84.0 81.0 84.0 86.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.45 (2.7%) stddev-sans-first:1.50 14:29:41 INFO - PROCESS | 1657 | Values: 55.0 53.0 54.0 51.0 54.0 56.0 54.0 56.0 54.0 54.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:72.00 stddev:13.31 (18.5%) stddev-sans-first:13.30 14:29:41 INFO - PROCESS | 1657 | Values: 63.0 75.0 69.0 72.0 72.0 67.0 66.0 73.0 99.0 101.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.50 stddev:10.60 (12.5%) stddev-sans-first:11.16 14:29:41 INFO - PROCESS | 1657 | Values: 84.0 84.0 83.0 81.0 81.0 86.0 86.0 88.0 117.0 85.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:134.50 stddev:13.70 (10.2%) stddev-sans-first:14.53 14:29:41 INFO - PROCESS | 1657 | Values: 136.0 132.0 131.0 132.0 117.0 133.0 145.0 140.0 170.0 132.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 14:29:41 INFO - PROCESS | 1657 | Values: 163.0 163.0 162.0 161.0 161.0 161.0 161.0 161.0 163.0 161.0 14:29:41 INFO - PROCESS | 1657 | 14:29:41 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 14:29:41 INFO - PROCESS | 1657 | Values: 64.0 65.0 65.0 64.0 62.0 64.0 63.0 65.0 63.0 63.0 14:29:41 INFO - PROCESS | 1657 | -------- Summary: end -------- 14:29:41 INFO - PROCESS | 1657 | 14:29:42 INFO - TEST-INFO | 1657: exit 0 14:29:42 INFO - TEST-OK | kraken | took 58102ms 14:29:42 INFO - SUITE-END | took 1174s 14:29:42 INFO - Completed test suite (00:19:35) 14:29:42 INFO - javascript benchmark 14:29:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.1193489692682, 3399.1332210286373, 3410.931781364373, 3450.1374656335884, 3469.4448888177894, 5711.371749107595, 5774.769009239636, 5784.248047753791, 5801.100829371444, 5806.941930580693, 5691.971540142304, 5729.684867332295, 5759.1937128802, 5781.739821708023, 5797.36229014808, 4772.856814295576, 5027.723475208881, 5176.663516871401, 5209.296744939423, 5209.609279304048, 5128.589712822965, 5146.716930568818, 5150.613703972198, 5184.974075129619, 5281.313429254192, 5212.661177023481, 5245.632805703603, 5263.921041184385, 5276.577873770108, 5277.683338999653, 5258.737063146847, 5272.815451459181, 5273.314469119028, 5284.101702710548, 5327.413984461706, 5009.098362294785, 5134.460881607415, 5206.687598744087, 5214.322138122057, 5214.957008598296, 5704.572157088235, 5710.857228569319, 5794.739236734357, 5796.362400135981, 5828.912566311508, 6300.842478938063, 6309.621422714652, 6314.71583778731, 6319.74721011159, 6355.396237357444, 6238.220222472191, 6268.561200715952, 6280.466160376328, 6291.402316779899, 6294.181756371689, 4358.738475691469, 5693.77224911003, 5750.281214848144, 5782.10377391505, 5826.796062137805, 6302.810915672537, 6314.336994615591, 6320.304766475684, 6327.3988971047675, 6331.430171284606, 6103.35914728956, 6134.9693251534345, 6141.7543298267565, 6143.96928015366, 6165.722542485599, 6202.906956395657, 6217.222847144107, 6239.688015599202, 6261.96869015652, 6262.937370626236, 6298.230649127788, 6315.494760419156, 6319.6208227506495, 6323.52573556985, 6336.778212762531, 6331.398517140864, 6336.619802811846, 6349.301576826545, 6355.428011478896, 6356.586821856565, 4767.070421267889, 4871.196252618349, 4875.07373599015, 4996.90006199874, 5027.069992051483, 4383.991681913114, 4426.911461770746, 4440.933385999213, 4444.7110937789585, 4511.70673906195, 5129.512696293846, 5724.856878578069, 5789.710514474259, 5791.305043394819, 5796.188533605298, 5169.948300517022, 6142.713648198282, 6289.245290565162, 6325.683715814191, 6337.144485494399, 5590.189422533791, 5710.057840456361, 5712.971435142881, 5720.342160651495, 5725.856853578611, 5430.701311427831, 5435.130379139318, 5436.184572314105, 5436.945630543723, 5442.809501667422, 6210.285817130997, 6257.43683068526, 6267.310595834455, 6275.968620156961, 6277.027060805491, 6264.248290205204, 6339.809805705836, 6341.4292713656, 6343.175387199819, 6343.333949935375, 6310.305866354789, 6312.558120931674, 6313.558050936574, 6330.272018717907, 6346.365363463801, 6102.176206212104, 6149.139120523041, 6150.907736383869, 6226.813195604139, 6266.373362663697, 5282.76227569768, 6232.937670623236, 6260.311365749855, 6302.936970630235, 6327.525435592257, 5998.490128338965, 6189.84525386869, 6199.783007594712, 6209.906851397323, 6212.471939884979, 6028.909566356596, 6208.782692605737, 6221.911165545921, 6225.844353891189, 6235.532335074797, 5927.614705044159, 5960.970195148997, 5991.520678345809, 6043.184170136975, 6111.96944015277, 6158.943040753452, 6184.288806787277, 6189.257289125334, 6190.907136392868, 6193.504519638508, 5964.373740757158, 6027.879442411215, 6034.879302414015, 6038.9396106038375, 6045.758169673164], "value": 5715.764567520421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.857557020679, 497.7536119620786, 503.8035166285152, 509.47524050228265, 533.4718628557729, 32576.185595360097, 42174.367384489255, 44209.33685994705, 44274.999999999956, 46593.767031164796, 45563.08873822522, 46100.0, 46101.0, 46151.0, 46182.76908615452, 9654.806903861936, 9838.852417213711, 9847.064528869781, 9852.802943941117, 9860.901390986106, 9030.322725795559, 9265.583048762788, 9278.72163835086, 9389.906100939006, 9390.342676012682, 10129.442880641562, 12195.390230488485, 12206.328651924141, 12361.134720569564, 12407.50369985204, 12003.3398163101, 12082.456289466994, 12090.697732556757, 12100.213486123417, 12113.273203607812, 11908.404579771064, 11927.761444771142, 11971.401429928468, 11972.940135299355, 11994.460249288803, 42932.57067429317, 43229.91925201863, 43342.13315733699, 43368.0, 43418.78290608558, 4057.472528571296, 4123.072308730541, 4125.608067233608, 4131.421600975866, 4146.129312844307, 30834.383312333626, 31621.841890790627, 31886.84056579702, 32971.51628176738, 33263.6673633263, 3356.5300857879915, 3366.8484918178497, 3392.423288041039, 3422.110251334646, 3543.875964341236, 502099.4895025538, 502642.9735702669, 502857.0, 502994.0, 504895.0, 66574.0, 68501.65749171222, 69054.30945690478, 69171.65414172897, 69340.30659693439, 63716.68141659355, 73345.6332718333, 73432.26567734254, 73469.63265183747, 73539.26460735324, 18134.09329533518, 18403.53991150232, 18427.355042573447, 18444.262229510936, 18492.35276765307, 14082.014259001771, 14188.006839521135, 14194.787078193835, 14214.862810975097, 14215.076020058663, 16863.0, 17219.913900430416, 17440.06278573914, 19023.52441188981, 19222.8077719221, 7090.4327653788605, 7225.747098851515, 7281.963590182015, 7423.8144046399275, 7460.365868901095, 766.3907193780957, 893.6684340332857, 903.6927444668844, 912.1015799437548, 920.374145580998, 30960.535591966138, 31014.844925775225, 31164.53253201204, 31362.372752544823, 31717.0, 1104.6962085426571, 1112.5827814569536, 1116.3636727065496, 1146.220570012383, 1148.4085695866636, 15642.530724078295, 16297.266623001757, 16308.0, 16435.83564164367, 16575.83424165767, 617951.0, 622503.0, 623133.0, 623191.0, 624690.0, 57336.853262934506, 58285.0, 64630.38424039436, 64984.350156498775, 65260.67369663122, 1488.2038109611306, 1491.0531812299268, 1494.6263434141465, 1502.8121484814617, 1511.463430482185, 25421.491570168862, 31925.0, 32520.34959300848, 32611.510827338083, 33318.666813331554, 55890.441095588525, 57323.42676573181, 57508.71245643745, 60169.495762604536, 60272.79454410975, 597595.0, 645307.0, 645863.0, 783812.0, 784464.0, 25246.0, 25493.0, 25509.61735573931, 25814.61278080868, 25873.870630646725, 44815.775921120185, 44871.0, 45022.0, 45248.0, 45358.77320613376, 29897.70102298949, 30487.695123048485, 30621.40482872533, 31023.379532408773, 31817.5227371585, 31000.53499197559, 31026.953360092568, 31126.066218013497, 31464.685353146175, 31500.054998350086, 36051.819740901126, 36747.44878826873, 36937.63062369342, 36948.44577331396, 36970.8151459241, 29795.0, 30457.781688732204, 30605.540916886708, 31127.0, 31599.36801264008, 24124.638130427706, 24375.75624243806, 24540.877295614122, 24620.1382951603, 24679.25962221136], "value": 20796.5708217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.75954427343595, 403.9495063117112, 408.6016134269087, 414.39705228891967, 434.1924021320344, 20560.177592896285, 20569.074391652375, 21667.566648667016, 21856.907154642286, 22103.115875364987, 20479.897600512013, 21319.467013324676, 21481.67777483339, 22412.215572454967, 22422.439439014033, 5862.0, 6133.6626485543275, 6137.447629713325, 6147.47746441553, 6151.784687535937, 5896.852578685546, 6021.5182785377065, 6034.125051867477, 6055.565792029163, 6072.332043475214, 6014.548908831834, 6020.668863212543, 6027.7287522061615, 6028.517718582503, 6038.57729958903, 5820.883582328351, 5976.193213916131, 5987.34139244685, 6042.667653279068, 6057.848553786146, 5104.106781313255, 5281.973590132063, 5314.096603577363, 5321.600879933982, 5323.840284791462, 22389.0, 22840.543189136126, 22857.0, 25397.0, 26585.73414265852, 2649.4038841260754, 2711.9728802712116, 2713.8643067846724, 2719.415325704983, 2725.68654604721, 10193.592256309812, 10207.0, 10713.928607139302, 13499.66250843727, 14576.271186440636, 1474.0, 1635.1497221444781, 1717.6516434598905, 1826.1599664154505, 1844.8339649431482, 101983.94048178567, 110365.0, 122225.0, 130325.34837325847, 144989.2750536251, 11577.942110289394, 11950.163488555718, 11981.880181198076, 12008.819867701992, 12010.519579216734, 15781.36874525029, 15864.60338491547, 15867.127307998171, 15873.285702143432, 15877.761833572506, 8654.437461564978, 8998.055204203465, 9013.369064165445, 9063.501507417155, 9103.726888193365, 8822.470651760916, 8826.735197944072, 8851.380403371832, 9002.684906028258, 9022.14289642483, 3987.362022076512, 4000.2599519089063, 4811.591014763714, 4850.024368270995, 4901.485344038896, 1668.3910372713872, 2047.9692804607944, 2054.1269960266827, 2059.969100463494, 2061.154926480136, 682.4717586031352, 807.6284908941952, 815.9347252219808, 833.9416240863081, 843.9240468357877, 20930.790692092884, 21002.264920727703, 22065.11739530433, 22081.889590551946, 22174.334769956928, 765.2882818978293, 811.9201462055452, 854.4189950833369, 890.5013192612158, 896.1083721696823, 10921.399323037309, 11320.773584528264, 11364.886351136549, 11387.772244555063, 11430.199886008066, 802399.0, 816357.0, 823269.0, 832656.0, 843696.0, 166079.0, 170034.0, 170819.0, 172507.6873078183, 174744.0, 1009.106940357774, 1046.9895301047045, 1091.252492042953, 1092.4646923007829, 1095.0637205189607, 19378.321758738377, 19712.310069147512, 20078.0, 20145.899270503553, 20184.49538761543, 64195.0, 64268.71462570629, 64391.0, 65157.67421162864, 65510.34489655042, 93746.53126734322, 97185.0, 98341.0, 98770.01229987896, 100043.4993475113, 7422.14645315774, 8148.551829649189, 8316.625751841302, 8811.383203175716, 8911.598978045873, 7431.3683336916965, 10486.318389304672, 11995.340256285988, 13317.467301308227, 13826.723465530431, 11305.15211359135, 11566.016888564567, 11935.224210426295, 11948.402579871146, 12059.03527717798, 10698.62554810578, 10829.458527073457, 11034.944825275823, 11094.0, 11342.092632589538, 11460.598879039193, 11520.769584608428, 11785.764284714429, 12084.39578021113, 12118.75762484763, 7554.395648348229, 7684.0, 7685.346745526693, 7858.921410785819, 8021.157778433414, 8529.189726976176, 10520.842187367043, 11755.647330580096, 12064.733203013557, 12064.819027714766], "value": 10024.642332413741, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.9805452918208, 1458.3510337899631, 1478.970420591589, 1482.2292407947868, 1485.4058376649332, 7456.7762967111075, 8275.255227029566, 8554.631258998554, 8631.784205394853, 8640.74077777667, 7113.502054856162, 7609.315161635452, 7907.604619769003, 7920.9207907921045, 8257.710980115697, 2379.940501487459, 2423.09134074722, 2424.854508729473, 2430.2101816909485, 2430.3195105370523, 2380.6191009438494, 2426.5632186206476, 2429.6841410616685, 2435.537247922889, 2439.865807380593, 2102.568973360457, 2200.570888676709, 2320.791128798408, 2381.345130089222, 2402.027178992511, 2367.633016882386, 2375.8218133639875, 2382.976170238293, 2389.2115601851433, 2389.7012873390827, 2360.055977608953, 2382.7617238276207, 2428.659987601737, 2428.854268743881, 2431.9392015199583, 8535.189157030072, 8594.914050859474, 8602.956985215096, 8617.612207450617, 8624.223819856243, 5169.302144210558, 5318.574514038906, 5328.440513746078, 5328.733563321857, 5339.439358867341, 3365.5456513370627, 3368.8147151906637, 3649.7810131392202, 3653.3789255826573, 3655.2872189922978, 1136.3409222650844, 1241.6895776055985, 1284.0690499387963, 1291.1671971578373, 1307.4312673986847, 10950.39772812495, 10970.451477426097, 10987.175961802817, 10992.230543861933, 10993.61522346714, 3743.644353786386, 4755.762211889391, 4826.276058591239, 4830.903381932412, 4833.758312084382, 9600.855987160197, 9608.711738647851, 9611.375260608178, 9646.372985755903, 9688.176504997155, 5297.099493086184, 5396.0556902542685, 5399.514043736082, 5401.864953376118, 5403.162509810985, 4441.111777644484, 4501.144782491317, 4610.446746390455, 4917.827876024322, 4921.138800709933, 3855.363864962306, 3918.4710064141545, 4025.496812898388, 4030.879073627796, 4069.348904175318, 1279.5073896549895, 1280.8270883430805, 1298.662377750918, 1308.5943357558997, 1311.8360204974379, 925.5696101312788, 932.9813403732023, 950.4059962523423, 959.203860795538, 1002.3484734922358, 4836.322914791932, 5385.7307134643115, 5511.0, 5698.886022279531, 6072.997955337408, 575.815738963536, 580.7938181945433, 591.4351794036685, 598.86525531755, 602.9577929544978, 3742.7567208131386, 3748.606396328401, 3799.601041890617, 3866.729328947003, 3892.9805350973065, 9866.260030497742, 10068.0, 10228.925962773801, 10234.744131396774, 10238.385696858213, 10146.949265253626, 10169.03394177552, 10176.796464070678, 10189.54147063384, 10210.336328138646, 7524.247575242432, 7808.0, 7937.960310198412, 7946.205379462008, 8025.518468891885, 5212.791488340424, 5782.132680098019, 5864.618799778001, 5972.432618901197, 5997.10043493462, 9275.350725449423, 9491.952540237255, 9517.714468565953, 9530.809383812146, 9555.761105972406, 7933.722319718782, 9114.908850911406, 9286.814263714823, 9410.717678469657, 9497.810043798947, 6774.830629234309, 7002.544834585736, 7255.020572222682, 7419.517731347445, 7424.703011879465, 7655.770326890202, 7943.324817390587, 7983.5209887406945, 8120.796980075545, 8221.424500284922, 6985.965070174617, 7093.893591596027, 7111.644417779194, 7135.5361901476235, 7231.457640676865, 6352.396522330371, 6971.163460384786, 6988.40598549129, 6996.580205187705, 7054.08296921397, 6512.283648798533, 6578.572392794453, 6623.602583844792, 6642.169728783902, 6643.2360278568585, 5096.388433388017, 5138.665986710852, 5139.6145289104215, 5154.8969020620125, 5198.4801519849225, 5045.293658887832, 5056.62075344358, 5161.483851614808, 5233.581313494988, 5265.763040663102], "value": 4444.699085665202, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.18241143102324, 379.18853653182197, 383.8656769246876, 392.6426951474159, 397.67192066545107, 5248.737563121843, 5308.946910530898, 5358.839234822952, 5377.580088959969, 5380.435054319299, 4741.502142275054, 4965.404151501825, 5091.338126043609, 5136.229565565167, 5197.66215196012, 4070.903484705379, 4115.8971025724295, 4141.151064031881, 4151.501819781615, 4176.728512646683, 3428.8971330860113, 4081.8775436736796, 4178.498580170384, 4190.7485550866895, 4208.663306935453, 3288.3752087103494, 3971.344728119857, 4144.896377590554, 4150.501939767232, 4157.334826427772, 3732.5147730795093, 3988.1624858779546, 4107.137501124767, 4116.341385378325, 4120.876373708794, 3647.598764135943, 3657.085728567858, 3665.9450108248398, 3671.5777685566236, 3681.5214022177215, 4796.973443742179, 4860.031687166703, 4956.3804524434445, 5159.25190847325, 5195.636305458619, 4250.469830860888, 4370.8033138508845, 4767.451743049559, 4790.592799612037, 4795.088933102699, 5622.550195984352, 5624.29696287964, 5625.1843482695185, 5652.74562644682, 5656.490915817596, 3848.230353929225, 4068.044009657728, 4073.97963010186, 4099.938500922489, 4105.2494828464705, 5165.483451654842, 5311.194193974067, 5750.79872204475, 5791.276090488689, 5857.589968702193, 4133.8966525837095, 4149.672104926394, 4155.958440415558, 4186.874393768192, 4187.895302617398, 3565.625609310985, 4229.703920725519, 4259.0621267323295, 4270.7010509264055, 4288.935665965013, 3854.5759966403675, 4538.155414368495, 4681.555252251031, 4729.287509305248, 4753.738544380023, 5151.459096794858, 5567.9142567199815, 5570.164475328733, 5607.691576963306, 5615.1470014894985, 1276.3363051213316, 1315.6184706435026, 1343.7849944008913, 1354.1265883505282, 1382.9696875827372, 923.132255679659, 932.9690691785615, 964.81668482988, 984.8621193032981, 989.1542730965065, 4406.713563618355, 4517.864464066083, 4608.976955115203, 4808.1820996593815, 4894.216925291937, 5349.0, 5429.267048948342, 5431.619786614978, 5437.945620543744, 5467.6719396836315, 3765.3222419964122, 4144.48193975753, 4591.977040114778, 4630.0, 4863.80544778212, 2478.5414698280874, 2820.3513191965963, 2845.39646223703, 2849.6295481587676, 2852.8288302701903, 4838.903221935541, 5060.671056381323, 5346.97326513365, 5396.865078373072, 5586.91619625706, 4905.087016063738, 5450.29146210998, 5631.915521267102, 5663.998081017067, 5668.489835914787, 4819.638527110411, 4892.804287828518, 5440.7551660174595, 5644.0, 5678.082123334886, 5022.347094877642, 5289.867753306198, 5309.681419114865, 5377.623566350318, 5383.973080134574, 4821.807127714992, 5124.104081489872, 5205.58355331565, 5421.132618780976, 5435.293411856592, 5553.888922221614, 5680.261565996394, 5680.693440508623, 5694.829155125353, 5704.486596206361, 3409.573803274591, 3496.9542817452075, 3708.9629103708617, 3775.754575952554, 3844.519435070616, 5196.246544251138, 5352.357717073976, 5354.223637572608, 5406.324209473816, 5416.106342453609, 4659.324397962344, 5181.844544663666, 5239.685618862881, 5274.7890084396195, 5278.551323137576, 4329.631981281626, 4477.798499067485, 4796.040791841576, 4987.80048798044, 5226.451222621722, 4917.582005529427, 5078.873028174326, 5105.617078719037, 5106.617003724809, 5216.869578260574, 4935.580475659609, 5059.139946209079, 5155.484451554815, 5267.73661316925, 5595.412481689364, 4820.228763397839, 5000.5999520037585, 5459.235707001102, 5477.698726569917, 5481.232627432242], "value": 4052.975784695269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3549466743261, 748.2218492767522, 766.7891329884282, 777.0675189772271, 880.4497189256715, 13295.601131966032, 15308.617284567878, 15616.453424130157, 15800.288986995583, 15863.920680396597, 14323.283835808194, 14359.856401435982, 14366.569002929902, 14418.134911905267, 14427.422903083863, 736.2196072163497, 759.388692102857, 762.2491845532146, 762.572959142879, 915.6108653822132, 765.490948519234, 765.689895592286, 893.865920111982, 923.5474617437475, 935.948522831244, 865.5109862927458, 991.5092029445435, 993.0417147452707, 997.997013001932, 1001.9729776978619, 988.7033889833057, 990.7325022244025, 996.9551370188359, 997.6657819630433, 1000.4947501511763, 750.1523278695095, 751.5528260684938, 751.9285667861544, 752.3943225703307, 752.7892190186757, 15375.231238438146, 15508.92245538765, 15757.763633545506, 15818.209089545591, 15869.682606347924, 14804.777928331083, 15045.247737613076, 15156.772648410282, 15359.001664891857, 15369.154696491689, 11708.414579271002, 11753.529858805638, 11844.703882402922, 11907.404629768476, 12139.575114870937, 3893.377059670439, 3898.7075969302414, 3955.805071647231, 3995.580464051262, 4038.2932986727205, 94593.0, 95800.52099739526, 101798.4910075445, 109198.0, 110635.0, 11192.888071119185, 11494.597689080842, 11620.244684095507, 11649.47577359021, 11658.125640576991, 22991.655125173136, 23093.0, 23389.181378651665, 23484.765152348256, 23494.530109397718, 7792.259735325135, 7893.526388416713, 7966.0, 8064.919350806535, 8138.267555919877, 3809.3143234218105, 4432.889177770581, 4465.977670111693, 4480.215962206601, 4540.704854184468, 3644.344018076719, 3666.816659167031, 3694.2980833641523, 3708.35103856824, 3733.1040550268285, 675.7398401615316, 683.1665368250726, 685.5817951049855, 690.8963655451622, 693.6774399903968, 663.2240278873729, 669.6015870557011, 677.2313424263497, 679.2629996453804, 698.3435570563654, 10389.156012275507, 10871.945640271748, 11281.32312061279, 11366.829497557543, 11518.84761576528, 595.7140572525212, 631.3370960491466, 632.8386261503288, 663.3318295167803, 727.5485406613734, 4397.912041759147, 5029.170186919117, 5253.4221235664045, 5264.815731449381, 5290.9735451322495, 96963.0, 98642.0, 99134.50432747934, 100030.4998475003, 102162.0, 69833.3016669837, 88353.67469487964, 88654.0, 90090.0, 90956.0, 58742.82514349689, 78851.81722274056, 79302.99999999885, 79665.60167199127, 79885.0, 10906.72733181645, 11180.832287515856, 11543.0, 11553.537858485903, 11585.594504192313, 39742.0, 43321.78339108284, 47547.0, 49992.0, 52510.0, 60542.0, 63757.362426376996, 70515.0, 70809.0, 73309.0, 13097.607071787861, 13255.80116298237, 13312.934965202567, 13397.464101436224, 13780.173189608655, 14778.63053423673, 15045.398184072514, 15104.0, 15277.6180595486, 15840.76238856395, 13453.394597242952, 13639.977001725108, 14138.293085345485, 14173.858261417254, 14190.645233869236, 9273.629054838, 13134.671633209246, 13965.511207107702, 13992.370343334778, 14217.009618653603, 10883.945580272048, 13254.469821207043, 13524.0, 14007.579772606838, 14220.0, 9812.607495700378, 10251.38491690501, 10355.94822025885, 10390.0, 10501.369917804956, 9772.706818795448, 9887.604495820087, 11171.832422513506, 11430.942845285721, 11467.541298347973], "value": 7658.201941944971, "unit": "score"}], "name": "dromaeo_css", "value": 7401.526600013337, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 106.0, 143.0, 107.0, 129.0, 144.0, 119.0, 125.0, 106.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 184.0, 247.0, 198.0, 182.0, 181.0, 183.0, 181.0], "value": 190.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 58.0, 84.0, 61.0, 59.0, 55.0, 58.0, 70.0, 57.0], "value": 64.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 85.0, 70.0, 68.0, 68.0, 80.0, 67.0, 69.0, 80.0], "value": 74.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 131.0, 107.0, 83.0, 86.0, 83.0, 87.0, 84.0, 86.0, 83.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 95.0, 93.0, 113.0, 137.0, 95.0, 93.0, 92.0], "value": 99.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 84.0, 88.0, 85.0, 87.0, 84.0, 81.0, 84.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 51.0, 54.0, 56.0, 54.0, 56.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 75.0, 69.0, 72.0, 72.0, 67.0, 66.0, 73.0, 99.0, 101.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 81.0, 81.0, 86.0, 86.0, 88.0, 117.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 131.0, 132.0, 117.0, 133.0, 145.0, 140.0, 170.0, 132.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 62.0, 64.0, 63.0, 65.0, 63.0, 63.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1421.0, "alertThreshold": 2.0}]} 14:29:42 INFO - Return code: 0 14:29:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:42 INFO - # TBPL SUCCESS # 14:29:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:29:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:29:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:29:42 INFO - 2017-03-30 14:29:42.527 screenresolution[1661:9904] starting screenresolution argv=screenresolution get 14:29:42 INFO - 2017-03-30 14:29:42.530 screenresolution[1661:9904] Display 0: 1600x1200x32@60 14:29:42 INFO - 2017-03-30 14:29:42.536 screenresolution[1662:9908] starting screenresolution argv=screenresolution list 14:29:42 INFO - Available Modes on Display 0 14:29:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:29:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:29:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:29:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:29:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:29:42 INFO - Intel Iris: 14:29:42 INFO - Chipset Model: Intel Iris 14:29:42 INFO - Type: GPU 14:29:42 INFO - Bus: Built-In 14:29:42 INFO - VRAM (Dynamic, Max): 1536 MB 14:29:42 INFO - Vendor: Intel (0x8086) 14:29:42 INFO - Device ID: 0x0a2e 14:29:42 INFO - Revision ID: 0x0009 14:29:42 INFO - Displays: 14:29:42 INFO - Display: 14:29:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:29:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:29:42 INFO - Display Serial Number: 1600x1200 60 14:29:42 INFO - Main Display: Yes 14:29:42 INFO - Mirror: Off 14:29:42 INFO - Online: Yes 14:29:42 INFO - Rotation: Supported 14:29:42 INFO - Return code: 0 14:29:42 INFO - Running post-action listener: _resource_record_post_action 14:29:42 INFO - [mozharness: 2017-03-30 21:29:42.769810Z] Finished run-tests step (success) 14:29:42 INFO - Running post-run listener: _resource_record_post_run 14:29:42 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38212608; Write bytes: 419374592; Read time: 241; Write time: 1368 14:29:42 INFO - TinderboxPrint: CPU usage
53.9% 14:29:42 INFO - TinderboxPrint: I/O read bytes / time
38,212,608 / 241 14:29:42 INFO - TinderboxPrint: I/O write bytes / time
419,374,592 / 1,368 14:29:42 INFO - TinderboxPrint: CPU idle
2,192.8 (46.1%) 14:29:42 INFO - TinderboxPrint: CPU system
955.1 (20.1%) 14:29:42 INFO - TinderboxPrint: CPU user
1,613.8 (33.9%) 14:29:42 INFO - TinderboxPrint: Swap in / out
160,120,832 / 0 14:29:42 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122812928; Write bytes: 122552320; Read time: 11227; Write time: 276 14:29:42 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34411520; Write bytes: 295437824; Read time: 218; Write time: 1086 14:29:43 INFO - Running post-run listener: _upload_blobber_files 14:29:43 INFO - Blob upload gear active. 14:29:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:43 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 14:29:43 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:29:43 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:45 INFO - (blobuploader) - INFO - Done attempting. 14:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:29:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:46 INFO - (blobuploader) - INFO - Done attempting. 14:29:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:29:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:29:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:47 INFO - (blobuploader) - INFO - Done attempting. 14:29:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:49 INFO - (blobuploader) - INFO - Done attempting. 14:29:49 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:49 INFO - Return code: 0 14:29:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4ac05d37f8fd3d1b9cedc097f209448642afe1a7dd6d70ede9fca6c65d0ffc17652749caa4b1d2583491ebc5eecdcec7d4a09a198e0b1c9f30a1e806a518505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f819aa72334d1616fb9b6dfb6f4d71528adf912fb7677e23e6cc13a9e2dba7f517bbeda9acc5db72408e8d8e22f57c4b521acce5febc9a7d075ea1cff43ae269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a2cc55b7362a6ad35aea3cff3214c8ae0340aa92cda3b7c0cdd9b950e7f1f67b8ce58f20eb055d1f95a8965676444bdc6a11129e1b5a28f0420b391130a0d2b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b5601e978de3c47f79825c7f0f5ab0b8c22f37bde2fc27abaec0deeed8a0073a5ce9bbf3e7b59d39464715792a4759d7d375654c3d4bdf13f1c5bd0526fda36"} 14:29:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:49 INFO - Contents: 14:29:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4ac05d37f8fd3d1b9cedc097f209448642afe1a7dd6d70ede9fca6c65d0ffc17652749caa4b1d2583491ebc5eecdcec7d4a09a198e0b1c9f30a1e806a518505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f819aa72334d1616fb9b6dfb6f4d71528adf912fb7677e23e6cc13a9e2dba7f517bbeda9acc5db72408e8d8e22f57c4b521acce5febc9a7d075ea1cff43ae269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a2cc55b7362a6ad35aea3cff3214c8ae0340aa92cda3b7c0cdd9b950e7f1f67b8ce58f20eb055d1f95a8965676444bdc6a11129e1b5a28f0420b391130a0d2b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b5601e978de3c47f79825c7f0f5ab0b8c22f37bde2fc27abaec0deeed8a0073a5ce9bbf3e7b59d39464715792a4759d7d375654c3d4bdf13f1c5bd0526fda36"} 14:29:49 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:49 INFO - Copying logs to upload dir... 14:29:49 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.030047 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-30 14:29:49.427550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 14:29:49.431557) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XigHlFHJuk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4ac05d37f8fd3d1b9cedc097f209448642afe1a7dd6d70ede9fca6c65d0ffc17652749caa4b1d2583491ebc5eecdcec7d4a09a198e0b1c9f30a1e806a518505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f819aa72334d1616fb9b6dfb6f4d71528adf912fb7677e23e6cc13a9e2dba7f517bbeda9acc5db72408e8d8e22f57c4b521acce5febc9a7d075ea1cff43ae269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a2cc55b7362a6ad35aea3cff3214c8ae0340aa92cda3b7c0cdd9b950e7f1f67b8ce58f20eb055d1f95a8965676444bdc6a11129e1b5a28f0420b391130a0d2b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b5601e978de3c47f79825c7f0f5ab0b8c22f37bde2fc27abaec0deeed8a0073a5ce9bbf3e7b59d39464715792a4759d7d375654c3d4bdf13f1c5bd0526fda36"} build_url:https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010801 build_url: 'https://queue.taskcluster.net/v1/task/MGXW8r5bSNu7I7p_gcE95g/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4ac05d37f8fd3d1b9cedc097f209448642afe1a7dd6d70ede9fca6c65d0ffc17652749caa4b1d2583491ebc5eecdcec7d4a09a198e0b1c9f30a1e806a518505", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f819aa72334d1616fb9b6dfb6f4d71528adf912fb7677e23e6cc13a9e2dba7f517bbeda9acc5db72408e8d8e22f57c4b521acce5febc9a7d075ea1cff43ae269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a2cc55b7362a6ad35aea3cff3214c8ae0340aa92cda3b7c0cdd9b950e7f1f67b8ce58f20eb055d1f95a8965676444bdc6a11129e1b5a28f0420b391130a0d2b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b5601e978de3c47f79825c7f0f5ab0b8c22f37bde2fc27abaec0deeed8a0073a5ce9bbf3e7b59d39464715792a4759d7d375654c3d4bdf13f1c5bd0526fda36"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 14:29:49.465573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:29:49.465901) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XigHlFHJuk/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hNVKHn8nLh/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005017 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 14:29:49.514051) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 14:29:49.514381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 14:29:49.514710) ========= ========= Total master_lag: 0.17 =========