builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1493224719.07 results: success (0) buildid: 20170426085225 builduid: d0fc854080904465ac1044a1be614112 revision: 70012c15c9428d2c8186befaa8da038dd28257ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.069988) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.070543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.070880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.097811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.098286) ========= 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.IyVCL1kBDK/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.hGM2svmm3m/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-04-26 09:38:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2017-04-26 09:38:39 (13.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144805 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.268268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.268641) ========= 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.IyVCL1kBDK/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.hGM2svmm3m/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.020961 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.316698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:39.317125) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 70012c15c9428d2c8186befaa8da038dd28257ee --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 70012c15c9428d2c8186befaa8da038dd28257ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IyVCL1kBDK/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.hGM2svmm3m/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-04-26 09:38:39,402 truncating revision to first 12 chars 2017-04-26 09:38:39,402 Setting DEBUG logging. 2017-04-26 09:38:39,402 attempt 1/10 2017-04-26 09:38:39,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/70012c15c942?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 09:38:40,066 unpacking tar archive at: mozilla-beta-70012c15c942/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914605 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:40.259979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:40.260736) ========= script_repo_revision: 70012c15c9428d2c8186befaa8da038dd28257ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:40.261610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:40.262172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 09:38:40.285487) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-26 09:38:40.286194) ========= /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.IyVCL1kBDK/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.hGM2svmm3m/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:38:40 INFO - MultiFileLogger online at 20170426 09:38:40 in /builds/slave/test 09:38:40 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 09:38:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:40 INFO - {'append_to_log': False, 09:38:40 INFO - 'base_work_dir': '/builds/slave/test', 09:38:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:38:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:40 INFO - 'branch': 'Mozilla-Beta', 09:38:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:40 INFO - 'config_files': ('talos/mac_config.py',), 09:38:40 INFO - 'default_actions': ('clobber', 09:38:40 INFO - 'read-buildbot-config', 09:38:40 INFO - 'download-and-extract', 09:38:40 INFO - 'populate-webroot', 09:38:40 INFO - 'create-virtualenv', 09:38:40 INFO - 'install', 09:38:40 INFO - 'run-tests'), 09:38:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:40 INFO - 'download_minidump_stackwalk': True, 09:38:40 INFO - 'download_symbols': 'ondemand', 09:38:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:40 INFO - 'gecko_profile': False, 09:38:40 INFO - 'gecko_profile_interval': 0, 09:38:40 INFO - 'installer_path': 'installer.exe', 09:38:40 INFO - 'log_level': 'info', 09:38:40 INFO - 'log_name': 'talos', 09:38:40 INFO - 'log_to_console': True, 09:38:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:38:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:38:40 INFO - 'opt_config_files': (), 09:38:40 INFO - 'pip_index': False, 09:38:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:40 INFO - 'cmd': ('bash', 09:38:40 INFO - '-c', 09:38:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:40 INFO - 'enabled': True, 09:38:40 INFO - 'halt_on_failure': False, 09:38:40 INFO - 'name': 'check_screen_resolution'},), 09:38:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:40 INFO - 'cmd': ('bash', 09:38:40 INFO - '-c', 09:38:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:40 INFO - 'enabled': True, 09:38:40 INFO - 'halt_on_failure': False, 09:38:40 INFO - 'name': 'check_screen_resolution'},), 09:38:40 INFO - 'run_cmd_checks_enabled': True, 09:38:40 INFO - 'suite': 'dromaeojs', 09:38:40 INFO - 'system_bits': '32', 09:38:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:40 INFO - 'title': 't-yosemite-r7-0112', 09:38:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:40 INFO - 'use_talos_json': True, 09:38:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:40 INFO - 'work_dir': 'build'} 09:38:40 INFO - [mozharness: 2017-04-26 16:38:40.500780Z] Running clobber step. 09:38:40 INFO - Running pre-action listener: _resource_record_pre_action 09:38:40 INFO - Running main action method: clobber 09:38:40 INFO - rmtree: /builds/slave/test/build 09:38:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:42 INFO - Running post-action listener: _resource_record_post_action 09:38:42 INFO - [mozharness: 2017-04-26 16:38:42.392930Z] Finished clobber step (success) 09:38:42 INFO - [mozharness: 2017-04-26 16:38:42.393109Z] Running read-buildbot-config step. 09:38:42 INFO - Running pre-action listener: _resource_record_pre_action 09:38:42 INFO - Running main action method: read_buildbot_config 09:38:42 INFO - Using buildbot properties: 09:38:42 INFO - { 09:38:42 INFO - "project": "", 09:38:42 INFO - "product": "firefox", 09:38:42 INFO - "script_repo_revision": "production", 09:38:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:38:42 INFO - "repository": "", 09:38:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:38:42 INFO - "buildid": "20170426085225", 09:38:42 INFO - "pgo_build": "False", 09:38:42 INFO - "basedir": "/builds/slave/test", 09:38:42 INFO - "buildnumber": 15, 09:38:42 INFO - "slavename": "t-yosemite-r7-0112", 09:38:42 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:38:42 INFO - "platform": "yosemite_r7", 09:38:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:38:42 INFO - "branch": "mozilla-beta", 09:38:42 INFO - "repo_path": "releases/mozilla-beta", 09:38:42 INFO - "revision": "70012c15c9428d2c8186befaa8da038dd28257ee", 09:38:42 INFO - "stage_platform": "macosx64", 09:38:42 INFO - "builduid": "d0fc854080904465ac1044a1be614112", 09:38:42 INFO - "slavebuilddir": "test" 09:38:42 INFO - } 09:38:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 09:38:42 INFO - Running post-action listener: _resource_record_post_action 09:38:42 INFO - [mozharness: 2017-04-26 16:38:42.396460Z] Finished read-buildbot-config step (success) 09:38:42 INFO - [mozharness: 2017-04-26 16:38:42.396598Z] Running download-and-extract step. 09:38:42 INFO - Running pre-action listener: _resource_record_pre_action 09:38:42 INFO - Running main action method: download_and_extract 09:38:42 INFO - mkdir: /builds/slave/test/build/tests 09:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:42 INFO - trying https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 09:38:42 INFO - Downloading https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 09:38:43 INFO - Downloaded 1165 bytes. 09:38:43 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:38:43 INFO - Using the following test package requirements: 09:38:43 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:38:43 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:38:43 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 09:38:43 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:38:43 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 09:38:43 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:38:43 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:38:43 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 09:38:43 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:38:43 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:38:43 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 09:38:43 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:38:43 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 09:38:43 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:38:43 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 09:38:43 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:38:43 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 09:38:43 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 09:38:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:38:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:38:43 INFO - Fetch https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:38:45 INFO - Expected file size: 51221728 09:38:45 INFO - Obtained file size: 51221728 09:39:02 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:39:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:39:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:39:02 INFO - Fetch https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:39:03 INFO - Expected file size: 51221728 09:39:03 INFO - Obtained file size: 51221728 09:39:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 09:39:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 09:39:19 INFO - Fetch https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 09:39:20 INFO - Expected file size: 14404449 09:39:20 INFO - Obtained file size: 14404449 09:39:20 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')]} 09:39:20 INFO - trying https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:39:20 INFO - Downloading https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 09:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 09:39:22 INFO - Downloaded 59541352 bytes. 09:39:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:39:22 INFO - mkdir: /builds/slave/test/properties 09:39:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:22 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:22 INFO - Contents: 09:39:22 INFO - build_url:https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:39:22 INFO - Running post-action listener: _resource_record_post_action 09:39:22 INFO - Running post-action listener: set_extra_try_arguments 09:39:22 INFO - [mozharness: 2017-04-26 16:39:22.993701Z] Finished download-and-extract step (success) 09:39:22 INFO - [mozharness: 2017-04-26 16:39:22.993820Z] Running populate-webroot step. 09:39:22 INFO - Running pre-action listener: _resource_record_pre_action 09:39:22 INFO - Running main action method: populate_webroot 09:39:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:23 INFO - '--tppagecycles', 09:39:23 INFO - '7'], 09:39:23 INFO - 'tests': ['tsvgm']}}, 09:39:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:39:23 INFO - 'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:39:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:39:23 INFO - 'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['damp', 'tps']}, 09:39:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:39:23 INFO - 'tests': ['damp', 'tps']}, 09:39:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['dromaeo_dom']}, 09:39:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['basic_compositor_video']}, 09:39:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:39:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['a11yr', 09:39:23 INFO - 'ts_paint', 09:39:23 INFO - 'tpaint', 09:39:23 INFO - 'sessionrestore', 09:39:23 INFO - 'sessionrestore_no_auto_restore', 09:39:23 INFO - 'tabpaint']}, 09:39:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:23 INFO - 'ts_paint', 09:39:23 INFO - 'tpaint', 09:39:23 INFO - 'sessionrestore', 09:39:23 INFO - 'sessionrestore_no_auto_restore', 09:39:23 INFO - 'tabpaint']}, 09:39:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:39:23 INFO - 'ts_paint', 09:39:23 INFO - 'tpaint', 09:39:23 INFO - 'sessionrestore', 09:39:23 INFO - 'sessionrestore_no_auto_restore', 09:39:23 INFO - 'tabpaint']}, 09:39:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:39:23 INFO - 'ts_paint', 09:39:23 INFO - 'tpaint', 09:39:23 INFO - 'sessionrestore', 09:39:23 INFO - 'sessionrestore_no_auto_restore', 09:39:23 INFO - 'tabpaint']}, 09:39:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['a11yr', 09:39:23 INFO - 'ts_paint', 09:39:23 INFO - 'tpaint', 09:39:23 INFO - 'sessionrestore', 09:39:23 INFO - 'sessionrestore_no_auto_restore', 09:39:23 INFO - 'tabpaint']}, 09:39:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['a11yr', 09:39:23 INFO - 'ts_paint', 09:39:23 INFO - 'tpaint', 09:39:23 INFO - 'sessionrestore', 09:39:23 INFO - 'sessionrestore_no_auto_restore', 09:39:23 INFO - 'tabpaint']}, 09:39:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['tsvgx', 09:39:23 INFO - 'tsvgr_opacity', 09:39:23 INFO - 'tart', 09:39:23 INFO - 'tscrollx', 09:39:23 INFO - 'cart', 09:39:23 INFO - 'tsvg_static']}, 09:39:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:23 INFO - 'tsvgr_opacity', 09:39:23 INFO - 'tart', 09:39:23 INFO - 'tscrollx', 09:39:23 INFO - 'cart', 09:39:23 INFO - 'tsvg_static']}, 09:39:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:39:23 INFO - 'talos_options': ['--disable-e10s'], 09:39:23 INFO - 'tests': ['tp5o']}, 09:39:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:39:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:39:23 INFO - 'talos_options': ['--disable-e10s', 09:39:23 INFO - '--xperf_path', 09:39:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:23 INFO - 'tests': ['tp5n']}, 09:39:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:39:23 INFO - 'talos_options': ['--xperf_path', 09:39:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:23 INFO - 'tests': ['tp5n']}}, 09:39:23 INFO - 'talos.zip': {'path': '', 09:39:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:23 INFO - Running post-action listener: _resource_record_post_action 09:39:23 INFO - [mozharness: 2017-04-26 16:39:23.012225Z] Finished populate-webroot step (success) 09:39:23 INFO - [mozharness: 2017-04-26 16:39:23.012366Z] Running create-virtualenv step. 09:39:23 INFO - Running pre-action listener: _resource_record_pre_action 09:39:23 INFO - Running main action method: create_virtualenv 09:39:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:23 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 09:39:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:23 INFO - Using real prefix '/tools/python27' 09:39:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:26 INFO - Installing pip.................done. 09:39:26 INFO - Return code: 0 09:39:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:39:27 INFO - Reading from file tmpfile_stdout 09:39:27 INFO - Output received: 09:39:27 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) 09:39:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:27 INFO - 'HOME': '/Users/cltbld', 09:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:27 INFO - 'LOGNAME': 'cltbld', 09:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:27 INFO - 'MOZ_NO_REMOTE': '1', 09:39:27 INFO - 'NO_EM_RESTART': '1', 09:39:27 INFO - 'PAGER': '/bin/cat', 09:39:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:27 INFO - 'PWD': '/builds/slave/test', 09:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:27 INFO - 'SHELL': '/bin/bash', 09:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:27 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:27 INFO - 'USER': 'cltbld', 09:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:27 INFO - 'XPC_FLAGS': '0x0', 09:39:27 INFO - 'XPC_SERVICE_NAME': '0', 09:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:27 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 09:39:27 INFO - Cleaning up... 09:39:27 INFO - Return code: 0 09:39:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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', '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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:39: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 psutil>=3.1.1 09:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:27 INFO - 'HOME': '/Users/cltbld', 09:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:27 INFO - 'LOGNAME': 'cltbld', 09:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:27 INFO - 'MOZ_NO_REMOTE': '1', 09:39:27 INFO - 'NO_EM_RESTART': '1', 09:39:27 INFO - 'PAGER': '/bin/cat', 09:39:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:27 INFO - 'PWD': '/builds/slave/test', 09:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:27 INFO - 'SHELL': '/bin/bash', 09:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:27 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:27 INFO - 'USER': 'cltbld', 09:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:27 INFO - 'XPC_FLAGS': '0x0', 09:39:27 INFO - 'XPC_SERVICE_NAME': '0', 09:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:27 INFO - Downloading/unpacking psutil>=3.1.1 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:31 INFO - Installing collected packages: psutil 09:39:31 INFO - Running setup.py install for psutil 09:39:31 INFO - building 'psutil._psutil_osx' extension 09:39:31 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 09:39:31 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 09:39:31 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 09:39:31 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 09:39:31 INFO - building 'psutil._psutil_posix' extension 09:39:31 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 09:39:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:39:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:39:31 INFO - ^ 09:39:31 INFO - 1 warning generated. 09:39:31 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 09:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:32 INFO - Successfully installed psutil 09:39:32 INFO - Cleaning up... 09:39:32 INFO - Return code: 0 09:39:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:32 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')]} 09:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:32 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')]} 09:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:32 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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:32 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 09:39:32 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 09:39:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:32 INFO - 'HOME': '/Users/cltbld', 09:39:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:32 INFO - 'LOGNAME': 'cltbld', 09:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:32 INFO - 'MOZ_NO_REMOTE': '1', 09:39:32 INFO - 'NO_EM_RESTART': '1', 09:39:32 INFO - 'PAGER': '/bin/cat', 09:39:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:32 INFO - 'PWD': '/builds/slave/test', 09:39:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:32 INFO - 'SHELL': '/bin/bash', 09:39:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:32 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:32 INFO - 'USER': 'cltbld', 09:39:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:32 INFO - 'XPC_FLAGS': '0x0', 09:39:32 INFO - 'XPC_SERVICE_NAME': '0', 09:39:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:36 INFO - Installing collected packages: mozsystemmonitor 09:39:36 INFO - Running setup.py install for mozsystemmonitor 09:39:36 INFO - Successfully installed mozsystemmonitor 09:39:36 INFO - Cleaning up... 09:39:36 INFO - Return code: 0 09:39:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:36 INFO - 'HOME': '/Users/cltbld', 09:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:36 INFO - 'LOGNAME': 'cltbld', 09:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:36 INFO - 'MOZ_NO_REMOTE': '1', 09:39:36 INFO - 'NO_EM_RESTART': '1', 09:39:36 INFO - 'PAGER': '/bin/cat', 09:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:36 INFO - 'PWD': '/builds/slave/test', 09:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:36 INFO - 'SHELL': '/bin/bash', 09:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:36 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:36 INFO - 'USER': 'cltbld', 09:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:36 INFO - 'XPC_FLAGS': '0x0', 09:39:36 INFO - 'XPC_SERVICE_NAME': '0', 09:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:37 INFO - Downloading/unpacking jsonschema==2.5.1 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:39 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 09:39:39 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 09:39:39 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 09:39:39 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 09:39:39 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 09:39:39 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 09:39:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:40 INFO - warning: no files found matching '*.txt' 09:39:40 INFO - no previously-included directories found matching 'build' 09:39:40 INFO - no previously-included directories found matching 'dist' 09:39:40 INFO - no previously-included directories found matching '.git*' 09:39:40 INFO - Installing collected packages: jsonschema, functools32 09:39:40 INFO - Running setup.py install for functools32 09:39:40 INFO - warning: no files found matching '*.txt' 09:39:40 INFO - no previously-included directories found matching 'build' 09:39:40 INFO - no previously-included directories found matching 'dist' 09:39:40 INFO - no previously-included directories found matching '.git*' 09:39:40 INFO - Successfully installed jsonschema functools32 09:39:40 INFO - Cleaning up... 09:39:40 INFO - Return code: 0 09:39:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:40 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')]} 09:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:40 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')]} 09:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:40 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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:40 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 09:39:40 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 09:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:40 INFO - 'HOME': '/Users/cltbld', 09:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:40 INFO - 'LOGNAME': 'cltbld', 09:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:40 INFO - 'MOZ_NO_REMOTE': '1', 09:39:40 INFO - 'NO_EM_RESTART': '1', 09:39:40 INFO - 'PAGER': '/bin/cat', 09:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:40 INFO - 'PWD': '/builds/slave/test', 09:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:40 INFO - 'SHELL': '/bin/bash', 09:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:40 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:40 INFO - 'USER': 'cltbld', 09:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:40 INFO - 'XPC_FLAGS': '0x0', 09:39:40 INFO - 'XPC_SERVICE_NAME': '0', 09:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:40 INFO - Cleaning up... 09:39:40 INFO - Return code: 0 09:39:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:40 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')]} 09:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:40 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')]} 09:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:40 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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:40 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 09:39:40 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 09:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:40 INFO - 'HOME': '/Users/cltbld', 09:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:40 INFO - 'LOGNAME': 'cltbld', 09:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:40 INFO - 'MOZ_NO_REMOTE': '1', 09:39:40 INFO - 'NO_EM_RESTART': '1', 09:39:40 INFO - 'PAGER': '/bin/cat', 09:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:40 INFO - 'PWD': '/builds/slave/test', 09:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:40 INFO - 'SHELL': '/bin/bash', 09:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:40 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:40 INFO - 'USER': 'cltbld', 09:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:40 INFO - 'XPC_FLAGS': '0x0', 09:39:40 INFO - 'XPC_SERVICE_NAME': '0', 09:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:41 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:41 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 09:39:41 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 09:39:41 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 09:39:41 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 09:39:41 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 09:39:41 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 09:39:43 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:43 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 09:39:43 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 09:39:43 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 09:39:43 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 09:39:43 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 09:39:43 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 09:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:45 INFO - Downloading docopt-0.6.1.tar.gz 09:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:45 INFO - Running setup.py install for blobuploader 09:39:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:45 INFO - Running setup.py install for requests 09:39:45 INFO - Running setup.py install for docopt 09:39:45 INFO - Successfully installed blobuploader requests docopt 09:39:45 INFO - Cleaning up... 09:39:46 INFO - Return code: 0 09:39:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:46 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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:46 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 09:39:46 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 09:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:46 INFO - 'HOME': '/Users/cltbld', 09:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:46 INFO - 'LOGNAME': 'cltbld', 09:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:46 INFO - 'MOZ_NO_REMOTE': '1', 09:39:46 INFO - 'NO_EM_RESTART': '1', 09:39:46 INFO - 'PAGER': '/bin/cat', 09:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:46 INFO - 'PWD': '/builds/slave/test', 09:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:46 INFO - 'SHELL': '/bin/bash', 09:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:46 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:46 INFO - 'USER': 'cltbld', 09:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:46 INFO - 'XPC_FLAGS': '0x0', 09:39:46 INFO - 'XPC_SERVICE_NAME': '0', 09:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-yVSDGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-WsPrDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5FB6rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pZ85pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Y0buiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-evijTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-c3crdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9hcvt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ahbXPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-US8peS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-bNcuJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hULVgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dG8K3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dfHHhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BcS7vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Nu3bCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qi0BXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:48 INFO - Running setup.py install for manifestparser 09:39:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:48 INFO - Running setup.py install for mozcrash 09:39:48 INFO - Running setup.py install for mozdebug 09:39:48 INFO - Running setup.py install for mozdevice 09:39:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:48 INFO - Running setup.py install for mozfile 09:39:48 INFO - Running setup.py install for mozhttpd 09:39:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:48 INFO - Running setup.py install for mozinfo 09:39:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Running setup.py install for mozInstall 09:39:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Running setup.py install for mozleak 09:39:49 INFO - Running setup.py install for mozlog 09:39:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Running setup.py install for moznetwork 09:39:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:49 INFO - Running setup.py install for mozprocess 09:39:49 INFO - Running setup.py install for mozprofile 09:39:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:50 INFO - Running setup.py install for mozrunner 09:39:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:50 INFO - Running setup.py install for mozscreenshot 09:39:50 INFO - Running setup.py install for moztest 09:39:50 INFO - Running setup.py install for mozversion 09:39:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:50 INFO - Cleaning up... 09:39:50 INFO - Return code: 0 09:39:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:50 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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:50 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 09:39:50 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 09:39:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:50 INFO - 'HOME': '/Users/cltbld', 09:39:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:50 INFO - 'LOGNAME': 'cltbld', 09:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:50 INFO - 'MOZ_NO_REMOTE': '1', 09:39:50 INFO - 'NO_EM_RESTART': '1', 09:39:50 INFO - 'PAGER': '/bin/cat', 09:39:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:50 INFO - 'PWD': '/builds/slave/test', 09:39:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:50 INFO - 'SHELL': '/bin/bash', 09:39:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:50 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:50 INFO - 'USER': 'cltbld', 09:39:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:50 INFO - 'XPC_FLAGS': '0x0', 09:39:50 INFO - 'XPC_SERVICE_NAME': '0', 09:39:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-e39PV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-QbvNMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5b4cHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-kRzCkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PrMZHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-EWGVg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-lFSeYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NVVypH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PmTjWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:51 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)) 09:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-s5pVoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:52 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)) 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-muIDha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:52 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)) 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-mFYl3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-24O_Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:52 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)) 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ozu1lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:52 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)) 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-u0bIDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:52 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)) 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pPnFt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:52 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)) 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-49DbRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:52 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)) 09:39:52 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)) 09:39:52 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)) 09:39:52 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)) 09:39:52 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)) 09:39:52 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)) 09:39:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:52 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 09:39:52 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 09:39:52 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 09:39:52 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 09:39:52 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 09:39:52 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 09:39:55 INFO - Downloading blessings-1.6.tar.gz 09:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:55 INFO - Installing collected packages: blessings 09:39:55 INFO - Running setup.py install for blessings 09:39:55 INFO - Successfully installed blessings 09:39:55 INFO - Cleaning up... 09:39:55 INFO - Return code: 0 09:39:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:56 INFO - Reading from file tmpfile_stdout 09:39:56 INFO - Current package versions: 09:39:56 INFO - blessings == 1.6 09:39:56 INFO - blobuploader == 1.2.4 09:39:56 INFO - docopt == 0.6.1 09:39:56 INFO - functools32 == 3.2.3-2 09:39:56 INFO - jsonschema == 2.5.1 09:39:56 INFO - manifestparser == 1.1 09:39:56 INFO - mozInstall == 1.12 09:39:56 INFO - mozcrash == 1.0 09:39:56 INFO - mozdebug == 0.1 09:39:56 INFO - mozdevice == 0.49 09:39:56 INFO - mozfile == 1.2 09:39:56 INFO - mozhttpd == 0.7 09:39:56 INFO - mozinfo == 0.9 09:39:56 INFO - mozleak == 0.1 09:39:56 INFO - mozlog == 3.4 09:39:56 INFO - moznetwork == 0.27 09:39:56 INFO - mozprocess == 0.25 09:39:56 INFO - mozprofile == 0.28 09:39:56 INFO - mozrunner == 6.13 09:39:56 INFO - mozscreenshot == 0.1 09:39:56 INFO - mozsystemmonitor == 0.3 09:39:56 INFO - moztest == 0.8 09:39:56 INFO - mozversion == 1.4 09:39:56 INFO - psutil == 3.1.1 09:39:56 INFO - requests == 1.2.3 09:39:56 INFO - wsgiref == 0.1.2 09:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:56 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 09:39:56 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 09:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:56 INFO - 'HOME': '/Users/cltbld', 09:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:56 INFO - 'LOGNAME': 'cltbld', 09:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:56 INFO - 'MOZ_NO_REMOTE': '1', 09:39:56 INFO - 'NO_EM_RESTART': '1', 09:39:56 INFO - 'PAGER': '/bin/cat', 09:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:56 INFO - 'PWD': '/builds/slave/test', 09:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:56 INFO - 'SHELL': '/bin/bash', 09:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:56 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:56 INFO - 'USER': 'cltbld', 09:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:56 INFO - 'XPC_FLAGS': '0x0', 09:39:56 INFO - 'XPC_SERVICE_NAME': '0', 09:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 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)) 09:39:56 INFO - Cleaning up... 09:39:56 INFO - Return code: 0 09:39:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 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 0x101190b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101193768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b71595cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, '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.IyVCL1kBDK/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.hGM2svmm3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 09:39:56 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 09:39:56 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 09:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:56 INFO - 'HOME': '/Users/cltbld', 09:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:56 INFO - 'LOGNAME': 'cltbld', 09:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:56 INFO - 'MOZ_NO_REMOTE': '1', 09:39:56 INFO - 'NO_EM_RESTART': '1', 09:39:56 INFO - 'PAGER': '/bin/cat', 09:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:56 INFO - 'PWD': '/builds/slave/test', 09:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:56 INFO - 'SHELL': '/bin/bash', 09:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:39:56 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:56 INFO - 'USER': 'cltbld', 09:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:56 INFO - 'XPC_FLAGS': '0x0', 09:39:56 INFO - 'XPC_SERVICE_NAME': '0', 09:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:39:56 INFO - Cleaning up... 09:39:56 INFO - Return code: 0 09:39:56 INFO - Running post-action listener: _resource_record_post_action 09:39:56 INFO - Running post-action listener: _start_resource_monitoring 09:39:56 INFO - Starting resource monitoring. 09:39:56 INFO - [mozharness: 2017-04-26 16:39:56.694294Z] Finished create-virtualenv step (success) 09:39:56 INFO - [mozharness: 2017-04-26 16:39:56.695305Z] Running install step. 09:39:56 INFO - Running pre-action listener: _resource_record_pre_action 09:39:56 INFO - Running main action method: install 09:39:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:56 INFO - Reading from file tmpfile_stdout 09:39:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:57 INFO - Reading from file tmpfile_stdout 09:39:57 INFO - Output received: 09:39:57 INFO - Usage: mozinstall [options] installer 09:39:57 INFO - Options: 09:39:57 INFO - -h, --help show this help message and exit 09:39:57 INFO - -d DEST, --destination=DEST 09:39:57 INFO - Directory to install application into. [default: 09:39:57 INFO - "/builds/slave/test"] 09:39:57 INFO - --app=APP Application being installed. [default: firefox] 09:39:57 INFO - mkdir: /builds/slave/test/build/application 09:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:40:11 INFO - Reading from file tmpfile_stdout 09:40:11 INFO - Output received: 09:40:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:40:11 INFO - Running post-action listener: _resource_record_post_action 09:40:11 INFO - [mozharness: 2017-04-26 16:40:11.898069Z] Finished install step (success) 09:40:11 INFO - [mozharness: 2017-04-26 16:40:11.898218Z] Running run-tests step. 09:40:11 INFO - Running pre-action listener: _resource_record_pre_action 09:40:11 INFO - Running main action method: run_tests 09:40:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:40:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:40:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:40:11 INFO - 2017-04-26 09:40:11.913 screenresolution[2915:47235] starting screenresolution argv=screenresolution get 09:40:11 INFO - 2017-04-26 09:40:11.915 screenresolution[2915:47235] Display 0: 1600x1200x32@60 09:40:11 INFO - 2017-04-26 09:40:11.921 screenresolution[2916:47237] starting screenresolution argv=screenresolution list 09:40:11 INFO - Available Modes on Display 0 09:40:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:40:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:40:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:40:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:40:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:40:12 INFO - Intel Iris: 09:40:12 INFO - Chipset Model: Intel Iris 09:40:12 INFO - Type: GPU 09:40:12 INFO - Bus: Built-In 09:40:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:40:12 INFO - Vendor: Intel (0x8086) 09:40:12 INFO - Device ID: 0x0a2e 09:40:12 INFO - Revision ID: 0x0009 09:40:12 INFO - Displays: 09:40:12 INFO - Display: 09:40:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:40:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:40:12 INFO - Display Serial Number: 1600x1200 60 09:40:12 INFO - Main Display: Yes 09:40:12 INFO - Mirror: Off 09:40:12 INFO - Online: Yes 09:40:12 INFO - Rotation: Supported 09:40:12 INFO - Return code: 0 09:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:12 INFO - Python 2.7.3 09:40:12 INFO - Return code: 0 09:40:12 INFO - grabbing minidump binary from tooltool 09:40:12 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')]} 09:40:12 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 0x100f6ed30>, '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 0x100e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f63be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:12 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 09:40:12 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 09:40:12 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 09:40:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:12 INFO - Return code: 0 09:40:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:40:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:12 INFO - ENV: RUST_BACKTRACE is now 1 09:40:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:40:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:12 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/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 09:40:12 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/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 09:40:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IyVCL1kBDK/Render', 09:40:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:12 INFO - 'HOME': '/Users/cltbld', 09:40:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:12 INFO - 'LOGNAME': 'cltbld', 09:40:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:12 INFO - 'MOZ_NO_REMOTE': '1', 09:40:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:12 INFO - 'NO_EM_RESTART': '1', 09:40:12 INFO - 'PAGER': '/bin/cat', 09:40:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:12 INFO - 'PWD': '/builds/slave/test', 09:40:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:12 INFO - 'RUST_BACKTRACE': '1', 09:40:12 INFO - 'SHELL': '/bin/bash', 09:40:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hGM2svmm3m/Listeners', 09:40:12 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 09:40:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:12 INFO - 'USER': 'cltbld', 09:40:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:12 INFO - 'XPC_FLAGS': '0x0', 09:40:12 INFO - 'XPC_SERVICE_NAME': '0', 09:40:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:12 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/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 09:40:12 INFO - mozversion application_buildid: 20170426085225 09:40:12 INFO - mozversion application_changeset: 70012c15c9428d2c8186befaa8da038dd28257ee 09:40:12 INFO - mozversion application_display_name: Firefox 09:40:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:12 INFO - mozversion application_name: Firefox 09:40:12 INFO - mozversion application_remotingname: firefox 09:40:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:40:12 INFO - mozversion application_vendor: Mozilla 09:40:12 INFO - mozversion application_version: 54.0 09:40:12 INFO - mozversion platform_buildid: 20170426085225 09:40:12 INFO - mozversion platform_changeset: 70012c15c9428d2c8186befaa8da038dd28257ee 09:40:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:40:12 INFO - mozversion platform_version: 54.0 09:40:12 INFO - using testdate: 1493224812 09:40:12 INFO - actual date: 1493224812 09:40:12 INFO - starting webserver on 'localhost:63516' 09:40:12 INFO - SUITE-START | Running 2 tests 09:40:12 INFO - TEST-START | dromaeo_css 09:40:12 INFO - operating with platform_type : mac_ 09:40:12 INFO - Initialising browser for dromaeo_css test... 09:40:12 INFO - TEST-INFO | started process 2926 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp3PtY1G/profile http://localhost:63516/getInfo.html) 09:40:14 INFO - PROCESS | 2926 | __metrics Screen width/height:1600/1200 09:40:14 INFO - PROCESS | 2926 | colorDepth:24 09:40:14 INFO - PROCESS | 2926 | Browser inner width/height: 1024/689 09:40:14 INFO - PROCESS | 2926 | __metrics 09:40:15 INFO - PROCESS | 2926 | 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" 09:40:15 INFO - PROCESS | 2926 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:15 INFO - TEST-INFO | 2926: exit 0 09:40:15 INFO - Browser initialized. 09:40:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:15 INFO - TEST-INFO | started process 2929 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp3PtY1G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:27 INFO - PROCESS | 2929 | RSS: Main: 165269504 09:40:27 INFO - PROCESS | 2929 | 09:43:31 INFO - PROCESS | 2929 | Cycle 1(1): loaded http://localhost:63516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:63516/tests/dromaeo/cssquery-ext.html) 09:43:33 INFO - PROCESS | 2929 | RSS: Main: 335421440 09:43:33 INFO - PROCESS | 2929 | 09:46:36 INFO - PROCESS | 2929 | Cycle 1(1): loaded http://localhost:63516/tests/dromaeo/cssquery-ext.html (next: http://localhost:63516/tests/dromaeo/cssquery-jquery.html) 09:46:36 INFO - PROCESS | 2929 | RSS: Main: 308912128 09:46:36 INFO - PROCESS | 2929 | 09:49:39 INFO - PROCESS | 2929 | Cycle 1(1): loaded http://localhost:63516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:63516/tests/dromaeo/cssquery-mootools.html) 09:49:40 INFO - PROCESS | 2929 | RSS: Main: 277876736 09:49:40 INFO - PROCESS | 2929 | 09:52:42 INFO - PROCESS | 2929 | Cycle 1(1): loaded http://localhost:63516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:63516/tests/dromaeo/cssquery-prototype.html) 09:52:43 INFO - PROCESS | 2929 | RSS: Main: 295542784 09:52:43 INFO - PROCESS | 2929 | 09:55:46 INFO - PROCESS | 2929 | Cycle 1(1): loaded http://localhost:63516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:63516/tests/dromaeo/cssquery-yui.html) 09:55:47 INFO - PROCESS | 2929 | RSS: Main: 267788288 09:55:47 INFO - PROCESS | 2929 | 09:58:50 INFO - PROCESS | 2929 | Cycle 1(1): loaded http://localhost:63516/tests/dromaeo/cssquery-yui.html (next: http://localhost:63516/tests/dromaeo/cssquery-dojo.html) 09:58:51 INFO - PROCESS | 2929 | RSS: Main: 324435968 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | __start_tp_report 09:58:51 INFO - PROCESS | 2929 | _x_x_mozilla_page_load 09:58:51 INFO - PROCESS | 2929 | _x_x_mozilla_page_load_details 09:58:51 INFO - PROCESS | 2929 | |i|pagename|runs| 09:58:51 INFO - PROCESS | 2929 | |0;dojo.html;3518.208403109301;3533.416986197277;3540.911477213068;3557.8221088945547;3601.4777857210706;6109.358517355675;6166.814995550135;6170.907436388457;6171.382861713821;6178.567500274982;6155.722992465338;6214.098955651428;6234.781782637609;6247.344028876971;6247.7813276535335;5482.972585137079;5500.779968801243;5533.6956467394275;5554.555635549166;5663.971680141593;5427.45725427458;5437.265969094181;5477.068898287301;5635.464630860082;5653.293338332708;5517.5585953123655;5535.6955367454775;5536.252605898213;5552.250446189753;5566.55467562594;5559.8888022239325;5582.748776305076;5585;5587.916181257285;5589.329280486327;5449.836504904859;5525.171224316385;5532.585056120807;5539.833804985857;5543.52880005196;5029.899402011939;6082.482988945945;6085.574009819315;6101.969490152565;6166.290876549209;6537.280899101095;6579.34206579343;6582.17722784652;6590.736370545173;6600.2079750429775;6640.966795165993;6665.333466653345;6706.362895524917;6707.128073350434;6718.2945790691765;6130.642739936431;6241.407066328691;6321.589096708699;6323.27282362525;6325.399087086719;6536.117624120778;6701.832454188684;6768.72925083001;6830.31696830313;6855.451563874878;6502.382273683992;6522.445592124723;6525.836854078686;6545.37818907203;6547.672616369163;6623.635700036448;6633.767818126343;6704.731810727614;6704.83237919056;6714.52998290115;6250.968745156245;6293.2762732285455;6461.127747753993;6475.287718350977;6485.4811615070685;6242.2509298883515;6274.6235225885675;6291.748330066837;6301.212348456443;6570.145881035435;5227.921581176285;5245.160774276097;5308.840734777963;5329.813456529003;5336.62643614951;4752.667313288037;4792.329073929653;4819.831305904347;4820.783064762094;4827.517248275144;6263.123162757218;6268.09112678659;6293.590916590407;6295.842603934938;6296.181496405438;6305.747770089237;6323.9683801580695;6542.607443553402;6628.072069910217;6642.767503137367;6236.376362363818;6241.75032998684;6256.155419018374;6282.120503129566;6282.434580887651;5795.739191736382;5822.126680997884;5857.531397488191;5871.55963302754;5895.174675545427;6475.449586785176;6479.902801458076;6864.862702746017;6894.586324820527;6903.75836845708;5508.091164957737;6391.648459334781;6406.327335629878;6420;6422.357764223727;6559.311272316338;6570.704318305592;6821.283765204582;6868.587884726932;6879.140107486564;6516.055172000129;6548.738050478118;6560.376764207393;6581.564821016254;6587.077809106633;6634.767783127568;6643.435307998681;6647.069410282467;6670.7665231716655;6677.3656502632175;6198.163247961648;6238;6337.9366206337345;6409.647469389229;6489.643069631215;6385.744570217325;6444.387783160592;6445.097686323825;6445.903311450238;6454.451371633464;6309.274433440213;6338.144350512622;6342.7145778441;6365.649889256136;6462.256840463218;6231.532635052298;6240.687965601611;6442.065900444503;6442.291347951628;6457.4511166551365;6194.349593292639;6279.623222606659;6331.715072821642;6340.968295158679;6344.4290013897125 09:58:51 INFO - PROCESS | 2929 | |1;ext.html;759.9354054905333;811.5536454949776;827.6275675945824;908.1508789282021;915.5285028210469;28905.56641650377;40635.59364406355;40703.98240044001;40738;40800.59199408005;41595.79202103993;41741;41744;41808.581914180846;41848.790756046175;7737.226277372246;9444.197243234315;9610.183134433546;9613.182879455255;9614.471204083773;7831.4909530880595;11590.65228043156;11643.243189192675;11670.766584668301;11670.8249376259;10292.588296468133;11482.368469734161;11744.941275293611;11776.411179441036;11801.94099029508;11750.177487575831;11803.23278986863;11806.645800625909;11808.881911180864;11809.822852657217;11361.715957101056;11403.201775875692;11409.60066397672;11413.771724565546;11427.371494567795;39876.80061599673;39973.80013099945;39996;40071.7996410019;40102.799486002674;3731.8134093295225;4063.8577649782114;4104.302268614343;4134.793260336971;4153.335466325373;27836.16491505258;28244.576331355045;28818.42363152746;29937.40125197484;30381.088567343017;3152.0701393088866;3240.9189770255934;3286.572745543088;3356.3622911646708;3373.2241584435474;345344.54655453376;348459;363163;363488.18255908816;364429;51887;51889.74055129776;51895.221571676455;51975.48024519782;52012.21981670278;54397;54617.453825462035;54735.17897231465;54745.72627136839;54822;15322.846771532364;15442.45951391696;15444.845551544566;15452.5364239073;15464.845351546566;11819.940900295443;11976;13172.209667419986;13188.878945289758;13200.273984930729;10627.149828013895;11798.587049453228;12003.63989080329;12117.27296362221;12214.26714397139;4541.6593755468475;5304.92042619361;5332.33345831771;5364.168553874156;5371.597130215171;1106.5062166075734;1112.6828853776635;1127.2954403497813;1215.428748488209;1220.0300760895109;26735.866320668272;26823.731762682513;27113.593296100575;27192.59211111835;27256.454870902868;1069.3583849690278;1090.6400887707039;1244.6701624069628;1245.6698974771693;1312.2809120052762;13228.14017088886;13375.53185638498;13439;13486.932565337307;13503.459861605623;339407;340437;340540;340871;341625;50917.74541127345;51032;51053;51099;51191;1425.1520345394474;1436.1526699247495;1488.047649504318;1496.5061529695174;1501.6020754500066;24355;25406.618900716134;25422.745772542778;25529;25553.744462555882;42406.36390454207;42466.78766606147;42524;42533;42678;310367;310863;311555;312324;313719;29498;29955;31782;31826.204344890637;31907.883224087047;32521.260055093968;32737.836310818293;37859.432108517845;39661.60338396579;41452.58547414487;24395.634065488677;32428;33134.668653314126;33501.497477538345;33722.83138584292;32941.84703535461;32957.17607059747;33572.49641255432;34354.656453436146;34378.48432273468;29895;40644.593554065264;41572.58427415687;41667;41672.166556669305;33515.83242083774;33869.491957620165;34351.797687080834;35046.299074017865;35171.12072198215;23848.807559621604;25668.486630267664;26888.731112688623;27181.59227611548;27221.59167612527 09:58:51 INFO - PROCESS | 2929 | |2;jquery.html;373.3708700839085;389.70187806328164;399.5465147058088;430.33942897652094;472.3057106054099;13615.659608509792;15590.830687698426;22165.445863853412;22345.664815027787;22780.658290125662;22593.322200334016;23230.88384558075;23452.29643110705;24148.275551733477;24346.90438930248;5976.252968378953;7116.359527642511;7271.600061996588;7276.781696549086;7295.16105647852;6880.311968803129;7088.326608972166;7117.466190035768;7204.3155900189395;7205.675744591506;6987.965060174717;7195.928040719578;7198.02826618405;7203.027591275163;7208.351248387644;7006.404455621253;7124.8931266030795;7175.533590316665;7176.569405835667;7179.46154038444;6872.965635171792;6915.135608048994;6990.021397004423;6994.2656021117555;6995.930040699579;28384.006559770514;28389;28443.573346399822;28471.85764071187;28803;2964.43675701616;2979.2700788307;3038.924026899323;3063.463893818595;3087.861046252924;17013.65972680552;17016.48950531486;17216.827831721646;17255.137243137793;18417.987010714405;2177.7822217778253;2185.8797766122857;2201.5376770878133;2209.6133176694016;2214.3799736073925;147485.2625736875;148112;148339;150530.003815829;151011.24494377567;20180.69728954067;20777.896110519352;21748.347549573537;21781.802000890104;22164.800174580556;35455.11362215914;35881.82059089688;36283.4557481638;36338.45492317617;36343.72906438433;10782.838257426145;11005.61480348184;11258.21192516516;11263.943680281545;11369.602063927723;8949.328800340001;8961.969373522128;8993.14565116313;9102.954485227532;9105.453672779655;10292.639757608598;10597.523111460003;10695.625653102104;10719.303245289031;10760.139188864872;3450.654934506529;4307.8492252771;4342.869713908588;4348.2825333819565;4362.17118747437;1108.700650824273;1129.220837622038;1132.4824734855333;1151.7061204953825;1183.2545496337252;23484;23604.66336519861;23750.168744093873;23765.405864853517;23794;1137.806572882612;1147.6958605969426;1160.3560024186488;1177.6231605886035;1201.3572738584814;10527.157827373792;11973.40132993347;12281.750181771162;12420.441080151235;12596.622101336974;775529;778079;783732;821526;826277;116738.41630791791;134681;135843.32078339742;139064;143468.28265858605;1197.7185361440054;1231.6428235811513;1296.4490091711173;1314.850932017812;1339.8794108530278;18097.914125152533;18793.530161746065;19344.613107737485;20709.79290207139;20809.895950520757;66024.42645816426;66246;66315;66348.6682566584;67937.30156745923;93815.53092234496;94981.5250923741;95347.52326238324;97384;97962;7326.267373262845;9969.451680157661;11200.551977920792;11389.373584452935;11950.402479876146;12270.75458490843;13178.538751143664;13218.471261149447;13641.727165456437;13706.314684265946;11377.374244416636;11474.082073434272;11603.013743831869;11875.346855923008;11921.82117268259;9326.207272381653;10588.258821882395;10664.733381665521;10751.731206719582;11080.889191107986;6613.338666133348;11676.124290678403;11773.411329433666;12099.697507562381;12131.393430328271;11401.714957125807;11622.70943226426;11913.82129268079;11945.283283003047;12023.879761202275;11299.548018079513;11459.255148415326;11592.362420066976;11715.355655438692;11811.82282265784 09:58:51 INFO - PROCESS | 2929 | |3;mootools.html;1386.542440994472;1453.6583902782847;1622.3672767620624;1642.2691902103566;1651.6201273707054;9565.808683826319;9954.701358959224;11295.983361497463;11550.422478876064;11784.705382365446;11423.086153107752;11496;11514.942425287862;11517.654470365902;11519.884801151986;2152.494163871489;2198.48335641125;2203.592335417945;2206.7020952171492;2215.28003398896;1797.63148554546;2166.1335465813645;2167.5339801942578;2173.1307477009163;2175.5213852952324;2410.0600765701392;2472.8021758259297;2477.293971218194;2486.78862296705;2490.252924122765;2180.5420861619;2346.3664810501155;2401.891914863835;2439.1706819681394;2439.7194322652945;2135.9466013349634;2418.3349578865955;2424.806015518754;2425.4906469641396;2444.1201167579657;11580.76838463226;11674.182807203415;11685.766284674344;11689.123315751267;11705.414729263503;5703.800366987177;5865.442782935615;5874.441928016831;5883.529317654577;5905.43898329658;3409;3425.3320602482527;3512.209752805624;3689.631036896289;3691.335559599271;1185.9326606054533;1233.5682511121126;1253.0414233111676;1256.1772039314264;1272.5673271087874;15974.28115734783;15982.68034639324;16025.19874006295;16054.197290135564;16066.116363599996;4702.255346533156;4915.8033678652455;5006.69959802413;5014.473480284591;5042.520960508746;13775.862241377457;13776.793348099787;13782.724345513034;13784.724305514033;13803;6043.184170136975;6105.389461053948;6148.877022459616;6156.353582873823;6197.4732147767045;5138.229265610188;5188.092083885305;5191.506806853343;5204.583633309327;5450.672959622435;3555.9644403555635;3768.2840260350445;3818.3771896943686;4028.637422631977;4111.157212771434;951.6145960885852;977.9070988256104;1037.1858091398217;1138.9259698119595;1142.8628564572305;942.8727121838601;978.6427953796955;985.3545927417553;985.8225519406576;988.5057471264367;6654.168228971379;6679.098321726505;6876.587404755731;6899.275576064441;7115.608641524663;1008.7541885771067;1013.5945621751358;1039;1072.5012869015945;1076.2036093290908;3764.4729737836724;4487.708298960557;4496.887577810516;4589;4629.884252893705;13722.519711810039;14135.717285654435;14165;14166.433342666383;14244.287785610679;13346.933265333611;13817.861821381657;14116.435342586386;14141.71716565663;14146;10492.632757853438;10754.73113172177;10787.083097936764;10797.406142662228;10821.29661572011;6747;7020.262872398529;7163.10461192351;7178.138623365229;7222.494425390172;11890.583829565923;12609.243445393306;12739.61781146567;12918.160319579198;12918.870811292143;12906.483740650268;13028.218306901616;13077.542286019943;13177.407016684081;13216.405261763435;9100.499472529074;9430.481323527272;9599.280053996117;9666.75833104178;9685.370450920667;10692.786144277226;10693.09108725767;10760;10798.56805727762;10817;9068.455892646462;9081.861159492411;9110.453372797654;9234.30742694314;9277.582508787256;7666.846663066819;8809.867851982353;8852.557372131496;8903.376763626484;8905.599248033725;7991.120976692443;8043.436959413019;8098.635561399633;8145.185481451807;8170.387220958333;5248.475152484721;5921.5558833086825;5937.079752638348;6173.351798061319;6211.3478084800445;5963.105534169736;6018.729157188025;6090.543209259235;6097.085437184458;6293.590916590407 09:58:51 INFO - PROCESS | 2929 | |4;prototype.html;370.4517314374725;377.98110094495286;395.29045363572385;397.5229724330802;401.65056400931184;4578.969731810341;4741.478437371895;4971.577415919646;5012.644057293066;5268.576454830778;4504.954950450495;4510.962478629917;4708.199606066968;4790.676307274399;5013.6490445668815;4266.5946735060115;4268.7225330353585;4281;4309.784510774464;4323.070539833935;3340.8329583520726;3713.8885833424906;4295.548967358429;4297.699161058727;4310.633596144316;3618.710503159754;4114.526829414625;4140.540756419994;4207.831686732527;4240.9821642805655;3620.31214069326;4248.044190057243;4249.32010878258;4261.252886316626;4289.914201715964;3442.3115376924466;3929.3713005918917;3958.4062390641348;3966.36538153894;4019.3569028955226;4340.620944394542;4405.559444055601;4803.351547541072;4857.392825896763;5079.6952182869145;4379.715318504287;4838.201696720037;4927.3638603347035;4980;4981.302617633534;5161.767720452589;5253.711045892474;5500.917486237709;5522.5581953443625;5556.666600003972;4130.463039804837;4351.847685331029;4367.104743527601;4382;4508.864734057984;5059.62052846038;5155.561777248939;5629;5764.279465066867;5770.88458230833;3964.5440774311323;4112.194318403048;4405.405270288534;4551.4765801932535;4646.581807637329;4374.58441448062;4727.739974301447;4733.721895088376;4737.692050016738;4778.354922085544;4295.591918767712;4580.862574122782;4604.056168485453;4978.850634480971;5026.693059804477;5069.923951140736;5298.894022119536;5541.5289700375115;5590.456342364215;5598.552115830724;1453.9636509087356;1565.506865337415;1582.849629285216;1592.4314550168076;1624.8781341399206;1119.652907598647;1120.1207052463776;1177.8998785103363;1205.932749516684;1207.8067509198486;4686.5782079613;5101.438841727407;5126.871828204325;5148.150555158431;5271.920921186185;4674.205385084544;5123.6157288202785;5272.841814745564;5312.601554883399;5656.5757568181725;4148.274052040881;4508.413906192174;5023.422306434733;5124.564412024945;5148.786022010571;2734.7128551502205;2794.413173233603;2887.321479452327;2963.807352522122;3000.6549246836894;5312.5484333832055;5405.7837686492885;5941.792037278675;5972.701364931736;6038;4690.671652984258;4904.901901961941;5200.869978250574;5376.91934620981;5861.479563787612;5808.39011903744;5886.676232807236;6003.9286446176;6004.3395226525045;6058.4244496772735;4977.789325884712;5325.946740532545;5698.914516282176;5733.770649173986;5760.654360738369;5088.669236499616;5107.361579802525;5590.456342364133;5648.893837343426;5657.755293835349;4864.318995340726;5129.871103492009;5639.295088113986;5686.886262274648;5850.853728656818;3902.20991990728;3950.6246906543834;4035.838566457426;4270.466191726035;4420.624246938917;5025.899482010413;5183.870403239949;5397.302847549441;5621;5742.885142297214;4435.3125265583885;4833.637477189154;5462.617616766947;5567.32768271224;5567.415421380859;4800.823283743166;5056.84829455117;5381.058314794817;5508.697021663847;5574.609777315549;4775.5224477551965;4875.43932447773;5055.69665820052;5398.892022159614;5466.753996070266;4933.432655244693;4996.325496058131;5293.947060529345;5460.453954604508;5558.110702287615;5107.770150343169;5420.864478388072;5469.781208751605;5476.890462190654;5498.45015498447 09:58:51 INFO - PROCESS | 2929 | |5;yui.html;786.0567319216938;793.2147174297445;825.5046971816906;854.3933806997031;903.2367649336309;16259.34962601496;18087.3773302871;18130.09349532523;18154.183061762218;18225.908870455663;16254.024758514497;16310.939788913742;16314.347426102942;16410.261538230778;16513.422030228943;931.1340453378356;971.9611215551387;993.8173573447574;999.1357475783432;1041.5677493840046;866.4974314897376;1019.4902548725637;1033.8655974723276;1034.2450011491615;1034.3483605328634;914.309696179387;1063.2344711807486;1063.840423936408;1064.7817197474499;1066.4454483668487;1055.8680164979378;1057.1648397765755;1057.6139709006234;1058.560697310615;1059.8569193158903;723.855228954206;726.1576571177461;781.5427974634846;782.3193821375382;784.8822676598498;16643.33426662932;16951;17493;17497.47507574775;17681.469555913343;14652.487162949352;14866.88498362627;14966.17686027268;14991.625209369744;15165.24173791306;10537.736556586147;11974.842265790816;12017.399130043463;12028.27830330183;12572.239886415817;3767.618629612246;3845.0771814764257;3889.3776995680555;4019.397090436458;4144.834206631731;104321;112548.43725781319;113916;115020.27469587963;118078.99999999914;11369.31784092957;11653;11953.40232988347;12039;12200.205956828635;24079.157229496883;24101.674407907383;24130;24142.7585724144;24145.758542414704;7939.20607939213;7951.721689740947;8000.079990801132;8497.150284971452;8504.022037465647;4592.196365636;4677.017826256524;4678.228092364721;4874.95125048745;4876.634252431082;3568.286342731464;3596.4245720684567;3681.9079523011605;3684.5578530575967;3702.333579955634;651.9478441724746;656.8193746719691;661.4476911778622;686.0395446375015;686.2519853359862;630.6562923206864;679.3715812873072;700.2157583506404;719.4496210399049;748.1433758346662;10356.275060745675;11051.613193538187;11239.719007024727;11749.941250293865;11929.403529823474;586.4047991288845;636.2555809702659;647.5370110371107;665.1785045468843;726.5531698005794;5106.948930510722;5261.242941232188;5299.6290259681455;5308.46915308466;5314.813981510629;97077.0292297082;101161.49419253004;101968;104014.47992759988;105684.41473377905;85290;87981.56009219913;88170.55914720513;90392;90664;57178.85642287131;78979.8153027705;79636.20363796288;80344.19655803367;81040;10968.341899486057;11302.208845380745;11350.54597816078;11598.94200528992;11788.174827762317;45984.770076149405;47522.04955900932;48345;49694.75152624214;52139.73930130325;68599.31400686128;71402.64298678473;72178;74132.62933685297;74524;13687.178769273478;13710.52013179534;13777.655558611115;14333.56999290023;14520.98353115314;15289.295396336209;15319.540413787605;15683.137427441145;15775.370496497238;16437.506874793777;14076.78884816749;14455.277236137941;14539.27303634793;14777.482788102365;15220.01069930451;13892.791608125684;14333.426662933784;14515.709685806436;14639.341229644479;14737.263136842901;13798.17210967345;14061.01572889888;14352.49766258176;14467.987240893457;14555;9524.85712714296;9804.264680148875;10286.485675716334;10368.585256589651;10431.68704938853;10148.067533971594;10784;11751.941240293743;11780.70548236301;11975 09:58:51 INFO - PROCESS | 2929 | __end_tp_report 09:58:51 INFO - PROCESS | 2929 | __start_cc_report 09:58:51 INFO - PROCESS | 2929 | _x_x_mozilla_cycle_collect,1781 09:58:51 INFO - PROCESS | 2929 | __end_cc_report 09:58:51 INFO - PROCESS | 2929 | __startTimestamp1493225931058__endTimestamp 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | ------- Summary: start ------- 09:58:51 INFO - PROCESS | 2929 | Number of tests: 6 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | [#0] dojo.html Cycles:165 Average:6103.56 Median:6295.84 stddev:666.56 (10.6%) stddev-sans-first:637.01 09:58:51 INFO - PROCESS | 2929 | Values: 3518.2 3533.4 3540.9 3557.8 3601.5 6109.4 6166.8 6170.9 6171.4 6178.6 6155.7 6214.1 6234.8 6247.3 6247.8 5483.0 5500.8 5533.7 5554.6 5664.0 5427.5 5437.3 5477.1 5635.5 5653.3 5517.6 5535.7 5536.3 5552.3 5566.6 5559.9 5582.7 5585.0 5587.9 5589.3 5449.8 5525.2 5532.6 5539.8 5543.5 5029.9 6082.5 6085.6 6102.0 6166.3 6537.3 6579.3 6582.2 6590.7 6600.2 6641.0 6665.3 6706.4 6707.1 6718.3 6130.6 6241.4 6321.6 6323.3 6325.4 6536.1 6701.8 6768.7 6830.3 6855.5 6502.4 6522.4 6525.8 6545.4 6547.7 6623.6 6633.8 6704.7 6704.8 6714.5 6251.0 6293.3 6461.1 6475.3 6485.5 6242.3 6274.6 6291.7 6301.2 6570.1 5227.9 5245.2 5308.8 5329.8 5336.6 4752.7 4792.3 4819.8 4820.8 4827.5 6263.1 6268.1 6293.6 6295.8 6296.2 6305.7 6324.0 6542.6 6628.1 6642.8 6236.4 6241.8 6256.2 6282.1 6282.4 5795.7 5822.1 5857.5 5871.6 5895.2 6475.4 6479.9 6864.9 6894.6 6903.8 5508.1 6391.6 6406.3 6420.0 6422.4 6559.3 6570.7 6821.3 6868.6 6879.1 6516.1 6548.7 6560.4 6581.6 6587.1 6634.8 6643.4 6647.1 6670.8 6677.4 6198.2 6238.0 6337.9 6409.6 6489.6 6385.7 6444.4 6445.1 6445.9 6454.5 6309.3 6338.1 6342.7 6365.6 6462.3 6231.5 6240.7 6442.1 6442.3 6457.5 6194.3 6279.6 6331.7 6341.0 6344.4 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | [#1] ext.html Cycles:180 Average:49128.05 Median:32629.55 stddev:88472.62 (271.1%) stddev-sans-first:88646.27 09:58:51 INFO - PROCESS | 2929 | Values: 759.9 811.6 827.6 908.2 915.5 28905.6 40635.6 40704.0 40738.0 40800.6 41595.8 41741.0 41744.0 41808.6 41848.8 7737.2 9444.2 9610.2 9613.2 9614.5 7831.5 11590.7 11643.2 11670.8 11670.8 10292.6 11482.4 11744.9 11776.4 11801.9 11750.2 11803.2 11806.6 11808.9 11809.8 11361.7 11403.2 11409.6 11413.8 11427.4 39876.8 39973.8 39996.0 40071.8 40102.8 3731.8 4063.9 4104.3 4134.8 4153.3 27836.2 28244.6 28818.4 29937.4 30381.1 3152.1 3240.9 3286.6 3356.4 3373.2 345344.5 348459.0 363163.0 363488.2 364429.0 51887.0 51889.7 51895.2 51975.5 52012.2 54397.0 54617.5 54735.2 54745.7 54822.0 15322.8 15442.5 15444.8 15452.5 15464.8 11819.9 11976.0 13172.2 13188.9 13200.3 10627.1 11798.6 12003.6 12117.3 12214.3 4541.7 5304.9 5332.3 5364.2 5371.6 1106.5 1112.7 1127.3 1215.4 1220.0 26735.9 26823.7 27113.6 27192.6 27256.5 1069.4 1090.6 1244.7 1245.7 1312.3 13228.1 13375.5 13439.0 13486.9 13503.5 339407.0 340437.0 340540.0 340871.0 341625.0 50917.7 51032.0 51053.0 51099.0 51191.0 1425.2 1436.2 1488.0 1496.5 1501.6 24355.0 25406.6 25422.7 25529.0 25553.7 42406.4 42466.8 42524.0 42533.0 42678.0 310367.0 310863.0 311555.0 312324.0 313719.0 29498.0 29955.0 31782.0 31826.2 31907.9 32521.3 32737.8 37859.4 39661.6 41452.6 24395.6 32428.0 33134.7 33501.5 33722.8 32941.8 32957.2 33572.5 34354.7 34378.5 29895.0 40644.6 41572.6 41667.0 41672.2 33515.8 33869.5 34351.8 35046.3 35171.1 23848.8 25668.5 26888.7 27181.6 27221.6 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | [#2] jquery.html Cycles:180 Average:44535.50 Median:2212.00 stddev:132093.72 (5971.7%) stddev-sans-first:132422.65 09:58:51 INFO - PROCESS | 2929 | Values: 373.4 389.7 399.5 430.3 472.3 13615.7 15590.8 22165.4 22345.7 22780.7 22593.3 23230.9 23452.3 24148.3 24346.9 5976.3 7116.4 7271.6 7276.8 7295.2 6880.3 7088.3 7117.5 7204.3 7205.7 6988.0 7195.9 7198.0 7203.0 7208.4 7006.4 7124.9 7175.5 7176.6 7179.5 6873.0 6915.1 6990.0 6994.3 6995.9 28384.0 28389.0 28443.6 28471.9 28803.0 2964.4 2979.3 3038.9 3063.5 3087.9 17013.7 17016.5 17216.8 17255.1 18418.0 2177.8 2185.9 2201.5 2209.6 2214.4 147485.3 148112.0 148339.0 150530.0 151011.2 20180.7 20777.9 21748.3 21781.8 22164.8 35455.1 35881.8 36283.5 36338.5 36343.7 10782.8 11005.6 11258.2 11263.9 11369.6 8949.3 8962.0 8993.1 9103.0 9105.5 10292.6 10597.5 10695.6 10719.3 10760.1 3450.7 4307.8 4342.9 4348.3 4362.2 1108.7 1129.2 1132.5 1151.7 1183.3 23484.0 23604.7 23750.2 23765.4 23794.0 1137.8 1147.7 1160.4 1177.6 1201.4 10527.2 11973.4 12281.8 12420.4 12596.6 775529.0 778079.0 783732.0 821526.0 826277.0 116738.4 134681.0 135843.3 139064.0 143468.3 1197.7 1231.6 1296.4 1314.9 1339.9 18097.9 18793.5 19344.6 20709.8 20809.9 66024.4 66246.0 66315.0 66348.7 67937.3 93815.5 94981.5 95347.5 97384.0 97962.0 7326.3 9969.5 11200.6 11389.4 11950.4 12270.8 13178.5 13218.5 13641.7 13706.3 11377.4 11474.1 11603.0 11875.3 11921.8 9326.2 10588.3 10664.7 10751.7 11080.9 6613.3 11676.1 11773.4 12099.7 12131.4 11401.7 11622.7 11913.8 11945.3 12023.9 11299.5 11459.3 11592.4 11715.4 11811.8 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | [#3] mootools.html Cycles:180 Average:6987.23 Median:2441.92 stddev:4472.02 (183.1%) stddev-sans-first:4464.77 09:58:51 INFO - PROCESS | 2929 | Values: 1386.5 1453.7 1622.4 1642.3 1651.6 9565.8 9954.7 11296.0 11550.4 11784.7 11423.1 11496.0 11514.9 11517.7 11519.9 2152.5 2198.5 2203.6 2206.7 2215.3 1797.6 2166.1 2167.5 2173.1 2175.5 2410.1 2472.8 2477.3 2486.8 2490.3 2180.5 2346.4 2401.9 2439.2 2439.7 2135.9 2418.3 2424.8 2425.5 2444.1 11580.8 11674.2 11685.8 11689.1 11705.4 5703.8 5865.4 5874.4 5883.5 5905.4 3409.0 3425.3 3512.2 3689.6 3691.3 1185.9 1233.6 1253.0 1256.2 1272.6 15974.3 15982.7 16025.2 16054.2 16066.1 4702.3 4915.8 5006.7 5014.5 5042.5 13775.9 13776.8 13782.7 13784.7 13803.0 6043.2 6105.4 6148.9 6156.4 6197.5 5138.2 5188.1 5191.5 5204.6 5450.7 3556.0 3768.3 3818.4 4028.6 4111.2 951.6 977.9 1037.2 1138.9 1142.9 942.9 978.6 985.4 985.8 988.5 6654.2 6679.1 6876.6 6899.3 7115.6 1008.8 1013.6 1039.0 1072.5 1076.2 3764.5 4487.7 4496.9 4589.0 4629.9 13722.5 14135.7 14165.0 14166.4 14244.3 13346.9 13817.9 14116.4 14141.7 14146.0 10492.6 10754.7 10787.1 10797.4 10821.3 6747.0 7020.3 7163.1 7178.1 7222.5 11890.6 12609.2 12739.6 12918.2 12918.9 12906.5 13028.2 13077.5 13177.4 13216.4 9100.5 9430.5 9599.3 9666.8 9685.4 10692.8 10693.1 10760.0 10798.6 10817.0 9068.5 9081.9 9110.5 9234.3 9277.6 7666.8 8809.9 8852.6 8903.4 8905.6 7991.1 8043.4 8098.6 8145.2 8170.4 5248.5 5921.6 5937.1 6173.4 6211.3 5963.1 6018.7 6090.5 6097.1 6293.6 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | [#4] prototype.html Cycles:180 Average:4551.12 Median:4890.17 stddev:1262.96 (25.8%) stddev-sans-first:1226.90 09:58:51 INFO - PROCESS | 2929 | Values: 370.5 378.0 395.3 397.5 401.7 4579.0 4741.5 4971.6 5012.6 5268.6 4505.0 4511.0 4708.2 4790.7 5013.6 4266.6 4268.7 4281.0 4309.8 4323.1 3340.8 3713.9 4295.5 4297.7 4310.6 3618.7 4114.5 4140.5 4207.8 4241.0 3620.3 4248.0 4249.3 4261.3 4289.9 3442.3 3929.4 3958.4 3966.4 4019.4 4340.6 4405.6 4803.4 4857.4 5079.7 4379.7 4838.2 4927.4 4980.0 4981.3 5161.8 5253.7 5500.9 5522.6 5556.7 4130.5 4351.8 4367.1 4382.0 4508.9 5059.6 5155.6 5629.0 5764.3 5770.9 3964.5 4112.2 4405.4 4551.5 4646.6 4374.6 4727.7 4733.7 4737.7 4778.4 4295.6 4580.9 4604.1 4978.9 5026.7 5069.9 5298.9 5541.5 5590.5 5598.6 1454.0 1565.5 1582.8 1592.4 1624.9 1119.7 1120.1 1177.9 1205.9 1207.8 4686.6 5101.4 5126.9 5148.2 5271.9 4674.2 5123.6 5272.8 5312.6 5656.6 4148.3 4508.4 5023.4 5124.6 5148.8 2734.7 2794.4 2887.3 2963.8 3000.7 5312.5 5405.8 5941.8 5972.7 6038.0 4690.7 4904.9 5200.9 5376.9 5861.5 5808.4 5886.7 6003.9 6004.3 6058.4 4977.8 5325.9 5698.9 5733.8 5760.7 5088.7 5107.4 5590.5 5648.9 5657.8 4864.3 5129.9 5639.3 5686.9 5850.9 3902.2 3950.6 4035.8 4270.5 4420.6 5025.9 5183.9 5397.3 5621.0 5742.9 4435.3 4833.6 5462.6 5567.3 5567.4 4800.8 5056.8 5381.1 5508.7 5574.6 4775.5 4875.4 5055.7 5398.9 5466.8 4933.4 4996.3 5293.9 5460.5 5558.1 5107.8 5420.9 5469.8 5476.9 5498.5 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - PROCESS | 2929 | [#5] yui.html Cycles:180 Average:21227.02 Median:17589.47 stddev:29806.09 (169.5%) stddev-sans-first:29850.18 09:58:51 INFO - PROCESS | 2929 | Values: 786.1 793.2 825.5 854.4 903.2 16259.3 18087.4 18130.1 18154.2 18225.9 16254.0 16310.9 16314.3 16410.3 16513.4 931.1 972.0 993.8 999.1 1041.6 866.5 1019.5 1033.9 1034.2 1034.3 914.3 1063.2 1063.8 1064.8 1066.4 1055.9 1057.2 1057.6 1058.6 1059.9 723.9 726.2 781.5 782.3 784.9 16643.3 16951.0 17493.0 17497.5 17681.5 14652.5 14866.9 14966.2 14991.6 15165.2 10537.7 11974.8 12017.4 12028.3 12572.2 3767.6 3845.1 3889.4 4019.4 4144.8 104321.0 112548.4 113916.0 115020.3 118079.0 11369.3 11653.0 11953.4 12039.0 12200.2 24079.2 24101.7 24130.0 24142.8 24145.8 7939.2 7951.7 8000.1 8497.2 8504.0 4592.2 4677.0 4678.2 4875.0 4876.6 3568.3 3596.4 3681.9 3684.6 3702.3 651.9 656.8 661.4 686.0 686.3 630.7 679.4 700.2 719.4 748.1 10356.3 11051.6 11239.7 11749.9 11929.4 586.4 636.3 647.5 665.2 726.6 5106.9 5261.2 5299.6 5308.5 5314.8 97077.0 101161.5 101968.0 104014.5 105684.4 85290.0 87981.6 88170.6 90392.0 90664.0 57178.9 78979.8 79636.2 80344.2 81040.0 10968.3 11302.2 11350.5 11598.9 11788.2 45984.8 47522.0 48345.0 49694.8 52139.7 68599.3 71402.6 72178.0 74132.6 74524.0 13687.2 13710.5 13777.7 14333.6 14521.0 15289.3 15319.5 15683.1 15775.4 16437.5 14076.8 14455.3 14539.3 14777.5 15220.0 13892.8 14333.4 14515.7 14639.3 14737.3 13798.2 14061.0 14352.5 14468.0 14555.0 9524.9 9804.3 10286.5 10368.6 10431.7 10148.1 10784.0 11751.9 11780.7 11975.0 09:58:51 INFO - PROCESS | 2929 | -------- Summary: end -------- 09:58:51 INFO - PROCESS | 2929 | 09:58:51 INFO - TEST-INFO | 2929: exit 0 09:58:51 INFO - TEST-OK | dromaeo_css | took 1119305ms 09:58:51 INFO - TEST-START | kraken 09:58:51 INFO - operating with platform_type : mac_ 09:58:51 INFO - Initialising browser for kraken test... 09:58:51 INFO - TEST-INFO | started process 2932 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp7Ii_nC/profile http://localhost:63516/getInfo.html) 09:58:54 INFO - PROCESS | 2932 | __metrics Screen width/height:1600/1200 09:58:54 INFO - PROCESS | 2932 | colorDepth:24 09:58:54 INFO - PROCESS | 2932 | Browser inner width/height: 1024/689 09:58:54 INFO - PROCESS | 2932 | __metrics 09:58:54 INFO - PROCESS | 2932 | 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" 09:58:54 INFO - PROCESS | 2932 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:55 INFO - TEST-INFO | 2932: exit 0 09:58:55 INFO - Browser initialized. 09:58:55 INFO - Running cycle 1/1 for kraken test... 09:58:55 INFO - TEST-INFO | started process 2934 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp7Ii_nC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:07 INFO - PROCESS | 2934 | RSS: Main: 165273600 09:59:07 INFO - PROCESS | 2934 | 09:59:09 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:63516/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:10 INFO - PROCESS | 2934 | RSS: Main: 215781376 09:59:10 INFO - PROCESS | 2934 | 09:59:13 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:63516/tests/kraken/driver.html?testName=audio-dft) 09:59:13 INFO - PROCESS | 2934 | RSS: Main: 231014400 09:59:13 INFO - PROCESS | 2934 | 09:59:17 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:63516/tests/kraken/driver.html?testName=audio-fft) 09:59:17 INFO - PROCESS | 2934 | RSS: Main: 328687616 09:59:17 INFO - PROCESS | 2934 | 09:59:19 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:63516/tests/kraken/driver.html?testName=audio-oscillator) 09:59:20 INFO - PROCESS | 2934 | RSS: Main: 230014976 09:59:20 INFO - PROCESS | 2934 | 09:59:22 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:63516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:22 INFO - PROCESS | 2934 | RSS: Main: 231821312 09:59:22 INFO - PROCESS | 2934 | 09:59:25 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:63516/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:26 INFO - PROCESS | 2934 | RSS: Main: 271855616 09:59:26 INFO - PROCESS | 2934 | 09:59:29 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:63516/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:30 INFO - PROCESS | 2934 | RSS: Main: 273276928 09:59:30 INFO - PROCESS | 2934 | 09:59:33 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:63516/tests/kraken/driver.html?testName=json-parse-financial) 09:59:33 INFO - PROCESS | 2934 | RSS: Main: 270004224 09:59:33 INFO - PROCESS | 2934 | 09:59:35 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:63516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:35 INFO - PROCESS | 2934 | RSS: Main: 247570432 09:59:35 INFO - PROCESS | 2934 | 09:59:37 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:38 INFO - PROCESS | 2934 | RSS: Main: 252706816 09:59:38 INFO - PROCESS | 2934 | 09:59:40 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:41 INFO - PROCESS | 2934 | RSS: Main: 254652416 09:59:41 INFO - PROCESS | 2934 | 09:59:44 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:45 INFO - PROCESS | 2934 | RSS: Main: 272785408 09:59:45 INFO - PROCESS | 2934 | 09:59:48 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:48 INFO - PROCESS | 2934 | RSS: Main: 266309632 09:59:48 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | Cycle 1(1): loaded http://localhost:63516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:63516/tests/kraken/driver.html?testName=ai-astar) 09:59:50 INFO - PROCESS | 2934 | RSS: Main: 311463936 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | __start_tp_report 09:59:50 INFO - PROCESS | 2934 | _x_x_mozilla_page_load 09:59:50 INFO - PROCESS | 2934 | _x_x_mozilla_page_load_details 09:59:50 INFO - PROCESS | 2934 | |i|pagename|runs| 09:59:50 INFO - PROCESS | 2934 | |0;ai-astar;105;114;115;114;115;114;115;113;114;116 09:59:50 INFO - PROCESS | 2934 | |1;audio-beat-detection;146;110;110;147;114;109;123;107;129;108 09:59:50 INFO - PROCESS | 2934 | |2;audio-dft;186;185;186;198;185;186;187;185;187;188 09:59:50 INFO - PROCESS | 2934 | |3;audio-fft;84;61;62;95;64;62;59;61;78;63 09:59:50 INFO - PROCESS | 2934 | |4;audio-oscillator;88;71;87;69;71;70;83;69;69;83 09:59:50 INFO - PROCESS | 2934 | |5;imaging-gaussian-blur;87;86;86;86;86;86;87;88;87;86 09:59:50 INFO - PROCESS | 2934 | |6;imaging-darkroom;93;94;94;93;93;94;94;93;94;93 09:59:50 INFO - PROCESS | 2934 | |7;imaging-desaturate;101;140;86;87;84;84;84;86;86;86 09:59:50 INFO - PROCESS | 2934 | |8;json-parse-financial;62;61;59;62;63;62;63;64;63;63 09:59:50 INFO - PROCESS | 2934 | |9;json-stringify-tinderbox;57;60;68;89;89;87;73;58;59;60 09:59:50 INFO - PROCESS | 2934 | |10;stanford-crypto-aes;85;81;102;97;98;68;94;97;96;99 09:59:50 INFO - PROCESS | 2934 | |11;stanford-crypto-ccm;136;147;124;134;137;145;134;136;195;173 09:59:50 INFO - PROCESS | 2934 | |12;stanford-crypto-pbkdf2;161;161;163;163;164;163;164;163;161;160 09:59:50 INFO - PROCESS | 2934 | |13;stanford-crypto-sha256-iterative;64;64;63;64;65;63;64;64;64;64 09:59:50 INFO - PROCESS | 2934 | __end_tp_report 09:59:50 INFO - PROCESS | 2934 | __start_cc_report 09:59:50 INFO - PROCESS | 2934 | _x_x_mozilla_cycle_collect,2066 09:59:50 INFO - PROCESS | 2934 | __end_cc_report 09:59:50 INFO - PROCESS | 2934 | __startTimestamp1493225990605__endTimestamp 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | ------- Summary: start ------- 09:59:50 INFO - PROCESS | 2934 | Number of tests: 14 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:3.10 (2.7%) stddev-sans-first:0.88 09:59:50 INFO - PROCESS | 2934 | Values: 105.0 114.0 115.0 114.0 115.0 114.0 115.0 113.0 114.0 116.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:118.50 stddev:15.51 (13.1%) stddev-sans-first:13.37 09:59:50 INFO - PROCESS | 2934 | Values: 146.0 110.0 110.0 147.0 114.0 109.0 123.0 107.0 129.0 108.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#2] audio-dft Cycles:10 Average:187.30 Median:186.50 stddev:3.89 (2.1%) stddev-sans-first:4.10 09:59:50 INFO - PROCESS | 2934 | Values: 186.0 185.0 186.0 198.0 185.0 186.0 187.0 185.0 187.0 188.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#3] audio-fft Cycles:10 Average:68.90 Median:63.50 stddev:12.33 (19.4%) stddev-sans-first:11.81 09:59:50 INFO - PROCESS | 2934 | Values: 84.0 61.0 62.0 95.0 64.0 62.0 59.0 61.0 78.0 63.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.00 stddev:8.14 (10.6%) stddev-sans-first:7.38 09:59:50 INFO - PROCESS | 2934 | Values: 88.0 71.0 87.0 69.0 71.0 70.0 83.0 69.0 69.0 83.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:86.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 09:59:50 INFO - PROCESS | 2934 | Values: 87.0 86.0 86.0 86.0 86.0 86.0 87.0 88.0 87.0 86.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:59:50 INFO - PROCESS | 2934 | Values: 93.0 94.0 94.0 93.0 93.0 94.0 94.0 93.0 94.0 93.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:86.00 stddev:17.46 (20.3%) stddev-sans-first:18.24 09:59:50 INFO - PROCESS | 2934 | Values: 101.0 140.0 86.0 87.0 84.0 84.0 84.0 86.0 86.0 86.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:63.00 stddev:1.40 (2.2%) stddev-sans-first:1.48 09:59:50 INFO - PROCESS | 2934 | Values: 62.0 61.0 59.0 62.0 63.0 62.0 63.0 64.0 63.0 63.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:13.57 (19.3%) stddev-sans-first:13.56 09:59:50 INFO - PROCESS | 2934 | Values: 57.0 60.0 68.0 89.0 89.0 87.0 73.0 58.0 59.0 60.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:96.50 stddev:10.54 (10.9%) stddev-sans-first:10.90 09:59:50 INFO - PROCESS | 2934 | Values: 85.0 81.0 102.0 97.0 98.0 68.0 94.0 97.0 96.0 99.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:141.00 stddev:21.56 (15.3%) stddev-sans-first:22.56 09:59:50 INFO - PROCESS | 2934 | Values: 136.0 147.0 124.0 134.0 137.0 145.0 134.0 136.0 195.0 173.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:1.42 (0.9%) stddev-sans-first:1.42 09:59:50 INFO - PROCESS | 2934 | Values: 161.0 161.0 163.0 163.0 164.0 163.0 164.0 163.0 161.0 160.0 09:59:50 INFO - PROCESS | 2934 | 09:59:50 INFO - PROCESS | 2934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:59:50 INFO - PROCESS | 2934 | Values: 64.0 64.0 63.0 64.0 65.0 63.0 64.0 64.0 64.0 64.0 09:59:50 INFO - PROCESS | 2934 | -------- Summary: end -------- 09:59:50 INFO - PROCESS | 2934 | 09:59:51 INFO - TEST-INFO | 2934: exit 0 09:59:51 INFO - TEST-OK | kraken | took 59686ms 09:59:51 INFO - SUITE-END | took 1178s 09:59:51 INFO - Completed test suite (00:19:39) 09:59:51 INFO - javascript benchmark 09:59:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7904.131531828828, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3518.208403109301, 3533.416986197277, 3540.911477213068, 3557.8221088945547, 3601.4777857210706, 6109.358517355675, 6166.814995550135, 6170.907436388457, 6171.382861713821, 6178.567500274982, 6155.722992465338, 6214.098955651428, 6234.781782637609, 6247.344028876971, 6247.7813276535335, 5482.972585137079, 5500.779968801243, 5533.6956467394275, 5554.555635549166, 5663.971680141593, 5427.45725427458, 5437.265969094181, 5477.068898287301, 5635.464630860082, 5653.293338332708, 5517.5585953123655, 5535.6955367454775, 5536.252605898213, 5552.250446189753, 5566.55467562594, 5559.8888022239325, 5582.748776305076, 5585.0, 5587.916181257285, 5589.329280486327, 5449.836504904859, 5525.171224316385, 5532.585056120807, 5539.833804985857, 5543.52880005196, 5029.899402011939, 6082.482988945945, 6085.574009819315, 6101.969490152565, 6166.290876549209, 6537.280899101095, 6579.34206579343, 6582.17722784652, 6590.736370545173, 6600.2079750429775, 6640.966795165993, 6665.333466653345, 6706.362895524917, 6707.128073350434, 6718.2945790691765, 6130.642739936431, 6241.407066328691, 6321.589096708699, 6323.27282362525, 6325.399087086719, 6536.117624120778, 6701.832454188684, 6768.72925083001, 6830.31696830313, 6855.451563874878, 6502.382273683992, 6522.445592124723, 6525.836854078686, 6545.37818907203, 6547.672616369163, 6623.635700036448, 6633.767818126343, 6704.731810727614, 6704.83237919056, 6714.52998290115, 6250.968745156245, 6293.2762732285455, 6461.127747753993, 6475.287718350977, 6485.4811615070685, 6242.2509298883515, 6274.6235225885675, 6291.748330066837, 6301.212348456443, 6570.145881035435, 5227.921581176285, 5245.160774276097, 5308.840734777963, 5329.813456529003, 5336.62643614951, 4752.667313288037, 4792.329073929653, 4819.831305904347, 4820.783064762094, 4827.517248275144, 6263.123162757218, 6268.09112678659, 6293.590916590407, 6295.842603934938, 6296.181496405438, 6305.747770089237, 6323.9683801580695, 6542.607443553402, 6628.072069910217, 6642.767503137367, 6236.376362363818, 6241.75032998684, 6256.155419018374, 6282.120503129566, 6282.434580887651, 5795.739191736382, 5822.126680997884, 5857.531397488191, 5871.55963302754, 5895.174675545427, 6475.449586785176, 6479.902801458076, 6864.862702746017, 6894.586324820527, 6903.75836845708, 5508.091164957737, 6391.648459334781, 6406.327335629878, 6420.0, 6422.357764223727, 6559.311272316338, 6570.704318305592, 6821.283765204582, 6868.587884726932, 6879.140107486564, 6516.055172000129, 6548.738050478118, 6560.376764207393, 6581.564821016254, 6587.077809106633, 6634.767783127568, 6643.435307998681, 6647.069410282467, 6670.7665231716655, 6677.3656502632175, 6198.163247961648, 6238.0, 6337.9366206337345, 6409.647469389229, 6489.643069631215, 6385.744570217325, 6444.387783160592, 6445.097686323825, 6445.903311450238, 6454.451371633464, 6309.274433440213, 6338.144350512622, 6342.7145778441, 6365.649889256136, 6462.256840463218, 6231.532635052298, 6240.687965601611, 6442.065900444503, 6442.291347951628, 6457.4511166551365, 6194.349593292639, 6279.623222606659, 6331.715072821642, 6340.968295158679, 6344.4290013897125], "value": 6061.42746977898, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.9354054905333, 811.5536454949776, 827.6275675945824, 908.1508789282021, 915.5285028210469, 28905.56641650377, 40635.59364406355, 40703.98240044001, 40738.0, 40800.59199408005, 41595.79202103993, 41741.0, 41744.0, 41808.581914180846, 41848.790756046175, 7737.226277372246, 9444.197243234315, 9610.183134433546, 9613.182879455255, 9614.471204083773, 7831.4909530880595, 11590.65228043156, 11643.243189192675, 11670.766584668301, 11670.8249376259, 10292.588296468133, 11482.368469734161, 11744.941275293611, 11776.411179441036, 11801.94099029508, 11750.177487575831, 11803.23278986863, 11806.645800625909, 11808.881911180864, 11809.822852657217, 11361.715957101056, 11403.201775875692, 11409.60066397672, 11413.771724565546, 11427.371494567795, 39876.80061599673, 39973.80013099945, 39996.0, 40071.7996410019, 40102.799486002674, 3731.8134093295225, 4063.8577649782114, 4104.302268614343, 4134.793260336971, 4153.335466325373, 27836.16491505258, 28244.576331355045, 28818.42363152746, 29937.40125197484, 30381.088567343017, 3152.0701393088866, 3240.9189770255934, 3286.572745543088, 3356.3622911646708, 3373.2241584435474, 345344.54655453376, 348459.0, 363163.0, 363488.18255908816, 364429.0, 51887.0, 51889.74055129776, 51895.221571676455, 51975.48024519782, 52012.21981670278, 54397.0, 54617.453825462035, 54735.17897231465, 54745.72627136839, 54822.0, 15322.846771532364, 15442.45951391696, 15444.845551544566, 15452.5364239073, 15464.845351546566, 11819.940900295443, 11976.0, 13172.209667419986, 13188.878945289758, 13200.273984930729, 10627.149828013895, 11798.587049453228, 12003.63989080329, 12117.27296362221, 12214.26714397139, 4541.6593755468475, 5304.92042619361, 5332.33345831771, 5364.168553874156, 5371.597130215171, 1106.5062166075734, 1112.6828853776635, 1127.2954403497813, 1215.428748488209, 1220.0300760895109, 26735.866320668272, 26823.731762682513, 27113.593296100575, 27192.59211111835, 27256.454870902868, 1069.3583849690278, 1090.6400887707039, 1244.6701624069628, 1245.6698974771693, 1312.2809120052762, 13228.14017088886, 13375.53185638498, 13439.0, 13486.932565337307, 13503.459861605623, 339407.0, 340437.0, 340540.0, 340871.0, 341625.0, 50917.74541127345, 51032.0, 51053.0, 51099.0, 51191.0, 1425.1520345394474, 1436.1526699247495, 1488.047649504318, 1496.5061529695174, 1501.6020754500066, 24355.0, 25406.618900716134, 25422.745772542778, 25529.0, 25553.744462555882, 42406.36390454207, 42466.78766606147, 42524.0, 42533.0, 42678.0, 310367.0, 310863.0, 311555.0, 312324.0, 313719.0, 29498.0, 29955.0, 31782.0, 31826.204344890637, 31907.883224087047, 32521.260055093968, 32737.836310818293, 37859.432108517845, 39661.60338396579, 41452.58547414487, 24395.634065488677, 32428.0, 33134.668653314126, 33501.497477538345, 33722.83138584292, 32941.84703535461, 32957.17607059747, 33572.49641255432, 34354.656453436146, 34378.48432273468, 29895.0, 40644.593554065264, 41572.58427415687, 41667.0, 41672.166556669305, 33515.83242083774, 33869.491957620165, 34351.797687080834, 35046.299074017865, 35171.12072198215, 23848.807559621604, 25668.486630267664, 26888.731112688623, 27181.59227611548, 27221.59167612527], "value": 18773.565697455404, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.3708700839085, 389.70187806328164, 399.5465147058088, 430.33942897652094, 472.3057106054099, 13615.659608509792, 15590.830687698426, 22165.445863853412, 22345.664815027787, 22780.658290125662, 22593.322200334016, 23230.88384558075, 23452.29643110705, 24148.275551733477, 24346.90438930248, 5976.252968378953, 7116.359527642511, 7271.600061996588, 7276.781696549086, 7295.16105647852, 6880.311968803129, 7088.326608972166, 7117.466190035768, 7204.3155900189395, 7205.675744591506, 6987.965060174717, 7195.928040719578, 7198.02826618405, 7203.027591275163, 7208.351248387644, 7006.404455621253, 7124.8931266030795, 7175.533590316665, 7176.569405835667, 7179.46154038444, 6872.965635171792, 6915.135608048994, 6990.021397004423, 6994.2656021117555, 6995.930040699579, 28384.006559770514, 28389.0, 28443.573346399822, 28471.85764071187, 28803.0, 2964.43675701616, 2979.2700788307, 3038.924026899323, 3063.463893818595, 3087.861046252924, 17013.65972680552, 17016.48950531486, 17216.827831721646, 17255.137243137793, 18417.987010714405, 2177.7822217778253, 2185.8797766122857, 2201.5376770878133, 2209.6133176694016, 2214.3799736073925, 147485.2625736875, 148112.0, 148339.0, 150530.003815829, 151011.24494377567, 20180.69728954067, 20777.896110519352, 21748.347549573537, 21781.802000890104, 22164.800174580556, 35455.11362215914, 35881.82059089688, 36283.4557481638, 36338.45492317617, 36343.72906438433, 10782.838257426145, 11005.61480348184, 11258.21192516516, 11263.943680281545, 11369.602063927723, 8949.328800340001, 8961.969373522128, 8993.14565116313, 9102.954485227532, 9105.453672779655, 10292.639757608598, 10597.523111460003, 10695.625653102104, 10719.303245289031, 10760.139188864872, 3450.654934506529, 4307.8492252771, 4342.869713908588, 4348.2825333819565, 4362.17118747437, 1108.700650824273, 1129.220837622038, 1132.4824734855333, 1151.7061204953825, 1183.2545496337252, 23484.0, 23604.66336519861, 23750.168744093873, 23765.405864853517, 23794.0, 1137.806572882612, 1147.6958605969426, 1160.3560024186488, 1177.6231605886035, 1201.3572738584814, 10527.157827373792, 11973.40132993347, 12281.750181771162, 12420.441080151235, 12596.622101336974, 775529.0, 778079.0, 783732.0, 821526.0, 826277.0, 116738.41630791791, 134681.0, 135843.32078339742, 139064.0, 143468.28265858605, 1197.7185361440054, 1231.6428235811513, 1296.4490091711173, 1314.850932017812, 1339.8794108530278, 18097.914125152533, 18793.530161746065, 19344.613107737485, 20709.79290207139, 20809.895950520757, 66024.42645816426, 66246.0, 66315.0, 66348.6682566584, 67937.30156745923, 93815.53092234496, 94981.5250923741, 95347.52326238324, 97384.0, 97962.0, 7326.267373262845, 9969.451680157661, 11200.551977920792, 11389.373584452935, 11950.402479876146, 12270.75458490843, 13178.538751143664, 13218.471261149447, 13641.727165456437, 13706.314684265946, 11377.374244416636, 11474.082073434272, 11603.013743831869, 11875.346855923008, 11921.82117268259, 9326.207272381653, 10588.258821882395, 10664.733381665521, 10751.731206719582, 11080.889191107986, 6613.338666133348, 11676.124290678403, 11773.411329433666, 12099.697507562381, 12131.393430328271, 11401.714957125807, 11622.70943226426, 11913.82129268079, 11945.283283003047, 12023.879761202275, 11299.548018079513, 11459.255148415326, 11592.362420066976, 11715.355655438692, 11811.82282265784], "value": 12073.770537436547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.542440994472, 1453.6583902782847, 1622.3672767620624, 1642.2691902103566, 1651.6201273707054, 9565.808683826319, 9954.701358959224, 11295.983361497463, 11550.422478876064, 11784.705382365446, 11423.086153107752, 11496.0, 11514.942425287862, 11517.654470365902, 11519.884801151986, 2152.494163871489, 2198.48335641125, 2203.592335417945, 2206.7020952171492, 2215.28003398896, 1797.63148554546, 2166.1335465813645, 2167.5339801942578, 2173.1307477009163, 2175.5213852952324, 2410.0600765701392, 2472.8021758259297, 2477.293971218194, 2486.78862296705, 2490.252924122765, 2180.5420861619, 2346.3664810501155, 2401.891914863835, 2439.1706819681394, 2439.7194322652945, 2135.9466013349634, 2418.3349578865955, 2424.806015518754, 2425.4906469641396, 2444.1201167579657, 11580.76838463226, 11674.182807203415, 11685.766284674344, 11689.123315751267, 11705.414729263503, 5703.800366987177, 5865.442782935615, 5874.441928016831, 5883.529317654577, 5905.43898329658, 3409.0, 3425.3320602482527, 3512.209752805624, 3689.631036896289, 3691.335559599271, 1185.9326606054533, 1233.5682511121126, 1253.0414233111676, 1256.1772039314264, 1272.5673271087874, 15974.28115734783, 15982.68034639324, 16025.19874006295, 16054.197290135564, 16066.116363599996, 4702.255346533156, 4915.8033678652455, 5006.69959802413, 5014.473480284591, 5042.520960508746, 13775.862241377457, 13776.793348099787, 13782.724345513034, 13784.724305514033, 13803.0, 6043.184170136975, 6105.389461053948, 6148.877022459616, 6156.353582873823, 6197.4732147767045, 5138.229265610188, 5188.092083885305, 5191.506806853343, 5204.583633309327, 5450.672959622435, 3555.9644403555635, 3768.2840260350445, 3818.3771896943686, 4028.637422631977, 4111.157212771434, 951.6145960885852, 977.9070988256104, 1037.1858091398217, 1138.9259698119595, 1142.8628564572305, 942.8727121838601, 978.6427953796955, 985.3545927417553, 985.8225519406576, 988.5057471264367, 6654.168228971379, 6679.098321726505, 6876.587404755731, 6899.275576064441, 7115.608641524663, 1008.7541885771067, 1013.5945621751358, 1039.0, 1072.5012869015945, 1076.2036093290908, 3764.4729737836724, 4487.708298960557, 4496.887577810516, 4589.0, 4629.884252893705, 13722.519711810039, 14135.717285654435, 14165.0, 14166.433342666383, 14244.287785610679, 13346.933265333611, 13817.861821381657, 14116.435342586386, 14141.71716565663, 14146.0, 10492.632757853438, 10754.73113172177, 10787.083097936764, 10797.406142662228, 10821.29661572011, 6747.0, 7020.262872398529, 7163.10461192351, 7178.138623365229, 7222.494425390172, 11890.583829565923, 12609.243445393306, 12739.61781146567, 12918.160319579198, 12918.870811292143, 12906.483740650268, 13028.218306901616, 13077.542286019943, 13177.407016684081, 13216.405261763435, 9100.499472529074, 9430.481323527272, 9599.280053996117, 9666.75833104178, 9685.370450920667, 10692.786144277226, 10693.09108725767, 10760.0, 10798.56805727762, 10817.0, 9068.455892646462, 9081.861159492411, 9110.453372797654, 9234.30742694314, 9277.582508787256, 7666.846663066819, 8809.867851982353, 8852.557372131496, 8903.376763626484, 8905.599248033725, 7991.120976692443, 8043.436959413019, 8098.635561399633, 8145.185481451807, 8170.387220958333, 5248.475152484721, 5921.5558833086825, 5937.079752638348, 6173.351798061319, 6211.3478084800445, 5963.105534169736, 6018.729157188025, 6090.543209259235, 6097.085437184458, 6293.590916590407], "value": 5262.753396682083, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4517314374725, 377.98110094495286, 395.29045363572385, 397.5229724330802, 401.65056400931184, 4578.969731810341, 4741.478437371895, 4971.577415919646, 5012.644057293066, 5268.576454830778, 4504.954950450495, 4510.962478629917, 4708.199606066968, 4790.676307274399, 5013.6490445668815, 4266.5946735060115, 4268.7225330353585, 4281.0, 4309.784510774464, 4323.070539833935, 3340.8329583520726, 3713.8885833424906, 4295.548967358429, 4297.699161058727, 4310.633596144316, 3618.710503159754, 4114.526829414625, 4140.540756419994, 4207.831686732527, 4240.9821642805655, 3620.31214069326, 4248.044190057243, 4249.32010878258, 4261.252886316626, 4289.914201715964, 3442.3115376924466, 3929.3713005918917, 3958.4062390641348, 3966.36538153894, 4019.3569028955226, 4340.620944394542, 4405.559444055601, 4803.351547541072, 4857.392825896763, 5079.6952182869145, 4379.715318504287, 4838.201696720037, 4927.3638603347035, 4980.0, 4981.302617633534, 5161.767720452589, 5253.711045892474, 5500.917486237709, 5522.5581953443625, 5556.666600003972, 4130.463039804837, 4351.847685331029, 4367.104743527601, 4382.0, 4508.864734057984, 5059.62052846038, 5155.561777248939, 5629.0, 5764.279465066867, 5770.88458230833, 3964.5440774311323, 4112.194318403048, 4405.405270288534, 4551.4765801932535, 4646.581807637329, 4374.58441448062, 4727.739974301447, 4733.721895088376, 4737.692050016738, 4778.354922085544, 4295.591918767712, 4580.862574122782, 4604.056168485453, 4978.850634480971, 5026.693059804477, 5069.923951140736, 5298.894022119536, 5541.5289700375115, 5590.456342364215, 5598.552115830724, 1453.9636509087356, 1565.506865337415, 1582.849629285216, 1592.4314550168076, 1624.8781341399206, 1119.652907598647, 1120.1207052463776, 1177.8998785103363, 1205.932749516684, 1207.8067509198486, 4686.5782079613, 5101.438841727407, 5126.871828204325, 5148.150555158431, 5271.920921186185, 4674.205385084544, 5123.6157288202785, 5272.841814745564, 5312.601554883399, 5656.5757568181725, 4148.274052040881, 4508.413906192174, 5023.422306434733, 5124.564412024945, 5148.786022010571, 2734.7128551502205, 2794.413173233603, 2887.321479452327, 2963.807352522122, 3000.6549246836894, 5312.5484333832055, 5405.7837686492885, 5941.792037278675, 5972.701364931736, 6038.0, 4690.671652984258, 4904.901901961941, 5200.869978250574, 5376.91934620981, 5861.479563787612, 5808.39011903744, 5886.676232807236, 6003.9286446176, 6004.3395226525045, 6058.4244496772735, 4977.789325884712, 5325.946740532545, 5698.914516282176, 5733.770649173986, 5760.654360738369, 5088.669236499616, 5107.361579802525, 5590.456342364133, 5648.893837343426, 5657.755293835349, 4864.318995340726, 5129.871103492009, 5639.295088113986, 5686.886262274648, 5850.853728656818, 3902.20991990728, 3950.6246906543834, 4035.838566457426, 4270.466191726035, 4420.624246938917, 5025.899482010413, 5183.870403239949, 5397.302847549441, 5621.0, 5742.885142297214, 4435.3125265583885, 4833.637477189154, 5462.617616766947, 5567.32768271224, 5567.415421380859, 4800.823283743166, 5056.84829455117, 5381.058314794817, 5508.697021663847, 5574.609777315549, 4775.5224477551965, 4875.43932447773, 5055.69665820052, 5398.892022159614, 5466.753996070266, 4933.432655244693, 4996.325496058131, 5293.947060529345, 5460.453954604508, 5558.110702287615, 5107.770150343169, 5420.864478388072, 5469.781208751605, 5476.890462190654, 5498.45015498447], "value": 4190.067234125228, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.0567319216938, 793.2147174297445, 825.5046971816906, 854.3933806997031, 903.2367649336309, 16259.34962601496, 18087.3773302871, 18130.09349532523, 18154.183061762218, 18225.908870455663, 16254.024758514497, 16310.939788913742, 16314.347426102942, 16410.261538230778, 16513.422030228943, 931.1340453378356, 971.9611215551387, 993.8173573447574, 999.1357475783432, 1041.5677493840046, 866.4974314897376, 1019.4902548725637, 1033.8655974723276, 1034.2450011491615, 1034.3483605328634, 914.309696179387, 1063.2344711807486, 1063.840423936408, 1064.7817197474499, 1066.4454483668487, 1055.8680164979378, 1057.1648397765755, 1057.6139709006234, 1058.560697310615, 1059.8569193158903, 723.855228954206, 726.1576571177461, 781.5427974634846, 782.3193821375382, 784.8822676598498, 16643.33426662932, 16951.0, 17493.0, 17497.47507574775, 17681.469555913343, 14652.487162949352, 14866.88498362627, 14966.17686027268, 14991.625209369744, 15165.24173791306, 10537.736556586147, 11974.842265790816, 12017.399130043463, 12028.27830330183, 12572.239886415817, 3767.618629612246, 3845.0771814764257, 3889.3776995680555, 4019.397090436458, 4144.834206631731, 104321.0, 112548.43725781319, 113916.0, 115020.27469587963, 118078.99999999914, 11369.31784092957, 11653.0, 11953.40232988347, 12039.0, 12200.205956828635, 24079.157229496883, 24101.674407907383, 24130.0, 24142.7585724144, 24145.758542414704, 7939.20607939213, 7951.721689740947, 8000.079990801132, 8497.150284971452, 8504.022037465647, 4592.196365636, 4677.017826256524, 4678.228092364721, 4874.95125048745, 4876.634252431082, 3568.286342731464, 3596.4245720684567, 3681.9079523011605, 3684.5578530575967, 3702.333579955634, 651.9478441724746, 656.8193746719691, 661.4476911778622, 686.0395446375015, 686.2519853359862, 630.6562923206864, 679.3715812873072, 700.2157583506404, 719.4496210399049, 748.1433758346662, 10356.275060745675, 11051.613193538187, 11239.719007024727, 11749.941250293865, 11929.403529823474, 586.4047991288845, 636.2555809702659, 647.5370110371107, 665.1785045468843, 726.5531698005794, 5106.948930510722, 5261.242941232188, 5299.6290259681455, 5308.46915308466, 5314.813981510629, 97077.0292297082, 101161.49419253004, 101968.0, 104014.47992759988, 105684.41473377905, 85290.0, 87981.56009219913, 88170.55914720513, 90392.0, 90664.0, 57178.85642287131, 78979.8153027705, 79636.20363796288, 80344.19655803367, 81040.0, 10968.341899486057, 11302.208845380745, 11350.54597816078, 11598.94200528992, 11788.174827762317, 45984.770076149405, 47522.04955900932, 48345.0, 49694.75152624214, 52139.73930130325, 68599.31400686128, 71402.64298678473, 72178.0, 74132.62933685297, 74524.0, 13687.178769273478, 13710.52013179534, 13777.655558611115, 14333.56999290023, 14520.98353115314, 15289.295396336209, 15319.540413787605, 15683.137427441145, 15775.370496497238, 16437.506874793777, 14076.78884816749, 14455.277236137941, 14539.27303634793, 14777.482788102365, 15220.01069930451, 13892.791608125684, 14333.426662933784, 14515.709685806436, 14639.341229644479, 14737.263136842901, 13798.17210967345, 14061.01572889888, 14352.49766258176, 14467.987240893457, 14555.0, 9524.85712714296, 9804.264680148875, 10286.485675716334, 10368.585256589651, 10431.68704938853, 10148.067533971594, 10784.0, 11751.941240293743, 11780.70548236301, 11975.0], "value": 8047.947570678116, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1434.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 113.0, 114.0, 116.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 110.0, 147.0, 114.0, 109.0, 123.0, 107.0, 129.0, 108.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 186.0, 198.0, 185.0, 186.0, 187.0, 185.0, 187.0, 188.0], "value": 187.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 62.0, 95.0, 64.0, 62.0, 59.0, 61.0, 78.0, 63.0], "value": 68.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 87.0, 69.0, 71.0, 70.0, 83.0, 69.0, 69.0, 83.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 86.0, 86.0, 87.0, 88.0, 87.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 140.0, 86.0, 87.0, 84.0, 84.0, 84.0, 86.0, 86.0, 86.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 59.0, 62.0, 63.0, 62.0, 63.0, 64.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 68.0, 89.0, 89.0, 87.0, 73.0, 58.0, 59.0, 60.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 102.0, 97.0, 98.0, 68.0, 94.0, 97.0, 96.0, 99.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 147.0, 124.0, 134.0, 137.0, 145.0, 134.0, 136.0, 195.0, 173.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 163.0, 164.0, 163.0, 164.0, 163.0, 161.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 65.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}]}]} 09:59:51 INFO - Return code: 0 09:59:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:51 INFO - # TBPL SUCCESS # 09:59:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:59:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:59:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:59:51 INFO - 2017-04-26 09:59:51.932 screenresolution[2938:49256] starting screenresolution argv=screenresolution get 09:59:51 INFO - 2017-04-26 09:59:51.934 screenresolution[2938:49256] Display 0: 1600x1200x32@60 09:59:51 INFO - 2017-04-26 09:59:51.940 screenresolution[2939:49259] starting screenresolution argv=screenresolution list 09:59:51 INFO - Available Modes on Display 0 09:59:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:59:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:59:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:59:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:59:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:59:52 INFO - Intel Iris: 09:59:52 INFO - Chipset Model: Intel Iris 09:59:52 INFO - Type: GPU 09:59:52 INFO - Bus: Built-In 09:59:52 INFO - VRAM (Dynamic, Max): 1536 MB 09:59:52 INFO - Vendor: Intel (0x8086) 09:59:52 INFO - Device ID: 0x0a2e 09:59:52 INFO - Revision ID: 0x0009 09:59:52 INFO - Displays: 09:59:52 INFO - Display: 09:59:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:59:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:59:52 INFO - Display Serial Number: 1600x1200 60 09:59:52 INFO - Main Display: Yes 09:59:52 INFO - Mirror: Off 09:59:52 INFO - Online: Yes 09:59:52 INFO - Rotation: Supported 09:59:52 INFO - Return code: 0 09:59:52 INFO - Running post-action listener: _resource_record_post_action 09:59:52 INFO - [mozharness: 2017-04-26 16:59:52.179756Z] Finished run-tests step (success) 09:59:52 INFO - Running post-run listener: _resource_record_post_run 09:59:52 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 393728; Write bytes: 421981184; Read time: 10; Write time: 2050 09:59:52 INFO - TinderboxPrint: CPU usage
54.0% 09:59:52 INFO - TinderboxPrint: I/O read bytes / time
393,728 / 10 09:59:52 INFO - TinderboxPrint: I/O write bytes / time
421,981,184 / 2,050 09:59:52 INFO - TinderboxPrint: CPU idle
2,198.3 (46.0%) 09:59:52 INFO - TinderboxPrint: CPU system
957.9 (20.1%) 09:59:52 INFO - TinderboxPrint: CPU user
1,621.4 (33.9%) 09:59:52 INFO - TinderboxPrint: Swap in / out
121,831,424 / 0 09:59:52 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121383424; Write bytes: 113922048; Read time: 11003; Write time: 227 09:59:52 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 278528; Write bytes: 297905152; Read time: 3; Write time: 1792 09:59:52 INFO - Running post-run listener: _upload_blobber_files 09:59:52 INFO - Blob upload gear active. 09:59:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:52 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 09:59:52 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'] 09:59:52 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 09:59:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:59:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:59:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:54 INFO - (blobuploader) - INFO - Done attempting. 09:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:55 INFO - (blobuploader) - INFO - Done attempting. 09:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:56 INFO - (blobuploader) - INFO - Done attempting. 09:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:58 INFO - (blobuploader) - INFO - Done attempting. 09:59:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:58 INFO - Return code: 0 09:59:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e79642654976a9ee121988e041357be1772211aae41d2d74a66750cd0cd2395a11263c8dab56f8b3f6faa9778bdc9c473cd12f4f70bc354d910158a2a0a8b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c60d646bbc3608a0ee3970fa7a2960fbef416c4907e95e7fb5113eff6e70049770e0797bcf102341ad2553aab6a00ad31a112c620491d8843514c9c617c4fd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24e946df55e6c4901e9732809bc221f2f59409b5a35aa56b702a1a97842980813168c6277fc4c179c029c52c0f10c453cfb9f433744ee9ca11315d085efdfe79", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37aa2ff702fb34533b86bd0480508224f0d8cc832e3ae8981b08e9dd5d4e0ae3f4b8e0e44b9169f23377be096b2b86685381fc5d4b00e01f6d9cedbcf087309c"} 09:59:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:58 INFO - Contents: 09:59:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e79642654976a9ee121988e041357be1772211aae41d2d74a66750cd0cd2395a11263c8dab56f8b3f6faa9778bdc9c473cd12f4f70bc354d910158a2a0a8b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c60d646bbc3608a0ee3970fa7a2960fbef416c4907e95e7fb5113eff6e70049770e0797bcf102341ad2553aab6a00ad31a112c620491d8843514c9c617c4fd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24e946df55e6c4901e9732809bc221f2f59409b5a35aa56b702a1a97842980813168c6277fc4c179c029c52c0f10c453cfb9f433744ee9ca11315d085efdfe79", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37aa2ff702fb34533b86bd0480508224f0d8cc832e3ae8981b08e9dd5d4e0ae3f4b8e0e44b9169f23377be096b2b86685381fc5d4b00e01f6d9cedbcf087309c"} 09:59:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:58 INFO - Copying logs to upload dir... 09:59:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.521106 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-26 09:59:58.848024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 09:59:58.851730) ========= 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.IyVCL1kBDK/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.hGM2svmm3m/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/e79642654976a9ee121988e041357be1772211aae41d2d74a66750cd0cd2395a11263c8dab56f8b3f6faa9778bdc9c473cd12f4f70bc354d910158a2a0a8b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c60d646bbc3608a0ee3970fa7a2960fbef416c4907e95e7fb5113eff6e70049770e0797bcf102341ad2553aab6a00ad31a112c620491d8843514c9c617c4fd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24e946df55e6c4901e9732809bc221f2f59409b5a35aa56b702a1a97842980813168c6277fc4c179c029c52c0f10c453cfb9f433744ee9ca11315d085efdfe79", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37aa2ff702fb34533b86bd0480508224f0d8cc832e3ae8981b08e9dd5d4e0ae3f4b8e0e44b9169f23377be096b2b86685381fc5d4b00e01f6d9cedbcf087309c"} build_url:https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/IVFFx4AZTlWC4ihe0rEHPQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e79642654976a9ee121988e041357be1772211aae41d2d74a66750cd0cd2395a11263c8dab56f8b3f6faa9778bdc9c473cd12f4f70bc354d910158a2a0a8b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c60d646bbc3608a0ee3970fa7a2960fbef416c4907e95e7fb5113eff6e70049770e0797bcf102341ad2553aab6a00ad31a112c620491d8843514c9c617c4fd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24e946df55e6c4901e9732809bc221f2f59409b5a35aa56b702a1a97842980813168c6277fc4c179c029c52c0f10c453cfb9f433744ee9ca11315d085efdfe79", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37aa2ff702fb34533b86bd0480508224f0d8cc832e3ae8981b08e9dd5d4e0ae3f4b8e0e44b9169f23377be096b2b86685381fc5d4b00e01f6d9cedbcf087309c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 09:59:58.887252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:59:58.887580) ========= 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.IyVCL1kBDK/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.hGM2svmm3m/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005075 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 09:59:58.936345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 09:59:58.936690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 09:59:58.937080) ========= ========= Total master_lag: 0.19 =========