builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0079 starttime: 1493143130.45 results: success (0) buildid: 20170425093027 builduid: 869ce8a7a58e4626a64ef6bb8aa221d0 revision: df76fe132d4fa5c7e1356bed6a435d4f83fae1bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.454807) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.455270) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.455556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.482583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.482891) ========= 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.85yGcpqIzF/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.7VcDJkiAnj/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-25 10:58:50-- 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% 157M=0s 2017-04-25 10:58:50 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129882 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.638141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.641504) ========= 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.85yGcpqIzF/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.7VcDJkiAnj/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.029220 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:50.693345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 10:58:50.693672) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev df76fe132d4fa5c7e1356bed6a435d4f83fae1bb --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 df76fe132d4fa5c7e1356bed6a435d4f83fae1bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.85yGcpqIzF/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.7VcDJkiAnj/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-25 10:58:50,800 truncating revision to first 12 chars 2017-04-25 10:58:50,800 Setting DEBUG logging. 2017-04-25 10:58:50,800 attempt 1/10 2017-04-25 10:58:50,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/df76fe132d4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 10:58:52,506 unpacking tar archive at: mozilla-beta-df76fe132d4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.979051 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 10:58:52.699675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:52.700071) ========= script_repo_revision: df76fe132d4fa5c7e1356bed6a435d4f83fae1bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:52.700604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:52.700922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 10:58:52.722063) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 10:58:52.722405) ========= /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.85yGcpqIzF/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.7VcDJkiAnj/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:58:52 INFO - MultiFileLogger online at 20170425 10:58:52 in /builds/slave/test 10:58:52 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 10:58:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:52 INFO - {'append_to_log': False, 10:58:52 INFO - 'base_work_dir': '/builds/slave/test', 10:58:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:58:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:52 INFO - 'branch': 'Mozilla-Beta', 10:58:52 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:52 INFO - 'config_files': ('talos/mac_config.py',), 10:58:52 INFO - 'default_actions': ('clobber', 10:58:52 INFO - 'read-buildbot-config', 10:58:52 INFO - 'download-and-extract', 10:58:52 INFO - 'populate-webroot', 10:58:52 INFO - 'create-virtualenv', 10:58:52 INFO - 'install', 10:58:52 INFO - 'run-tests'), 10:58:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:52 INFO - 'download_minidump_stackwalk': True, 10:58:52 INFO - 'download_symbols': 'ondemand', 10:58:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:52 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:52 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:52 INFO - 'gecko_profile': False, 10:58:52 INFO - 'gecko_profile_interval': 0, 10:58:52 INFO - 'installer_path': 'installer.exe', 10:58:52 INFO - 'log_level': 'info', 10:58:52 INFO - 'log_name': 'talos', 10:58:52 INFO - 'log_to_console': True, 10:58:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:58:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:58:52 INFO - 'opt_config_files': (), 10:58:52 INFO - 'pip_index': False, 10:58:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:58:52 INFO - 'cmd': ('bash', 10:58:52 INFO - '-c', 10:58:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:58:52 INFO - 'enabled': True, 10:58:52 INFO - 'halt_on_failure': False, 10:58:52 INFO - 'name': 'check_screen_resolution'},), 10:58:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:58:52 INFO - 'cmd': ('bash', 10:58:52 INFO - '-c', 10:58:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:58:52 INFO - 'enabled': True, 10:58:52 INFO - 'halt_on_failure': False, 10:58:52 INFO - 'name': 'check_screen_resolution'},), 10:58:52 INFO - 'run_cmd_checks_enabled': True, 10:58:52 INFO - 'suite': 'dromaeojs', 10:58:52 INFO - 'system_bits': '32', 10:58:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:52 INFO - 'title': 't-yosemite-r7-0079', 10:58:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:52 INFO - 'use_talos_json': True, 10:58:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:52 INFO - 'work_dir': 'build'} 10:58:52 INFO - [mozharness: 2017-04-25 17:58:52.941689Z] Running clobber step. 10:58:52 INFO - Running pre-action listener: _resource_record_pre_action 10:58:52 INFO - Running main action method: clobber 10:58:52 INFO - rmtree: /builds/slave/test/build 10:58:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:55 INFO - Running post-action listener: _resource_record_post_action 10:58:55 INFO - [mozharness: 2017-04-25 17:58:55.347093Z] Finished clobber step (success) 10:58:55 INFO - [mozharness: 2017-04-25 17:58:55.347308Z] Running read-buildbot-config step. 10:58:55 INFO - Running pre-action listener: _resource_record_pre_action 10:58:55 INFO - Running main action method: read_buildbot_config 10:58:55 INFO - Using buildbot properties: 10:58:55 INFO - { 10:58:55 INFO - "project": "", 10:58:55 INFO - "product": "firefox", 10:58:55 INFO - "script_repo_revision": "production", 10:58:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:58:55 INFO - "repository": "", 10:58:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:58:55 INFO - "buildid": "20170425093027", 10:58:55 INFO - "pgo_build": "False", 10:58:55 INFO - "basedir": "/builds/slave/test", 10:58:55 INFO - "buildnumber": 9, 10:58:55 INFO - "slavename": "t-yosemite-r7-0079", 10:58:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:58:55 INFO - "platform": "yosemite_r7", 10:58:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:58:55 INFO - "branch": "mozilla-beta", 10:58:55 INFO - "repo_path": "releases/mozilla-beta", 10:58:55 INFO - "revision": "df76fe132d4fa5c7e1356bed6a435d4f83fae1bb", 10:58:55 INFO - "stage_platform": "macosx64", 10:58:55 INFO - "builduid": "869ce8a7a58e4626a64ef6bb8aa221d0", 10:58:55 INFO - "slavebuilddir": "test" 10:58:55 INFO - } 10:58:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:58:55 INFO - Running post-action listener: _resource_record_post_action 10:58:55 INFO - [mozharness: 2017-04-25 17:58:55.353109Z] Finished read-buildbot-config step (success) 10:58:55 INFO - [mozharness: 2017-04-25 17:58:55.353341Z] Running download-and-extract step. 10:58:55 INFO - Running pre-action listener: _resource_record_pre_action 10:58:55 INFO - Running main action method: download_and_extract 10:58:55 INFO - mkdir: /builds/slave/test/build/tests 10:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:55 INFO - trying https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:58:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/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 10:58:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/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 10:58:56 INFO - Downloaded 1165 bytes. 10:58:56 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:58:56 INFO - Using the following test package requirements: 10:58:56 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:58:56 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:58:56 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:58:56 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:58:56 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:58:56 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:58:56 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:58:56 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:58:56 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:58:56 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:58:56 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:58:56 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:58:56 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:58:56 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:58:56 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:58:56 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:58:56 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:58:56 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:58:58 INFO - Expected file size: 51223047 10:58:58 INFO - Obtained file size: 51223047 10:59:14 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 10:59:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:59:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:59:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:59:16 INFO - Expected file size: 51223047 10:59:16 INFO - Obtained file size: 51223047 10:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:59:32 INFO - Expected file size: 14404449 10:59:32 INFO - Obtained file size: 14404449 10:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:33 INFO - trying https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:59:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/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 10:59:34 INFO - Downloaded 59533601 bytes. 10:59:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:59:34 INFO - mkdir: /builds/slave/test/properties 10:59:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:59:34 INFO - Writing to file /builds/slave/test/properties/build_url 10:59:34 INFO - Contents: 10:59:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:59:35 INFO - Running post-action listener: _resource_record_post_action 10:59:35 INFO - Running post-action listener: set_extra_try_arguments 10:59:35 INFO - [mozharness: 2017-04-25 17:59:35.489443Z] Finished download-and-extract step (success) 10:59:35 INFO - [mozharness: 2017-04-25 17:59:35.489598Z] Running populate-webroot step. 10:59:35 INFO - Running pre-action listener: _resource_record_pre_action 10:59:35 INFO - Running main action method: populate_webroot 10:59:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:59:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:59:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:59:35 INFO - '--tppagecycles', 10:59:35 INFO - '7'], 10:59:35 INFO - 'tests': ['tsvgm']}}, 10:59:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:59:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:59:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:59:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:59:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:59:35 INFO - 'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:59:35 INFO - 'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['damp', 'tps']}, 10:59:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:59:35 INFO - 'tests': ['damp', 'tps']}, 10:59:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['dromaeo_dom']}, 10:59:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['basic_compositor_video']}, 10:59:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:59:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['a11yr', 10:59:35 INFO - 'ts_paint', 10:59:35 INFO - 'tpaint', 10:59:35 INFO - 'sessionrestore', 10:59:35 INFO - 'sessionrestore_no_auto_restore', 10:59:35 INFO - 'tabpaint']}, 10:59:35 INFO - 'other-e10s': {'tests': ['a11yr', 10:59:35 INFO - 'ts_paint', 10:59:35 INFO - 'tpaint', 10:59:35 INFO - 'sessionrestore', 10:59:35 INFO - 'sessionrestore_no_auto_restore', 10:59:35 INFO - 'tabpaint']}, 10:59:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:59:35 INFO - 'ts_paint', 10:59:35 INFO - 'tpaint', 10:59:35 INFO - 'sessionrestore', 10:59:35 INFO - 'sessionrestore_no_auto_restore', 10:59:35 INFO - 'tabpaint']}, 10:59:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:59:35 INFO - 'ts_paint', 10:59:35 INFO - 'tpaint', 10:59:35 INFO - 'sessionrestore', 10:59:35 INFO - 'sessionrestore_no_auto_restore', 10:59:35 INFO - 'tabpaint']}, 10:59:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['a11yr', 10:59:35 INFO - 'ts_paint', 10:59:35 INFO - 'tpaint', 10:59:35 INFO - 'sessionrestore', 10:59:35 INFO - 'sessionrestore_no_auto_restore', 10:59:35 INFO - 'tabpaint']}, 10:59:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['a11yr', 10:59:35 INFO - 'ts_paint', 10:59:35 INFO - 'tpaint', 10:59:35 INFO - 'sessionrestore', 10:59:35 INFO - 'sessionrestore_no_auto_restore', 10:59:35 INFO - 'tabpaint']}, 10:59:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['tsvgx', 10:59:35 INFO - 'tsvgr_opacity', 10:59:35 INFO - 'tart', 10:59:35 INFO - 'tscrollx', 10:59:35 INFO - 'cart', 10:59:35 INFO - 'tsvg_static']}, 10:59:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:59:35 INFO - 'tsvgr_opacity', 10:59:35 INFO - 'tart', 10:59:35 INFO - 'tscrollx', 10:59:35 INFO - 'cart', 10:59:35 INFO - 'tsvg_static']}, 10:59:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:59:35 INFO - 'talos_options': ['--disable-e10s'], 10:59:35 INFO - 'tests': ['tp5o']}, 10:59:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:59:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:59:35 INFO - 'talos_options': ['--disable-e10s', 10:59:35 INFO - '--xperf_path', 10:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:35 INFO - 'tests': ['tp5n']}, 10:59:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:59:35 INFO - 'talos_options': ['--xperf_path', 10:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:35 INFO - 'tests': ['tp5n']}}, 10:59:35 INFO - 'talos.zip': {'path': '', 10:59:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:59:35 INFO - Running post-action listener: _resource_record_post_action 10:59:35 INFO - [mozharness: 2017-04-25 17:59:35.507873Z] Finished populate-webroot step (success) 10:59:35 INFO - [mozharness: 2017-04-25 17:59:35.508001Z] Running create-virtualenv step. 10:59:35 INFO - Running pre-action listener: _resource_record_pre_action 10:59:35 INFO - Running main action method: create_virtualenv 10:59:35 INFO - Creating virtualenv /builds/slave/test/build/venv 10:59:35 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 10:59:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:59:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:35 INFO - Using real prefix '/tools/python27' 10:59:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:59:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:39 INFO - Installing pip.................done. 10:59:39 INFO - Return code: 0 10:59:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:59:39 INFO - Reading from file tmpfile_stdout 10:59:39 INFO - Output received: 10:59:39 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) 10:59:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:39 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:59:39 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 10:59:39 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 10:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 10:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:39 INFO - 'HOME': '/Users/cltbld', 10:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:39 INFO - 'LOGNAME': 'cltbld', 10:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:39 INFO - 'MOZ_NO_REMOTE': '1', 10:59:39 INFO - 'NO_EM_RESTART': '1', 10:59:39 INFO - 'PAGER': '/bin/cat', 10:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:39 INFO - 'PWD': '/builds/slave/test', 10:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:39 INFO - 'SHELL': '/bin/bash', 10:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 10:59:39 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:39 INFO - 'USER': 'cltbld', 10:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:39 INFO - 'XPC_FLAGS': '0x0', 10:59:39 INFO - 'XPC_SERVICE_NAME': '0', 10:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:39 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 10:59:39 INFO - Cleaning up... 10:59:39 INFO - Return code: 0 10:59:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:39 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:59:39 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 10:59:39 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 10:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 10:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:39 INFO - 'HOME': '/Users/cltbld', 10:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:39 INFO - 'LOGNAME': 'cltbld', 10:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:39 INFO - 'MOZ_NO_REMOTE': '1', 10:59:39 INFO - 'NO_EM_RESTART': '1', 10:59:39 INFO - 'PAGER': '/bin/cat', 10:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:39 INFO - 'PWD': '/builds/slave/test', 10:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:39 INFO - 'SHELL': '/bin/bash', 10:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 10:59:39 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:39 INFO - 'USER': 'cltbld', 10:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:39 INFO - 'XPC_FLAGS': '0x0', 10:59:39 INFO - 'XPC_SERVICE_NAME': '0', 10:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:40 INFO - Downloading/unpacking psutil>=3.1.1 10:59:40 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 10:59:40 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 10:59:40 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 10:59:40 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 10:59:40 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 10:59:40 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 10:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:43 INFO - Installing collected packages: psutil 10:59:43 INFO - Running setup.py install for psutil 10:59:43 INFO - building 'psutil._psutil_osx' extension 10:59:43 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 10:59:44 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 10:59:44 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 10:59:44 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 10:59:44 INFO - building 'psutil._psutil_posix' extension 10:59:44 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 10:59:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:59:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:59:44 INFO - ^ 10:59:44 INFO - 1 warning generated. 10:59:44 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 10:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:44 INFO - Successfully installed psutil 10:59:44 INFO - Cleaning up... 10:59:44 INFO - Return code: 0 10:59:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 10:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:44 INFO - 'HOME': '/Users/cltbld', 10:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:44 INFO - 'LOGNAME': 'cltbld', 10:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:44 INFO - 'MOZ_NO_REMOTE': '1', 10:59:44 INFO - 'NO_EM_RESTART': '1', 10:59:44 INFO - 'PAGER': '/bin/cat', 10:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:44 INFO - 'PWD': '/builds/slave/test', 10:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:44 INFO - 'SHELL': '/bin/bash', 10:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 10:59:44 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:44 INFO - 'USER': 'cltbld', 10:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:44 INFO - 'XPC_FLAGS': '0x0', 10:59:44 INFO - 'XPC_SERVICE_NAME': '0', 10:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:45 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 10:59:45 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 10:59:45 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 10:59:45 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 10:59:45 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 10:59:45 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 10:59:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:48 INFO - Installing collected packages: mozsystemmonitor 10:59:48 INFO - Running setup.py install for mozsystemmonitor 10:59:48 INFO - Successfully installed mozsystemmonitor 10:59:48 INFO - Cleaning up... 10:59:48 INFO - Return code: 0 10:59:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59:48 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')]} 10:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:48 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')]} 10:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:48 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:59:48 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 10:59:48 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 10:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 10:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:48 INFO - 'HOME': '/Users/cltbld', 10:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:48 INFO - 'LOGNAME': 'cltbld', 10:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:48 INFO - 'MOZ_NO_REMOTE': '1', 10:59:48 INFO - 'NO_EM_RESTART': '1', 10:59:48 INFO - 'PAGER': '/bin/cat', 10:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:48 INFO - 'PWD': '/builds/slave/test', 10:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:48 INFO - 'SHELL': '/bin/bash', 10:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 10:59:48 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:48 INFO - 'USER': 'cltbld', 10:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:48 INFO - 'XPC_FLAGS': '0x0', 10:59:48 INFO - 'XPC_SERVICE_NAME': '0', 10:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:48 INFO - Downloading/unpacking jsonschema==2.5.1 10:59:48 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 10:59:48 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 10:59:48 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 10:59:48 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 10:59:48 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 10:59:48 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 10:59:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:51 INFO - warning: no files found matching '*.txt' 10:59:51 INFO - no previously-included directories found matching 'build' 10:59:51 INFO - no previously-included directories found matching 'dist' 10:59:51 INFO - no previously-included directories found matching '.git*' 10:59:51 INFO - Installing collected packages: jsonschema, functools32 10:59:52 INFO - Running setup.py install for functools32 10:59:52 INFO - warning: no files found matching '*.txt' 10:59:52 INFO - no previously-included directories found matching 'build' 10:59:52 INFO - no previously-included directories found matching 'dist' 10:59:52 INFO - no previously-included directories found matching '.git*' 10:59:52 INFO - Successfully installed jsonschema functools32 10:59:52 INFO - Cleaning up... 10:59:52 INFO - Return code: 0 10:59:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:52 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:59:52 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 10:59:52 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 10:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 10:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:52 INFO - 'HOME': '/Users/cltbld', 10:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:52 INFO - 'LOGNAME': 'cltbld', 10:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:52 INFO - 'MOZ_NO_REMOTE': '1', 10:59:52 INFO - 'NO_EM_RESTART': '1', 10:59:52 INFO - 'PAGER': '/bin/cat', 10:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:52 INFO - 'PWD': '/builds/slave/test', 10:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:52 INFO - 'SHELL': '/bin/bash', 10:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 10:59:52 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:52 INFO - 'USER': 'cltbld', 10:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:52 INFO - 'XPC_FLAGS': '0x0', 10:59:52 INFO - 'XPC_SERVICE_NAME': '0', 10:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:52 INFO - Cleaning up... 10:59:52 INFO - Return code: 0 10:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:52 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:59:52 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 10:59:52 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 10:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 10:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:52 INFO - 'HOME': '/Users/cltbld', 10:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:52 INFO - 'LOGNAME': 'cltbld', 10:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:52 INFO - 'MOZ_NO_REMOTE': '1', 10:59:52 INFO - 'NO_EM_RESTART': '1', 10:59:52 INFO - 'PAGER': '/bin/cat', 10:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:52 INFO - 'PWD': '/builds/slave/test', 10:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:52 INFO - 'SHELL': '/bin/bash', 10:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 10:59:52 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:52 INFO - 'USER': 'cltbld', 10:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:52 INFO - 'XPC_FLAGS': '0x0', 10:59:52 INFO - 'XPC_SERVICE_NAME': '0', 10:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:55 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 10:59:55 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 10:59:55 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 10:59:55 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 10:59:55 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 10:59:55 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 10:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:56 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 10:59:56 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 10:59:56 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 10:59:56 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 10:59:56 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 10:59:56 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 10:59:56 INFO - Downloading docopt-0.6.1.tar.gz 10:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:56 INFO - Running setup.py install for blobuploader 10:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:56 INFO - Running setup.py install for requests 10:59:57 INFO - Running setup.py install for docopt 10:59:57 INFO - Successfully installed blobuploader requests docopt 10:59:57 INFO - Cleaning up... 10:59:57 INFO - Return code: 0 10:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:57 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:59:57 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 10:59:57 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 10:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 10:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:57 INFO - 'HOME': '/Users/cltbld', 10:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:57 INFO - 'LOGNAME': 'cltbld', 10:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:57 INFO - 'MOZ_NO_REMOTE': '1', 10:59:57 INFO - 'NO_EM_RESTART': '1', 10:59:57 INFO - 'PAGER': '/bin/cat', 10:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:57 INFO - 'PWD': '/builds/slave/test', 10:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:57 INFO - 'SHELL': '/bin/bash', 10:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 10:59:57 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:57 INFO - 'USER': 'cltbld', 10:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:57 INFO - 'XPC_FLAGS': '0x0', 10:59:57 INFO - 'XPC_SERVICE_NAME': '0', 10:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:57 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-pQgsV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:57 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9AloDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:57 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-sNV8al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-CaQFDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-kwpE8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-URkzzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-MZ_INs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-8NQVXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-y5Oi5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-gHJ99H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Oopzfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:58 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-fiV6CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:59 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yvzZyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:59 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-sbV9wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:59 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-iEyw63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:59 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-7M225A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:59 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-xIt1Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:59 INFO - Running setup.py install for manifestparser 10:59:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:59 INFO - Running setup.py install for mozcrash 10:59:59 INFO - Running setup.py install for mozdebug 10:59:59 INFO - Running setup.py install for mozdevice 11:00:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Running setup.py install for mozfile 11:00:00 INFO - Running setup.py install for mozhttpd 11:00:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Running setup.py install for mozinfo 11:00:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Running setup.py install for mozInstall 11:00:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:00:00 INFO - Running setup.py install for mozleak 11:00:00 INFO - Running setup.py install for mozlog 11:00:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:00:01 INFO - Running setup.py install for moznetwork 11:00:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:00:01 INFO - Running setup.py install for mozprocess 11:00:01 INFO - Running setup.py install for mozprofile 11:00:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:00:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:00:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:00:01 INFO - Running setup.py install for mozrunner 11:00:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:00:01 INFO - Running setup.py install for mozscreenshot 11:00:01 INFO - Running setup.py install for moztest 11:00:01 INFO - Running setup.py install for mozversion 11:00:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:00:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:02 INFO - Cleaning up... 11:00:02 INFO - Return code: 0 11:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:02 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 11:00:02 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 11:00:02 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 11:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 11:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:02 INFO - 'HOME': '/Users/cltbld', 11:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:02 INFO - 'LOGNAME': 'cltbld', 11:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:02 INFO - 'MOZ_NO_REMOTE': '1', 11:00:02 INFO - 'NO_EM_RESTART': '1', 11:00:02 INFO - 'PAGER': '/bin/cat', 11:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:02 INFO - 'PWD': '/builds/slave/test', 11:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:02 INFO - 'SHELL': '/bin/bash', 11:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 11:00:02 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:02 INFO - 'USER': 'cltbld', 11:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:02 INFO - 'XPC_FLAGS': '0x0', 11:00:02 INFO - 'XPC_SERVICE_NAME': '0', 11:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:02 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-MV2LbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:02 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)) 11:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:02 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4TQacm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:02 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)) 11:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:02 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Jzxcmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:02 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)) 11:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:02 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-tiamF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:02 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)) 11:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:02 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-3C0nOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:02 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)) 11:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:02 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-t9X0ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Jji15X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-jEWuYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-u9wcVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-jBmw4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-e1x2g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-gQuG2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-SKpXSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-rMFi6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:03 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)) 11:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:03 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-dv36ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:04 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)) 11:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:04 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Q4e88x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:04 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)) 11:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:04 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-6eIb4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:04 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)) 11:00:04 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)) 11:00:04 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)) 11:00:04 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)) 11:00:04 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)) 11:00:04 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)) 11:00:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:06 INFO - Downloading blessings-1.6.tar.gz 11:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:07 INFO - Installing collected packages: blessings 11:00:07 INFO - Running setup.py install for blessings 11:00:07 INFO - Successfully installed blessings 11:00:07 INFO - Cleaning up... 11:00:07 INFO - Return code: 0 11:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:07 INFO - Reading from file tmpfile_stdout 11:00:07 INFO - Current package versions: 11:00:07 INFO - blessings == 1.6 11:00:07 INFO - blobuploader == 1.2.4 11:00:07 INFO - docopt == 0.6.1 11:00:07 INFO - functools32 == 3.2.3-2 11:00:07 INFO - jsonschema == 2.5.1 11:00:07 INFO - manifestparser == 1.1 11:00:07 INFO - mozInstall == 1.12 11:00:07 INFO - mozcrash == 1.0 11:00:07 INFO - mozdebug == 0.1 11:00:07 INFO - mozdevice == 0.49 11:00:07 INFO - mozfile == 1.2 11:00:07 INFO - mozhttpd == 0.7 11:00:07 INFO - mozinfo == 0.9 11:00:07 INFO - mozleak == 0.1 11:00:07 INFO - mozlog == 3.4 11:00:07 INFO - moznetwork == 0.27 11:00:07 INFO - mozprocess == 0.25 11:00:07 INFO - mozprofile == 0.28 11:00:07 INFO - mozrunner == 6.13 11:00:07 INFO - mozscreenshot == 0.1 11:00:07 INFO - mozsystemmonitor == 0.3 11:00:07 INFO - moztest == 0.8 11:00:07 INFO - mozversion == 1.4 11:00:07 INFO - psutil == 3.1.1 11:00:07 INFO - requests == 1.2.3 11:00:07 INFO - wsgiref == 0.1.2 11:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:07 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')]} 11:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:07 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')]} 11:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:07 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 11:00:07 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 11:00:07 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 11:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 11:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:07 INFO - 'HOME': '/Users/cltbld', 11:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:07 INFO - 'LOGNAME': 'cltbld', 11:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:07 INFO - 'MOZ_NO_REMOTE': '1', 11:00:07 INFO - 'NO_EM_RESTART': '1', 11:00:07 INFO - 'PAGER': '/bin/cat', 11:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:07 INFO - 'PWD': '/builds/slave/test', 11:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:07 INFO - 'SHELL': '/bin/bash', 11:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 11:00:07 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:07 INFO - 'USER': 'cltbld', 11:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:07 INFO - 'XPC_FLAGS': '0x0', 11:00:07 INFO - 'XPC_SERVICE_NAME': '0', 11:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 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)) 11:00:07 INFO - Cleaning up... 11:00:07 INFO - Return code: 0 11:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:00:07 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')]} 11:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:07 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')]} 11:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:07 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 0x103697b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10369a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb858d6d220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, '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.85yGcpqIzF/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.7VcDJkiAnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 11:00:07 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 11:00:07 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 11:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 11:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:07 INFO - 'HOME': '/Users/cltbld', 11:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:07 INFO - 'LOGNAME': 'cltbld', 11:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:07 INFO - 'MOZ_NO_REMOTE': '1', 11:00:07 INFO - 'NO_EM_RESTART': '1', 11:00:07 INFO - 'PAGER': '/bin/cat', 11:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:07 INFO - 'PWD': '/builds/slave/test', 11:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:07 INFO - 'SHELL': '/bin/bash', 11:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 11:00:07 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:07 INFO - 'USER': 'cltbld', 11:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:07 INFO - 'XPC_FLAGS': '0x0', 11:00:07 INFO - 'XPC_SERVICE_NAME': '0', 11:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:00:08 INFO - Cleaning up... 11:00:08 INFO - Return code: 0 11:00:08 INFO - Running post-action listener: _resource_record_post_action 11:00:08 INFO - Running post-action listener: _start_resource_monitoring 11:00:08 INFO - Starting resource monitoring. 11:00:08 INFO - [mozharness: 2017-04-25 18:00:08.134536Z] Finished create-virtualenv step (success) 11:00:08 INFO - [mozharness: 2017-04-25 18:00:08.135488Z] Running install step. 11:00:08 INFO - Running pre-action listener: _resource_record_pre_action 11:00:08 INFO - Running main action method: install 11:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:08 INFO - Reading from file tmpfile_stdout 11:00:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:00:08 INFO - Reading from file tmpfile_stdout 11:00:08 INFO - Output received: 11:00:08 INFO - Usage: mozinstall [options] installer 11:00:08 INFO - Options: 11:00:08 INFO - -h, --help show this help message and exit 11:00:08 INFO - -d DEST, --destination=DEST 11:00:08 INFO - Directory to install application into. [default: 11:00:08 INFO - "/builds/slave/test"] 11:00:08 INFO - --app=APP Application being installed. [default: firefox] 11:00:08 INFO - mkdir: /builds/slave/test/build/application 11:00:08 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'] 11:00:08 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 11:00:23 INFO - Reading from file tmpfile_stdout 11:00:23 INFO - Output received: 11:00:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:00:23 INFO - Running post-action listener: _resource_record_post_action 11:00:23 INFO - [mozharness: 2017-04-25 18:00:23.526747Z] Finished install step (success) 11:00:23 INFO - [mozharness: 2017-04-25 18:00:23.526859Z] Running run-tests step. 11:00:23 INFO - Running pre-action listener: _resource_record_pre_action 11:00:23 INFO - Running main action method: run_tests 11:00:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:00:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:00:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:00:23 INFO - 2017-04-25 11:00:23.541 screenresolution[1629:7303] starting screenresolution argv=screenresolution get 11:00:23 INFO - 2017-04-25 11:00:23.544 screenresolution[1629:7303] Display 0: 1600x1200x32@60 11:00:23 INFO - 2017-04-25 11:00:23.549 screenresolution[1630:7305] starting screenresolution argv=screenresolution list 11:00:23 INFO - Available Modes on Display 0 11:00:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:00:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:00:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:00:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:00:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:00:23 INFO - Intel Iris: 11:00:23 INFO - Chipset Model: Intel Iris 11:00:23 INFO - Type: GPU 11:00:23 INFO - Bus: Built-In 11:00:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:00:23 INFO - Vendor: Intel (0x8086) 11:00:23 INFO - Device ID: 0x0a2e 11:00:23 INFO - Revision ID: 0x0009 11:00:23 INFO - Displays: 11:00:23 INFO - Display: 11:00:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:00:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:00:23 INFO - Display Serial Number: 1600x1200 60 11:00:23 INFO - Main Display: Yes 11:00:23 INFO - Mirror: Off 11:00:23 INFO - Online: Yes 11:00:23 INFO - Rotation: Supported 11:00:23 INFO - Return code: 0 11:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:00:23 INFO - Python 2.7.3 11:00:23 INFO - Return code: 0 11:00:23 INFO - grabbing minidump binary from tooltool 11:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:23 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 0x103475d30>, '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 0x10339cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10346abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:00:23 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 11:00:23 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 11:00:23 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 11:00:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:23 INFO - Return code: 0 11:00:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:00:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:00:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:00:23 INFO - ENV: RUST_BACKTRACE is now 1 11:00:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:00:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:00:23 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/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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 11:00:23 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/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --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 11:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.85yGcpqIzF/Render', 11:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:23 INFO - 'HOME': '/Users/cltbld', 11:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:23 INFO - 'LOGNAME': 'cltbld', 11:00:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:00:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:23 INFO - 'MOZ_NO_REMOTE': '1', 11:00:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:00:23 INFO - 'NO_EM_RESTART': '1', 11:00:23 INFO - 'PAGER': '/bin/cat', 11:00:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:23 INFO - 'PWD': '/builds/slave/test', 11:00:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:23 INFO - 'RUST_BACKTRACE': '1', 11:00:23 INFO - 'SHELL': '/bin/bash', 11:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7VcDJkiAnj/Listeners', 11:00:23 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:23 INFO - 'USER': 'cltbld', 11:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:23 INFO - 'XPC_FLAGS': '0x0', 11:00:23 INFO - 'XPC_SERVICE_NAME': '0', 11:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:23 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/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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 11:00:24 INFO - mozversion application_buildid: 20170425093027 11:00:24 INFO - mozversion application_changeset: df76fe132d4fa5c7e1356bed6a435d4f83fae1bb 11:00:24 INFO - mozversion application_display_name: Firefox 11:00:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:24 INFO - mozversion application_name: Firefox 11:00:24 INFO - mozversion application_remotingname: firefox 11:00:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:00:24 INFO - mozversion application_vendor: Mozilla 11:00:24 INFO - mozversion application_version: 54.0 11:00:24 INFO - mozversion platform_buildid: 20170425093027 11:00:24 INFO - mozversion platform_changeset: df76fe132d4fa5c7e1356bed6a435d4f83fae1bb 11:00:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:00:24 INFO - mozversion platform_version: 54.0 11:00:24 INFO - using testdate: 1493143224 11:00:24 INFO - actual date: 1493143224 11:00:24 INFO - starting webserver on 'localhost:49236' 11:00:24 INFO - SUITE-START | Running 2 tests 11:00:24 INFO - TEST-START | dromaeo_css 11:00:24 INFO - operating with platform_type : mac_ 11:00:24 INFO - Initialising browser for dromaeo_css test... 11:00:24 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp0oBAJa/profile http://localhost:49236/getInfo.html) 11:00:26 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 11:00:26 INFO - PROCESS | 1640 | colorDepth:24 11:00:26 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 11:00:26 INFO - PROCESS | 1640 | __metrics 11:00:26 INFO - PROCESS | 1640 | 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" 11:00:26 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:00:27 INFO - TEST-INFO | 1640: exit 0 11:00:27 INFO - Browser initialized. 11:00:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:27 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp0oBAJa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:39 INFO - PROCESS | 1643 | RSS: Main: 165257216 11:00:39 INFO - PROCESS | 1643 | 11:03:43 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 11:03:45 INFO - PROCESS | 1643 | RSS: Main: 380121088 11:03:45 INFO - PROCESS | 1643 | 11:06:49 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 11:06:49 INFO - PROCESS | 1643 | RSS: Main: 304259072 11:06:49 INFO - PROCESS | 1643 | 11:09:52 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 11:09:53 INFO - PROCESS | 1643 | RSS: Main: 272445440 11:09:53 INFO - PROCESS | 1643 | 11:12:55 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 11:12:56 INFO - PROCESS | 1643 | RSS: Main: 278814720 11:12:56 INFO - PROCESS | 1643 | 11:15:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 11:16:00 INFO - PROCESS | 1643 | RSS: Main: 263327744 11:16:00 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 11:19:03 INFO - PROCESS | 1643 | RSS: Main: 346443776 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | __start_tp_report 11:19:03 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 11:19:03 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 11:19:03 INFO - PROCESS | 1643 | |i|pagename|runs| 11:19:03 INFO - PROCESS | 1643 | |0;dojo.html;3088.1198858325374;3295.9452975047984;3575.964240357596;3594.263176048907;3616.656417640325;6175.505959523233;6200.720967556459;6207.627542347463;6222.5021998240145;6249.12512248285;6195.721192546335;6250.656213908233;6252.437280644741;6276.717547710353;6288.276848162463;5500.779968801253;5509.3664228613625;5551.694656793895;5588.21764952907;5647.265855438787;5434.483724046229;5456.781728730846;5505.03661859175;5641.210230567724;5642.689652069134;5566.777328906839;5587.05020146574;5587.217789509472;5608.831735047955;5613.270274864262;5619.325680918275;5636.436356364372;5637.971810140964;5640.802571909963;5648.689322087304;5363.061464243741;5425.327441694552;5545.251391062196;5562.2212890195;5635.295588051494;6130.336988993121;6140.907886381708;6146.7541298348015;6230.408111229426;6237.594556353823;6630.602163870183;6639.402453779183;6649.168853893263;6663.600183988928;6668;6616.470682345401;6647.767328143492;6737.225219099817;6738.191417029988;6744.460443164535;6117.319130932566;6174.228221472316;6281.685915704196;6333.873322533524;6389.1694079769795;6800.149981252343;6812.795616131524;6816;6818.795436136924;6833.384995350442;6438.227412710505;6470.579412338183;6496.252930912911;6516.348365163541;6523.7064332105165;6414.486841052704;6458.935410645928;6630.370114839083;6656.36764507371;6668.066470694107;6571.244306904671;6586.27550969393;6599.670016499252;6600.73597056122;6605.339466053356;6293.30773614902;6348.904766428507;6355.523335749837;6421.422072013448;6425.967870160619;5035.647504674711;5231.24146998683;5290.206469029677;5296.576273898079;5323.866903327448;4803.807847686124;4812.759362031885;4831.637627177975;4843.055604157155;4846.07924494352;6108.755649774048;6313.9368606314265;6326.4622507087415;6328.557001009885;6335.4931605472375;6501.869962600722;6535.248446428626;6565.638889861008;6578;6685.832854178684;6302.306746257908;6305.747770089237;6324.209473815773;6324.3043265240785;6339.492840572743;5807.506361959281;5836.970815145897;5844.473997340175;5864.237649105589;5876.6180198286975;6610.504212184009;6618;6786.966065169642;6802.965985170043;6902.068220790129;6688.83277918056;6694.732210711712;6704.966475167593;6706.631135287606;6712.865742685217;6808.897866531907;6869.416099631388;6888.104546408935;6908.171019477695;6928.272531384132;6331.366863313632;6388.1376014237485;6417.550771445954;6433.388828061326;6529.706163222571;5005.549500544968;6489.059086432347;6501.707423166064;6503.154589903283;6509.218893732783;5877.294724633071;6062.151298818081;6400.039994000937;6466.515011374072;6491.870162596816;6484.740610375532;6501.284858665448;6511.023346498063;6512.3162067982175;6528.543001989815;6371.904421433589;6388.584741991755;6401.519886008475;6402.199725034371;6412.198475190601;6145.139680444652;6183.752649894134;6382.457491113308;6397.744090236339;6508.60948343101;6253.812385628256;6268.655223962726;6292.1505596743855;6327.557071004985;6356 11:19:03 INFO - PROCESS | 1643 | |1;ext.html;804.8913396691446;821.1501096365262;883.6818745251708;892.8749975003497;981.4700061966538;38413.42379864301;39071.60928390715;39270.60729392705;40988;41074.178516429725;39335.803320983425;39591;39621.40567891484;39629.801850990705;39726.60273397265;7979.601019949008;8032.598370081472;8132.268095871385;8269.62786674601;11814.527418903233;11811.527538898434;11931.821022684666;11957.222780519282;11961.58134465294;11966.22219555726;11855.525778968831;11879.406029698524;11924.284542927453;11951.521939122425;11995.64013079609;11869.050475961945;11914.523419063227;11929.880701192964;11931.463084161234;11934.462949167222;11531.25046871959;11589.652310430616;11606.129540284428;11614.954654081173;11617.825732614017;41070.79464602658;41291.96770080772;41381.96545086367;41410.1717965642;41419;4032.334664780308;4082.6121518455698;4091.8158682859344;4120.608542188487;4124.360724087771;24612.876935615386;28620.856895715595;29005;30449.847750761324;31175;3190.7766456348063;3273.099897528175;3284.998075586945;3377.5946886373545;3396.6263710992016;331309;335151;335189;335297;335804.32097839355;41431.378529322086;44711.776441118236;47286.763566182635;51764;53302;55863.720681396335;55925.72037139788;56026.719866401225;56040;56088.43911560914;15297.617559560877;15385.384584616713;15395.769063464057;15414.922925385301;15416;13073.869261307455;13126.474941002443;13128.277944713132;13145.342732863319;13224.074314798065;12426.875731242753;12437.378131093408;12456.564020259248;12537.185082969578;12609.49562017509;4656.604188644003;5609.5792815539;5610.158476228598;5614.214010038598;5614.85962850932;994.8607194992707;1149.166854030821;1168.6201984355118;1207.9154459187773;1211.3550853024863;27081.729182708314;29412.38231897266;31957.36085278328;33468.832655836566;33521.329573408395;1179.3572502985894;1186.549111337686;1203.5306230569909;1220.6338098570393;1236.313845815563;8404.20160084791;8594.52730099838;8667.696630618024;8684.56577171139;8757.430767000253;505034;506560;507204;507985;508335;60445;60881.69559152264;60903;61050;61233;1443.7112577484545;1497.5956491747386;1564.1631727025986;1567.0675947811035;1580.913049782273;30262;31523.842380787948;31596.368072637957;31775.36449271048;32020.51969220417;49253;49594.25608615801;49710.75144624254;49731.00537989292;49748.00503989973;471331;474101;474218;474380;474622.6268868634;28606.856965715036;30640;31675.366492669556;33210.83394583012;36758.89723308305;36754.448683270304;44282.3357649642;45758;45938.621841344815;47333.7633311845;31326.277054762206;31533.8423307882;31796;32163.51754723634;32833.67166328402;26347.473050539265;31974.040778776674;31980.20049498781;32050.03849884507;32681;37243.25513489769;37996.81001594974;38043;38052.23895522129;38196.236075278895;25798.355041124123;28769.56845647359;30659.240668339957;31797.841010794797;31811;23420.06319747191;24658.260252192464;24920.435054183105;25121.623175652014;25158.993640254186 11:19:03 INFO - PROCESS | 1643 | |2;jquery.html;431.21949271817994;435.66236166970594;437.7001753798648;443.820252797617;448.9785737447307;20391.592168156647;21485.462863428424;21538.353849384504;22545.436364090907;22828;22019.559608807813;22995.885020574875;23588.88205558974;23626;23918.28245152644;6578.210614726239;6863.279355667658;6876.449884009292;7445;7762;7321.158066822304;7821.921780782176;7860.921390786076;7865.68537258509;7898.05223373196;7713.537187768724;7775.222477752208;7786.987691600084;7790.571518566477;7802.180771019046;7604.695812167479;7660.961695191516;7697.26875946787;7783.688652453895;7784.766457006299;7216.603086830222;7479.887801682979;7501.512401693873;7540.8114797129965;7648.196939321347;26000.479990400276;26170.6074408884;27153.321166970985;27195.048173314037;27547.724522754717;2978.955315670267;2986.4325778102093;3098.7366073883745;3126.7498600112162;3194.5847039884666;15598.688026239524;16023.198840058067;16325.510234692978;16333.183340832911;16853.073080980543;2062.257587268582;2071.829416379756;2075.356639441778;2095.7904209579074;2105.368389483149;152609;153287;158141.4185858138;160319;162103.37896621;16246.593835154215;19985.30051448192;20027.09878055491;20082.288890999822;20177.899110504648;31285.904993325123;31583.52624710631;31850.681493185235;31910.680893190773;31932.201694957814;9501.907280662674;10252.794944101077;10476.895231047745;10678.1991350649;10816.242862999672;8573.356998225157;8954.910450895408;8974.775630609287;8982.056884027214;9160.083991600919;9114.81770364589;9215.95392023049;9309.767255818524;9330.95334523323;9337.206337461255;3209.51857221414;3894.5521265054313;3921.509841250769;4000.7999600019884;4010.799460026987;750.9711694977915;834.3533761334893;893.3433926064338;920.2316066084894;928.1646518133733;19272.710909336372;19371.159739824696;20537.691934620994;21099.68350474744;21119;870.7431307764225;919.9586018629178;937.1846493550654;944.6835310171169;952.9666461673808;6826.658667066627;6908.516403851782;6941.34057264559;7078.079849619619;7186.461015423864;435636;437031.81484092376;556919;564893;700227;119321;124888.37555812162;157657;164960;166152;1241.4289426863743;1307.5423601739506;1320.577415227118;1322.3388305847077;1330.7272009238084;18458.907705461923;19642.80357196467;19721;19734.210631574577;19747.802521974598;63761.68119159374;64400.677996611594;65315;65741.67129164323;65799;92614;93258;93587.53206233925;93593;95345.52327238319;10039.598416063567;11070.5571777128;11084.584751718505;11099.723531793947;11287.266327688674;11993.160478766402;12018.579349722717;12065.396730163282;12198.207116537396;12499.75000500003;10973.341599503736;11587.710307242387;11596.94201528987;11673.824892626448;11706.88293117092;10450.895491044992;10507.94746026265;10509.842352364567;10605.46972651349;10893.019628233496;11009.119270458184;11431.942840285745;11720.355380454157;11772.352520611448;11775.293482391084;7730.574818384818;10615.575376985144;10966.890331096905;11462.254953428;11540.307581545134;9422.717318480456;10998.560057597606;11117.555297787998;11230.83153752678;11356.94321528387 11:19:03 INFO - PROCESS | 1643 | |3;mootools.html;1409.626448991017;1616.3534586165533;1645.9588510287244;1648.2006226979904;1653.330401187519;8967.730968070951;9537;9962.850557241647;11385;11400.372979486125;11327.98048175664;11449.084073274138;11466.7133321667;11468;11553.364564948924;2409.915652952147;2489.8879550420274;2490.402303447169;2493.9650045231206;2496.226169887341;2084.4997200671805;2179.7820217978233;2431.7203521595065;2499.187763976715;2509.1845150326126;2438.207582535674;2443.584590619599;2476.2695004973575;2478.7025556933104;2479.6776419065586;2478.5414698280874;2481.5161043596504;2485.254423672909;2486.9005239790386;2489.8879550420274;2418.697662792151;2440.3777036855668;2447.596146635803;2454.4232105455203;2456.250843492734;11443.054680704301;11671.358075305854;11673.299602023906;11701.765964680744;11702;5833.533317334603;6049.243844519435;6064.9090263646085;6064.96967515164;6067.029275315928;3490.1100219444133;3564.7861128332124;3654.3056819204267;3734.719896007783;3752.3808571585655;1252.6930901928995;1262.1543565810928;1893.8958357290344;1918.5011896906906;1968.7735910370204;16204.675906481922;16344.75482867758;16455.83544164555;16480.42318518858;16490.422835200712;4631.305304204329;4782.33047373368;4843.418789745253;4844.32179494871;4848.587870031087;10106.595736170619;12254.448549815279;12264.141510094209;12280.754384912252;12282.570110046105;5970.522358211333;5987.191729116601;5990.610610310316;5996.790112346047;5999.370066143079;4693.06138772247;5219.399769026534;5399.4600539945695;5457.45425457459;5467.0705979983495;3619.2037751694584;3686.8156592170285;3690.8523659053876;3691.317106335283;3696.094456858087;765.5521519910915;775.3913178155121;977.5307852230969;1060.7295139739317;1061.0397590180899;959.9968033405108;971.1114330387758;971.9319647624599;1007.8034783217349;1012.3065699995526;6829.146356705412;7038.331358520933;7050.6827192776445;7202.279772022861;7317.487775855746;1044.6448207609449;1058.4972138234277;1067.204932325407;1086.5110700184791;1120.7030137013699;4171.165766846643;4244.511881133647;4455.643548516111;4581.106684196549;4594.931076033862;13565.253911034988;14270.643233919234;14273.64315892111;14297.571072867831;14305;13717.519886803913;14036.157830530201;14150.36323365451;14248.216348100746;14271.64320891986;9996.200303975664;10249.077583017415;10433.478326083665;10563.313384629975;10588.100011498955;6901.516893817385;7164.355208031302;7181.856362872818;7203.351698347174;7377;12881.549145779853;12882.227066376048;12887.291198984145;12998.285094319903;13152.276624785345;13196;13280.867191328349;13288.468461261442;13496;13498.920086393262;7249.601271929883;9385.296102792181;9464.816897887764;9613.375130616487;9621.134097931219;10034.548445319831;10270.435126068138;10389.584416623553;10407.895921040692;10413;7041;7206.927930720625;8913.777155571162;9034.86447703272;9241.630334786532;8113.716019939274;8378.874316885129;8404.705835295736;8431.578421079044;8554.657813687383;8196.959015204886;8208.466449680991;8219.79450513718;8311.542865142233;8336.291415229773;5878.647281163144;5948.702564871653;5979.5814292999075;5994.010988187075;6179.474744646755;5022.84931452057;6101.237345331833;6143.447089761943;6227.96886015567;6329.082283068838 11:19:03 INFO - PROCESS | 1643 | |4;prototype.html;374.68339253330925;385.4642047553901;391.8843941037394;392.2351414741255;396.08701942023635;5015.874603134924;5193.584982982912;5214.66104703195;5267.552258058065;5288.444713305101;4298.46269216348;5026.974865125679;5034.82378116766;5063.21526157781;5078.289039534468;4123.752574845511;4439.511653718088;4450.443694538183;4457.59881610655;4477.6417886569;4221.881201481609;4231.682623803212;4473.329000649896;4488.214562451574;4501.909961800762;3716.331060409139;4005.6595189408936;4131.88439121437;4420;4422.380866678652;4132.421460995433;4391.49497807753;4414.94041430056;4416.249237629579;4432.290833466662;4241.766702831343;4288.742675439484;4297.914041719148;4321.157374312011;4321.2653848845775;4182.895427614303;4677.345171675968;4949.455559888409;4974.651774375795;5057.772400241998;4532.70537415067;4585.065558042856;4697;4770.61835053195;4893.09477746618;5177.1864635028005;5294.708791016493;5298.913722686879;5481.835544933619;5517.337919449652;3613.8554457821656;4150.634138541002;4321.978390108061;4375.833962188705;4420.889477763049;5294.364676238837;5738.971305143489;5786.276715410574;5807.216025836543;5817.563682723812;4195.8741237762915;4530.660200484911;4549.385832912581;4566.26939689648;4604.240300350405;3862.8261728222296;4134.896627584334;4528.5245049270015;4627.838025669085;4667.789949452283;4603.930941035887;4695.460022097503;4922.138625740481;4927.876803079952;4933.3586633738105;4511.255642818898;4649.325847752057;4681.6722829401615;5488.945110548843;5492.670439773627;1384.4047059764196;1409.7875826788954;1410.6896482773773;1427.557457188275;1483.2361333913043;993.8161440133598;1022.2026819081128;1081.8431327457631;1102.5865300512307;1175.3359351966112;4685.266451412999;4874.8050077997195;5102.5252752415045;5145.588352931756;5161.52228952662;5076.619253555924;5453.590980676386;5467.715086954562;5657.3776884543495;5707.914381284284;4099.221147981933;4517.5482451755215;4794.7362895040405;4815.662903596784;4898.089744999453;2576.0082368288345;2724.5368287391193;2736.7263273672474;2917.7467124156415;2931;5138.537531622172;5476.863078423071;5675.489205971482;5770.730439303346;5811.4018644872995;4663.253879379283;5102;5336.4129945705945;5344.676174636637;5656.377798442168;5178.239398604493;5774;5822.446867547576;5860.38465961068;5883.882322353615;4961.42943561495;5204.297419848272;5525.336959564878;5552.278203833475;5616.297962754656;4323.632491238154;5505.678042736433;5533.6403133796175;5544.445555444423;5581.7767289309595;4793.472718001087;4901.754912254301;5009.5491405773655;5061.8734531637;5782.421757824184;4168.708190426641;4197.5802419759;4478.283474644041;4490.865274041784;4525.004499010212;4956.504349565014;5192.3769147701005;5484.945150548603;5537.674176845654;5650.417882992769;5316.23555751015;5352.250684904195;5459.0347474909795;5482.533984611193;5527.3744971139995;5443.564514838724;5443.700596467233;5486.259354987025;5494.835154945358;5500.889982200253;4706.976465117789;5013.949860501494;5039.84880453587;5372.570194384518;5386.811461598825;4483.977580112079;4880.731559764247;5219.217117432416;5407.378151512469;5416.350037995466;4594.701344412602;5379.73101344939;5380.789322402585;5389.622726409114;5419.945800541944 11:19:03 INFO - PROCESS | 1643 | |5;yui.html;753.0699586011272;769.445998880806;786.7875673568137;886.3263919421239;887.8357503861786;14277.50028748994;15620.218989050545;17341;17372;17430.954142751412;16015.679686406265;16178;16210.865239433215;16253.349866005376;16287.91856040718;998.483820771655;1012.6683411314135;1026.9678972632494;1042.1558537584542;1059.0362769879373;1028.2647906746674;1033.0237925160689;1044.2324891204958;1044.5247412427366;1044.7492601775596;1080.2114456446798;1080.2654195147336;1080.4651697409793;1080.778440419716;1083.9241253112286;1075.6826736112866;1075.930064545802;1075.9731006724894;1076.252004856625;1077.6012875236174;797.3023604346197;798.7084714079377;799.2487062161549;799.7440818937943;800.3477166109602;16412.83587164125;16824.07467589282;17337.393191238247;17378.39175628847;17493.950362978263;12367.938160309232;14357.425702971868;14593;14620.342084606218;14636.121832689967;11944.581939632071;12001.459934302977;12102.394880255952;12220.511179552896;12707.237565745992;3776.131489757344;3856.6914646828186;3948.309045916953;4003.3594624860175;4034.6080602192196;89122.99999999935;115552;118509;119945;120128;9243.39917905334;11091.83362249567;11464.942675286737;11516.251443656136;11638.185327027197;22394.88802555977;23333.94997225129;23795;23844;23862.403439914142;8075.596220189084;8080.393970452122;8118.837623247502;8247.298979586802;8344.874826877602;4416.381706561084;4539.387182730356;4559.635229181657;4695.990362072171;4704.7412392318065;3381.746369022333;3406.233597440556;3437.415639341318;3454.1191996041352;3471.5139880416764;604.3231580629723;604.5194070713793;619.6715740657459;619.9876002479925;629.0187307799847;669.8057563306684;701.6176183979743;707.3209718670031;712.5404114346218;715.7602203261965;10393.713383055716;10632.893705993596;10683.14534837211;11119.888801112047;11151;687.3916583823352;694.9617771022643;745.8657441660445;752.2778132992279;765.8047197964595;4808.230683090758;5130.666506677054;5137.2037334213255;5144.742762861917;5157.58739300855;105176;105493.89179755672;105552.47223763831;107870;111953.88046119598;82214.58892705498;87901;88865;89484.552577238;91832;76368.23631763611;77181;77977.61011194908;78811;79499;7583.05211848519;9828;10070.44612546317;10129.189664826943;10140.391576505433;50749.49250507448;51060.48939510557;52063.958720824616;52280;53592.73203633957;63308.050379243425;65754.67122664356;66098.66950665216;66919.78928535891;67922;10306.278560500694;11450.541978320774;11765.941170294436;11792.29246245228;11806.551202185956;13028.804567931298;13297.933510332387;13307.268100254192;13312.733745325233;13330.666733331744;12451.875481245434;12571.748565028465;12733.29966851795;12845.550405735754;13171.40728667193;12044.156909016285;12383.814242786546;12412.81380779307;12440.626781196579;12879.678008049874;10227.43749093807;12325.815112773495;12381.380930953235;12735.172213806072;12742.554010609585;9270.953645231732;9318.297693668761;9789.657361992297;9820.11618954269;9824.5087745611;8773.744733804228;9700.304900721127;10419.687409377731;10624.628138015132;10656.786864262827 11:19:03 INFO - PROCESS | 1643 | __end_tp_report 11:19:03 INFO - PROCESS | 1643 | __start_cc_report 11:19:03 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2612 11:19:03 INFO - PROCESS | 1643 | __end_cc_report 11:19:03 INFO - PROCESS | 1643 | __startTimestamp1493144343586__endTimestamp 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | ------- Summary: start ------- 11:19:03 INFO - PROCESS | 1643 | Number of tests: 6 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:6126.15 Median:6333.87 stddev:690.15 (10.9%) stddev-sans-first:649.81 11:19:03 INFO - PROCESS | 1643 | Values: 3088.1 3295.9 3576.0 3594.3 3616.7 6175.5 6200.7 6207.6 6222.5 6249.1 6195.7 6250.7 6252.4 6276.7 6288.3 5500.8 5509.4 5551.7 5588.2 5647.3 5434.5 5456.8 5505.0 5641.2 5642.7 5566.8 5587.1 5587.2 5608.8 5613.3 5619.3 5636.4 5638.0 5640.8 5648.7 5363.1 5425.3 5545.3 5562.2 5635.3 6130.3 6140.9 6146.8 6230.4 6237.6 6630.6 6639.4 6649.2 6663.6 6668.0 6616.5 6647.8 6737.2 6738.2 6744.5 6117.3 6174.2 6281.7 6333.9 6389.2 6800.1 6812.8 6816.0 6818.8 6833.4 6438.2 6470.6 6496.3 6516.3 6523.7 6414.5 6458.9 6630.4 6656.4 6668.1 6571.2 6586.3 6599.7 6600.7 6605.3 6293.3 6348.9 6355.5 6421.4 6426.0 5035.6 5231.2 5290.2 5296.6 5323.9 4803.8 4812.8 4831.6 4843.1 4846.1 6108.8 6313.9 6326.5 6328.6 6335.5 6501.9 6535.2 6565.6 6578.0 6685.8 6302.3 6305.7 6324.2 6324.3 6339.5 5807.5 5837.0 5844.5 5864.2 5876.6 6610.5 6618.0 6787.0 6803.0 6902.1 6688.8 6694.7 6705.0 6706.6 6712.9 6808.9 6869.4 6888.1 6908.2 6928.3 6331.4 6388.1 6417.6 6433.4 6529.7 5005.5 6489.1 6501.7 6503.2 6509.2 5877.3 6062.2 6400.0 6466.5 6491.9 6484.7 6501.3 6511.0 6512.3 6528.5 6371.9 6388.6 6401.5 6402.2 6412.2 6145.1 6183.8 6382.5 6397.7 6508.6 6253.8 6268.7 6292.2 6327.6 6356.0 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:58231.36 Median:33339.83 stddev:118163.53 (354.4%) stddev-sans-first:118416.35 11:19:03 INFO - PROCESS | 1643 | Values: 804.9 821.2 883.7 892.9 981.5 38413.4 39071.6 39270.6 40988.0 41074.2 39335.8 39591.0 39621.4 39629.8 39726.6 7979.6 8032.6 8132.3 8269.6 11814.5 11811.5 11931.8 11957.2 11961.6 11966.2 11855.5 11879.4 11924.3 11951.5 11995.6 11869.1 11914.5 11929.9 11931.5 11934.5 11531.3 11589.7 11606.1 11615.0 11617.8 41070.8 41292.0 41382.0 41410.2 41419.0 4032.3 4082.6 4091.8 4120.6 4124.4 24612.9 28620.9 29005.0 30449.8 31175.0 3190.8 3273.1 3285.0 3377.6 3396.6 331309.0 335151.0 335189.0 335297.0 335804.3 41431.4 44711.8 47286.8 51764.0 53302.0 55863.7 55925.7 56026.7 56040.0 56088.4 15297.6 15385.4 15395.8 15414.9 15416.0 13073.9 13126.5 13128.3 13145.3 13224.1 12426.9 12437.4 12456.6 12537.2 12609.5 4656.6 5609.6 5610.2 5614.2 5614.9 994.9 1149.2 1168.6 1207.9 1211.4 27081.7 29412.4 31957.4 33468.8 33521.3 1179.4 1186.5 1203.5 1220.6 1236.3 8404.2 8594.5 8667.7 8684.6 8757.4 505034.0 506560.0 507204.0 507985.0 508335.0 60445.0 60881.7 60903.0 61050.0 61233.0 1443.7 1497.6 1564.2 1567.1 1580.9 30262.0 31523.8 31596.4 31775.4 32020.5 49253.0 49594.3 49710.8 49731.0 49748.0 471331.0 474101.0 474218.0 474380.0 474622.6 28606.9 30640.0 31675.4 33210.8 36758.9 36754.4 44282.3 45758.0 45938.6 47333.8 31326.3 31533.8 31796.0 32163.5 32833.7 26347.5 31974.0 31980.2 32050.0 32681.0 37243.3 37996.8 38043.0 38052.2 38196.2 25798.4 28769.6 30659.2 31797.8 31811.0 23420.1 24658.3 24920.4 25121.6 25159.0 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:37337.26 Median:27371.39 stddev:93836.20 (342.8%) stddev-sans-first:94058.52 11:19:03 INFO - PROCESS | 1643 | Values: 431.2 435.7 437.7 443.8 449.0 20391.6 21485.5 21538.4 22545.4 22828.0 22019.6 22995.9 23588.9 23626.0 23918.3 6578.2 6863.3 6876.4 7445.0 7762.0 7321.2 7821.9 7860.9 7865.7 7898.1 7713.5 7775.2 7787.0 7790.6 7802.2 7604.7 7661.0 7697.3 7783.7 7784.8 7216.6 7479.9 7501.5 7540.8 7648.2 26000.5 26170.6 27153.3 27195.0 27547.7 2979.0 2986.4 3098.7 3126.7 3194.6 15598.7 16023.2 16325.5 16333.2 16853.1 2062.3 2071.8 2075.4 2095.8 2105.4 152609.0 153287.0 158141.4 160319.0 162103.4 16246.6 19985.3 20027.1 20082.3 20177.9 31285.9 31583.5 31850.7 31910.7 31932.2 9501.9 10252.8 10476.9 10678.2 10816.2 8573.4 8954.9 8974.8 8982.1 9160.1 9114.8 9216.0 9309.8 9331.0 9337.2 3209.5 3894.6 3921.5 4000.8 4010.8 751.0 834.4 893.3 920.2 928.2 19272.7 19371.2 20537.7 21099.7 21119.0 870.7 920.0 937.2 944.7 953.0 6826.7 6908.5 6941.3 7078.1 7186.5 435636.0 437031.8 556919.0 564893.0 700227.0 119321.0 124888.4 157657.0 164960.0 166152.0 1241.4 1307.5 1320.6 1322.3 1330.7 18458.9 19642.8 19721.0 19734.2 19747.8 63761.7 64400.7 65315.0 65741.7 65799.0 92614.0 93258.0 93587.5 93593.0 95345.5 10039.6 11070.6 11084.6 11099.7 11287.3 11993.2 12018.6 12065.4 12198.2 12499.8 10973.3 11587.7 11596.9 11673.8 11706.9 10450.9 10507.9 10509.8 10605.5 10893.0 11009.1 11431.9 11720.4 11772.4 11775.3 7730.6 10615.6 10966.9 11462.3 11540.3 9422.7 10998.6 11117.6 11230.8 11356.9 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6922.26 Median:2492.18 stddev:4381.70 (175.8%) stddev-sans-first:4374.42 11:19:03 INFO - PROCESS | 1643 | Values: 1409.6 1616.4 1646.0 1648.2 1653.3 8967.7 9537.0 9962.9 11385.0 11400.4 11328.0 11449.1 11466.7 11468.0 11553.4 2409.9 2489.9 2490.4 2494.0 2496.2 2084.5 2179.8 2431.7 2499.2 2509.2 2438.2 2443.6 2476.3 2478.7 2479.7 2478.5 2481.5 2485.3 2486.9 2489.9 2418.7 2440.4 2447.6 2454.4 2456.3 11443.1 11671.4 11673.3 11701.8 11702.0 5833.5 6049.2 6064.9 6065.0 6067.0 3490.1 3564.8 3654.3 3734.7 3752.4 1252.7 1262.2 1893.9 1918.5 1968.8 16204.7 16344.8 16455.8 16480.4 16490.4 4631.3 4782.3 4843.4 4844.3 4848.6 10106.6 12254.4 12264.1 12280.8 12282.6 5970.5 5987.2 5990.6 5996.8 5999.4 4693.1 5219.4 5399.5 5457.5 5467.1 3619.2 3686.8 3690.9 3691.3 3696.1 765.6 775.4 977.5 1060.7 1061.0 960.0 971.1 971.9 1007.8 1012.3 6829.1 7038.3 7050.7 7202.3 7317.5 1044.6 1058.5 1067.2 1086.5 1120.7 4171.2 4244.5 4455.6 4581.1 4594.9 13565.3 14270.6 14273.6 14297.6 14305.0 13717.5 14036.2 14150.4 14248.2 14271.6 9996.2 10249.1 10433.5 10563.3 10588.1 6901.5 7164.4 7181.9 7203.4 7377.0 12881.5 12882.2 12887.3 12998.3 13152.3 13196.0 13280.9 13288.5 13496.0 13498.9 7249.6 9385.3 9464.8 9613.4 9621.1 10034.5 10270.4 10389.6 10407.9 10413.0 7041.0 7206.9 8913.8 9034.9 9241.6 8113.7 8378.9 8404.7 8431.6 8554.7 8197.0 8208.5 8219.8 8311.5 8336.3 5878.6 5948.7 5979.6 5994.0 6179.5 5022.8 6101.2 6143.4 6228.0 6329.1 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4557.48 Median:4899.92 stddev:1255.95 (25.6%) stddev-sans-first:1219.61 11:19:03 INFO - PROCESS | 1643 | Values: 374.7 385.5 391.9 392.2 396.1 5015.9 5193.6 5214.7 5267.6 5288.4 4298.5 5027.0 5034.8 5063.2 5078.3 4123.8 4439.5 4450.4 4457.6 4477.6 4221.9 4231.7 4473.3 4488.2 4501.9 3716.3 4005.7 4131.9 4420.0 4422.4 4132.4 4391.5 4414.9 4416.2 4432.3 4241.8 4288.7 4297.9 4321.2 4321.3 4182.9 4677.3 4949.5 4974.7 5057.8 4532.7 4585.1 4697.0 4770.6 4893.1 5177.2 5294.7 5298.9 5481.8 5517.3 3613.9 4150.6 4322.0 4375.8 4420.9 5294.4 5739.0 5786.3 5807.2 5817.6 4195.9 4530.7 4549.4 4566.3 4604.2 3862.8 4134.9 4528.5 4627.8 4667.8 4603.9 4695.5 4922.1 4927.9 4933.4 4511.3 4649.3 4681.7 5488.9 5492.7 1384.4 1409.8 1410.7 1427.6 1483.2 993.8 1022.2 1081.8 1102.6 1175.3 4685.3 4874.8 5102.5 5145.6 5161.5 5076.6 5453.6 5467.7 5657.4 5707.9 4099.2 4517.5 4794.7 4815.7 4898.1 2576.0 2724.5 2736.7 2917.7 2931.0 5138.5 5476.9 5675.5 5770.7 5811.4 4663.3 5102.0 5336.4 5344.7 5656.4 5178.2 5774.0 5822.4 5860.4 5883.9 4961.4 5204.3 5525.3 5552.3 5616.3 4323.6 5505.7 5533.6 5544.4 5581.8 4793.5 4901.8 5009.5 5061.9 5782.4 4168.7 4197.6 4478.3 4490.9 4525.0 4956.5 5192.4 5484.9 5537.7 5650.4 5316.2 5352.3 5459.0 5482.5 5527.4 5443.6 5443.7 5486.3 5494.8 5500.9 4707.0 5013.9 5039.8 5372.6 5386.8 4484.0 4880.7 5219.2 5407.4 5416.4 4594.7 5379.7 5380.8 5389.6 5419.9 11:19:03 INFO - PROCESS | 1643 | 11:19:03 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20813.31 Median:17404.67 stddev:30271.85 (173.9%) stddev-sans-first:30319.29 11:19:03 INFO - PROCESS | 1643 | Values: 753.1 769.4 786.8 886.3 887.8 14277.5 15620.2 17341.0 17372.0 17431.0 16015.7 16178.0 16210.9 16253.3 16287.9 998.5 1012.7 1027.0 1042.2 1059.0 1028.3 1033.0 1044.2 1044.5 1044.7 1080.2 1080.3 1080.5 1080.8 1083.9 1075.7 1075.9 1076.0 1076.3 1077.6 797.3 798.7 799.2 799.7 800.3 16412.8 16824.1 17337.4 17378.4 17494.0 12367.9 14357.4 14593.0 14620.3 14636.1 11944.6 12001.5 12102.4 12220.5 12707.2 3776.1 3856.7 3948.3 4003.4 4034.6 89123.0 115552.0 118509.0 119945.0 120128.0 9243.4 11091.8 11464.9 11516.3 11638.2 22394.9 23333.9 23795.0 23844.0 23862.4 8075.6 8080.4 8118.8 8247.3 8344.9 4416.4 4539.4 4559.6 4696.0 4704.7 3381.7 3406.2 3437.4 3454.1 3471.5 604.3 604.5 619.7 620.0 629.0 669.8 701.6 707.3 712.5 715.8 10393.7 10632.9 10683.1 11119.9 11151.0 687.4 695.0 745.9 752.3 765.8 4808.2 5130.7 5137.2 5144.7 5157.6 105176.0 105493.9 105552.5 107870.0 111953.9 82214.6 87901.0 88865.0 89484.6 91832.0 76368.2 77181.0 77977.6 78811.0 79499.0 7583.1 9828.0 10070.4 10129.2 10140.4 50749.5 51060.5 52064.0 52280.0 53592.7 63308.1 65754.7 66098.7 66919.8 67922.0 10306.3 11450.5 11765.9 11792.3 11806.6 13028.8 13297.9 13307.3 13312.7 13330.7 12451.9 12571.7 12733.3 12845.6 13171.4 12044.2 12383.8 12412.8 12440.6 12879.7 10227.4 12325.8 12381.4 12735.2 12742.6 9271.0 9318.3 9789.7 9820.1 9824.5 8773.7 9700.3 10419.7 10624.6 10656.8 11:19:03 INFO - PROCESS | 1643 | -------- Summary: end -------- 11:19:03 INFO - PROCESS | 1643 | 11:19:04 INFO - TEST-INFO | 1643: exit 0 11:19:04 INFO - TEST-OK | dromaeo_css | took 1120051ms 11:19:04 INFO - TEST-START | kraken 11:19:04 INFO - operating with platform_type : mac_ 11:19:04 INFO - Initialising browser for kraken test... 11:19:04 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmph26ntI/profile http://localhost:49236/getInfo.html) 11:19:06 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 11:19:06 INFO - PROCESS | 1651 | colorDepth:24 11:19:06 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 11:19:06 INFO - PROCESS | 1651 | __metrics 11:19:06 INFO - PROCESS | 1651 | 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" 11:19:06 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:07 INFO - TEST-INFO | 1651: exit 0 11:19:07 INFO - Browser initialized. 11:19:07 INFO - Running cycle 1/1 for kraken test... 11:19:07 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmph26ntI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:19 INFO - PROCESS | 1653 | RSS: Main: 165462016 11:19:19 INFO - PROCESS | 1653 | 11:19:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:22 INFO - PROCESS | 1653 | RSS: Main: 216518656 11:19:22 INFO - PROCESS | 1653 | 11:19:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 11:19:26 INFO - PROCESS | 1653 | RSS: Main: 231497728 11:19:26 INFO - PROCESS | 1653 | 11:19:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 11:19:29 INFO - PROCESS | 1653 | RSS: Main: 329654272 11:19:29 INFO - PROCESS | 1653 | 11:19:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 11:19:32 INFO - PROCESS | 1653 | RSS: Main: 230723584 11:19:32 INFO - PROCESS | 1653 | 11:19:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:19:35 INFO - PROCESS | 1653 | RSS: Main: 232349696 11:19:35 INFO - PROCESS | 1653 | 11:19:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 11:19:38 INFO - PROCESS | 1653 | RSS: Main: 272478208 11:19:38 INFO - PROCESS | 1653 | 11:19:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 11:19:42 INFO - PROCESS | 1653 | RSS: Main: 274489344 11:19:42 INFO - PROCESS | 1653 | 11:19:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 11:19:45 INFO - PROCESS | 1653 | RSS: Main: 272404480 11:19:45 INFO - PROCESS | 1653 | 11:19:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:19:48 INFO - PROCESS | 1653 | RSS: Main: 247959552 11:19:48 INFO - PROCESS | 1653 | 11:19:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:19:50 INFO - PROCESS | 1653 | RSS: Main: 252010496 11:19:50 INFO - PROCESS | 1653 | 11:19:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:19:53 INFO - PROCESS | 1653 | RSS: Main: 259186688 11:19:53 INFO - PROCESS | 1653 | 11:19:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:19:57 INFO - PROCESS | 1653 | RSS: Main: 272609280 11:19:57 INFO - PROCESS | 1653 | 11:19:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:00 INFO - PROCESS | 1653 | RSS: Main: 266436608 11:20:00 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 11:20:02 INFO - PROCESS | 1653 | RSS: Main: 311435264 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | __start_tp_report 11:20:02 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 11:20:02 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 11:20:02 INFO - PROCESS | 1653 | |i|pagename|runs| 11:20:02 INFO - PROCESS | 1653 | |0;ai-astar;103;115;115;116;114;116;113;113;114;115 11:20:02 INFO - PROCESS | 1653 | |1;audio-beat-detection;142;109;113;170;137;138;107;107;129;132 11:20:02 INFO - PROCESS | 1653 | |2;audio-dft;184;184;183;184;182;186;183;184;184;184 11:20:02 INFO - PROCESS | 1653 | |3;audio-fft;82;59;59;89;59;61;65;81;98;86 11:20:02 INFO - PROCESS | 1653 | |4;audio-oscillator;88;69;88;69;70;68;81;70;68;81 11:20:02 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;88;92;135;110;89;87;88;89;76 11:20:02 INFO - PROCESS | 1653 | |6;imaging-darkroom;95;96;94;95;95;94;94;95;95;104 11:20:02 INFO - PROCESS | 1653 | |7;imaging-desaturate;82;83;86;84;85;83;89;87;83;101 11:20:02 INFO - PROCESS | 1653 | |8;json-parse-financial;65;60;60;61;62;61;62;64;65;65 11:20:02 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;55;62;66;65;60;58;58;58;58;58 11:20:02 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;82;83;83;83;80;76;98;78;85;88 11:20:02 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;143;143;148;134;133;132;145;136;201;178 11:20:02 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;160;164;162;161;161;161;165;160;160;159 11:20:02 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;64;63;65;63;64;63;63;64;61;63 11:20:02 INFO - PROCESS | 1653 | __end_tp_report 11:20:02 INFO - PROCESS | 1653 | __start_cc_report 11:20:02 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2144 11:20:02 INFO - PROCESS | 1653 | __end_cc_report 11:20:02 INFO - PROCESS | 1653 | __startTimestamp1493144402441__endTimestamp 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | ------- Summary: start ------- 11:20:02 INFO - PROCESS | 1653 | Number of tests: 14 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:3.81 (3.3%) stddev-sans-first:1.13 11:20:02 INFO - PROCESS | 1653 | Values: 103.0 115.0 115.0 116.0 114.0 116.0 113.0 113.0 114.0 115.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:134.50 stddev:20.07 (14.9%) stddev-sans-first:20.67 11:20:02 INFO - PROCESS | 1653 | Values: 142.0 109.0 113.0 170.0 137.0 138.0 107.0 107.0 129.0 132.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 11:20:02 INFO - PROCESS | 1653 | Values: 184.0 184.0 183.0 184.0 182.0 186.0 183.0 184.0 184.0 184.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:73.90 Median:81.50 stddev:14.84 (18.2%) stddev-sans-first:15.45 11:20:02 INFO - PROCESS | 1653 | Values: 82.0 59.0 59.0 89.0 59.0 61.0 65.0 81.0 98.0 86.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:75.50 stddev:8.36 (11.1%) stddev-sans-first:7.48 11:20:02 INFO - PROCESS | 1653 | Values: 88.0 69.0 88.0 69.0 70.0 68.0 81.0 70.0 68.0 81.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:88.50 stddev:16.53 (18.7%) stddev-sans-first:17.42 11:20:02 INFO - PROCESS | 1653 | Values: 89.0 88.0 92.0 135.0 110.0 89.0 87.0 88.0 89.0 76.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:95.00 stddev:2.98 (3.1%) stddev-sans-first:3.15 11:20:02 INFO - PROCESS | 1653 | Values: 95.0 96.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 104.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:84.50 stddev:5.60 (6.6%) stddev-sans-first:5.72 11:20:02 INFO - PROCESS | 1653 | Values: 82.0 83.0 86.0 84.0 85.0 83.0 89.0 87.0 83.0 101.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:1.99 11:20:02 INFO - PROCESS | 1653 | Values: 65.0 60.0 60.0 61.0 62.0 61.0 62.0 64.0 65.0 65.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.00 stddev:3.49 (5.9%) stddev-sans-first:3.24 11:20:02 INFO - PROCESS | 1653 | Values: 55.0 62.0 66.0 65.0 60.0 58.0 58.0 58.0 58.0 58.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:6.10 (7.3%) stddev-sans-first:6.44 11:20:02 INFO - PROCESS | 1653 | Values: 82.0 83.0 83.0 83.0 80.0 76.0 98.0 78.0 85.0 88.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:144.00 stddev:22.54 (15.7%) stddev-sans-first:23.79 11:20:02 INFO - PROCESS | 1653 | Values: 143.0 143.0 148.0 134.0 133.0 132.0 145.0 136.0 201.0 178.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:1.89 (1.2%) stddev-sans-first:1.94 11:20:02 INFO - PROCESS | 1653 | Values: 160.0 164.0 162.0 161.0 161.0 161.0 165.0 160.0 160.0 159.0 11:20:02 INFO - PROCESS | 1653 | 11:20:02 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.06 (1.7%) stddev-sans-first:1.09 11:20:02 INFO - PROCESS | 1653 | Values: 64.0 63.0 65.0 63.0 64.0 63.0 63.0 64.0 61.0 63.0 11:20:02 INFO - PROCESS | 1653 | -------- Summary: end -------- 11:20:02 INFO - PROCESS | 1653 | 11:20:03 INFO - TEST-INFO | 1653: exit 0 11:20:03 INFO - TEST-OK | kraken | took 59086ms 11:20:03 INFO - SUITE-END | took 1179s 11:20:03 INFO - Completed test suite (00:19:39) 11:20:03 INFO - javascript benchmark 11:20:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7843.712737357692, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.1198858325374, 3295.9452975047984, 3575.964240357596, 3594.263176048907, 3616.656417640325, 6175.505959523233, 6200.720967556459, 6207.627542347463, 6222.5021998240145, 6249.12512248285, 6195.721192546335, 6250.656213908233, 6252.437280644741, 6276.717547710353, 6288.276848162463, 5500.779968801253, 5509.3664228613625, 5551.694656793895, 5588.21764952907, 5647.265855438787, 5434.483724046229, 5456.781728730846, 5505.03661859175, 5641.210230567724, 5642.689652069134, 5566.777328906839, 5587.05020146574, 5587.217789509472, 5608.831735047955, 5613.270274864262, 5619.325680918275, 5636.436356364372, 5637.971810140964, 5640.802571909963, 5648.689322087304, 5363.061464243741, 5425.327441694552, 5545.251391062196, 5562.2212890195, 5635.295588051494, 6130.336988993121, 6140.907886381708, 6146.7541298348015, 6230.408111229426, 6237.594556353823, 6630.602163870183, 6639.402453779183, 6649.168853893263, 6663.600183988928, 6668.0, 6616.470682345401, 6647.767328143492, 6737.225219099817, 6738.191417029988, 6744.460443164535, 6117.319130932566, 6174.228221472316, 6281.685915704196, 6333.873322533524, 6389.1694079769795, 6800.149981252343, 6812.795616131524, 6816.0, 6818.795436136924, 6833.384995350442, 6438.227412710505, 6470.579412338183, 6496.252930912911, 6516.348365163541, 6523.7064332105165, 6414.486841052704, 6458.935410645928, 6630.370114839083, 6656.36764507371, 6668.066470694107, 6571.244306904671, 6586.27550969393, 6599.670016499252, 6600.73597056122, 6605.339466053356, 6293.30773614902, 6348.904766428507, 6355.523335749837, 6421.422072013448, 6425.967870160619, 5035.647504674711, 5231.24146998683, 5290.206469029677, 5296.576273898079, 5323.866903327448, 4803.807847686124, 4812.759362031885, 4831.637627177975, 4843.055604157155, 4846.07924494352, 6108.755649774048, 6313.9368606314265, 6326.4622507087415, 6328.557001009885, 6335.4931605472375, 6501.869962600722, 6535.248446428626, 6565.638889861008, 6578.0, 6685.832854178684, 6302.306746257908, 6305.747770089237, 6324.209473815773, 6324.3043265240785, 6339.492840572743, 5807.506361959281, 5836.970815145897, 5844.473997340175, 5864.237649105589, 5876.6180198286975, 6610.504212184009, 6618.0, 6786.966065169642, 6802.965985170043, 6902.068220790129, 6688.83277918056, 6694.732210711712, 6704.966475167593, 6706.631135287606, 6712.865742685217, 6808.897866531907, 6869.416099631388, 6888.104546408935, 6908.171019477695, 6928.272531384132, 6331.366863313632, 6388.1376014237485, 6417.550771445954, 6433.388828061326, 6529.706163222571, 5005.549500544968, 6489.059086432347, 6501.707423166064, 6503.154589903283, 6509.218893732783, 5877.294724633071, 6062.151298818081, 6400.039994000937, 6466.515011374072, 6491.870162596816, 6484.740610375532, 6501.284858665448, 6511.023346498063, 6512.3162067982175, 6528.543001989815, 6371.904421433589, 6388.584741991755, 6401.519886008475, 6402.199725034371, 6412.198475190601, 6145.139680444652, 6183.752649894134, 6382.457491113308, 6397.744090236339, 6508.60948343101, 6253.812385628256, 6268.655223962726, 6292.1505596743855, 6327.557071004985, 6356.0], "value": 6080.484791256773, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.8913396691446, 821.1501096365262, 883.6818745251708, 892.8749975003497, 981.4700061966538, 38413.42379864301, 39071.60928390715, 39270.60729392705, 40988.0, 41074.178516429725, 39335.803320983425, 39591.0, 39621.40567891484, 39629.801850990705, 39726.60273397265, 7979.601019949008, 8032.598370081472, 8132.268095871385, 8269.62786674601, 11814.527418903233, 11811.527538898434, 11931.821022684666, 11957.222780519282, 11961.58134465294, 11966.22219555726, 11855.525778968831, 11879.406029698524, 11924.284542927453, 11951.521939122425, 11995.64013079609, 11869.050475961945, 11914.523419063227, 11929.880701192964, 11931.463084161234, 11934.462949167222, 11531.25046871959, 11589.652310430616, 11606.129540284428, 11614.954654081173, 11617.825732614017, 41070.79464602658, 41291.96770080772, 41381.96545086367, 41410.1717965642, 41419.0, 4032.334664780308, 4082.6121518455698, 4091.8158682859344, 4120.608542188487, 4124.360724087771, 24612.876935615386, 28620.856895715595, 29005.0, 30449.847750761324, 31175.0, 3190.7766456348063, 3273.099897528175, 3284.998075586945, 3377.5946886373545, 3396.6263710992016, 331309.0, 335151.0, 335189.0, 335297.0, 335804.32097839355, 41431.378529322086, 44711.776441118236, 47286.763566182635, 51764.0, 53302.0, 55863.720681396335, 55925.72037139788, 56026.719866401225, 56040.0, 56088.43911560914, 15297.617559560877, 15385.384584616713, 15395.769063464057, 15414.922925385301, 15416.0, 13073.869261307455, 13126.474941002443, 13128.277944713132, 13145.342732863319, 13224.074314798065, 12426.875731242753, 12437.378131093408, 12456.564020259248, 12537.185082969578, 12609.49562017509, 4656.604188644003, 5609.5792815539, 5610.158476228598, 5614.214010038598, 5614.85962850932, 994.8607194992707, 1149.166854030821, 1168.6201984355118, 1207.9154459187773, 1211.3550853024863, 27081.729182708314, 29412.38231897266, 31957.36085278328, 33468.832655836566, 33521.329573408395, 1179.3572502985894, 1186.549111337686, 1203.5306230569909, 1220.6338098570393, 1236.313845815563, 8404.20160084791, 8594.52730099838, 8667.696630618024, 8684.56577171139, 8757.430767000253, 505034.0, 506560.0, 507204.0, 507985.0, 508335.0, 60445.0, 60881.69559152264, 60903.0, 61050.0, 61233.0, 1443.7112577484545, 1497.5956491747386, 1564.1631727025986, 1567.0675947811035, 1580.913049782273, 30262.0, 31523.842380787948, 31596.368072637957, 31775.36449271048, 32020.51969220417, 49253.0, 49594.25608615801, 49710.75144624254, 49731.00537989292, 49748.00503989973, 471331.0, 474101.0, 474218.0, 474380.0, 474622.6268868634, 28606.856965715036, 30640.0, 31675.366492669556, 33210.83394583012, 36758.89723308305, 36754.448683270304, 44282.3357649642, 45758.0, 45938.621841344815, 47333.7633311845, 31326.277054762206, 31533.8423307882, 31796.0, 32163.51754723634, 32833.67166328402, 26347.473050539265, 31974.040778776674, 31980.20049498781, 32050.03849884507, 32681.0, 37243.25513489769, 37996.81001594974, 38043.0, 38052.23895522129, 38196.236075278895, 25798.355041124123, 28769.56845647359, 30659.240668339957, 31797.841010794797, 31811.0, 23420.06319747191, 24658.260252192464, 24920.435054183105, 25121.623175652014, 25158.993640254186], "value": 19420.683347342783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.21949271817994, 435.66236166970594, 437.7001753798648, 443.820252797617, 448.9785737447307, 20391.592168156647, 21485.462863428424, 21538.353849384504, 22545.436364090907, 22828.0, 22019.559608807813, 22995.885020574875, 23588.88205558974, 23626.0, 23918.28245152644, 6578.210614726239, 6863.279355667658, 6876.449884009292, 7445.0, 7762.0, 7321.158066822304, 7821.921780782176, 7860.921390786076, 7865.68537258509, 7898.05223373196, 7713.537187768724, 7775.222477752208, 7786.987691600084, 7790.571518566477, 7802.180771019046, 7604.695812167479, 7660.961695191516, 7697.26875946787, 7783.688652453895, 7784.766457006299, 7216.603086830222, 7479.887801682979, 7501.512401693873, 7540.8114797129965, 7648.196939321347, 26000.479990400276, 26170.6074408884, 27153.321166970985, 27195.048173314037, 27547.724522754717, 2978.955315670267, 2986.4325778102093, 3098.7366073883745, 3126.7498600112162, 3194.5847039884666, 15598.688026239524, 16023.198840058067, 16325.510234692978, 16333.183340832911, 16853.073080980543, 2062.257587268582, 2071.829416379756, 2075.356639441778, 2095.7904209579074, 2105.368389483149, 152609.0, 153287.0, 158141.4185858138, 160319.0, 162103.37896621, 16246.593835154215, 19985.30051448192, 20027.09878055491, 20082.288890999822, 20177.899110504648, 31285.904993325123, 31583.52624710631, 31850.681493185235, 31910.680893190773, 31932.201694957814, 9501.907280662674, 10252.794944101077, 10476.895231047745, 10678.1991350649, 10816.242862999672, 8573.356998225157, 8954.910450895408, 8974.775630609287, 8982.056884027214, 9160.083991600919, 9114.81770364589, 9215.95392023049, 9309.767255818524, 9330.95334523323, 9337.206337461255, 3209.51857221414, 3894.5521265054313, 3921.509841250769, 4000.7999600019884, 4010.799460026987, 750.9711694977915, 834.3533761334893, 893.3433926064338, 920.2316066084894, 928.1646518133733, 19272.710909336372, 19371.159739824696, 20537.691934620994, 21099.68350474744, 21119.0, 870.7431307764225, 919.9586018629178, 937.1846493550654, 944.6835310171169, 952.9666461673808, 6826.658667066627, 6908.516403851782, 6941.34057264559, 7078.079849619619, 7186.461015423864, 435636.0, 437031.81484092376, 556919.0, 564893.0, 700227.0, 119321.0, 124888.37555812162, 157657.0, 164960.0, 166152.0, 1241.4289426863743, 1307.5423601739506, 1320.577415227118, 1322.3388305847077, 1330.7272009238084, 18458.907705461923, 19642.80357196467, 19721.0, 19734.210631574577, 19747.802521974598, 63761.68119159374, 64400.677996611594, 65315.0, 65741.67129164323, 65799.0, 92614.0, 93258.0, 93587.53206233925, 93593.0, 95345.52327238319, 10039.598416063567, 11070.5571777128, 11084.584751718505, 11099.723531793947, 11287.266327688674, 11993.160478766402, 12018.579349722717, 12065.396730163282, 12198.207116537396, 12499.75000500003, 10973.341599503736, 11587.710307242387, 11596.94201528987, 11673.824892626448, 11706.88293117092, 10450.895491044992, 10507.94746026265, 10509.842352364567, 10605.46972651349, 10893.019628233496, 11009.119270458184, 11431.942840285745, 11720.355380454157, 11772.352520611448, 11775.293482391084, 7730.574818384818, 10615.575376985144, 10966.890331096905, 11462.254953428, 11540.307581545134, 9422.717318480456, 10998.560057597606, 11117.555297787998, 11230.83153752678, 11356.94321528387], "value": 11474.077702999957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.626448991017, 1616.3534586165533, 1645.9588510287244, 1648.2006226979904, 1653.330401187519, 8967.730968070951, 9537.0, 9962.850557241647, 11385.0, 11400.372979486125, 11327.98048175664, 11449.084073274138, 11466.7133321667, 11468.0, 11553.364564948924, 2409.915652952147, 2489.8879550420274, 2490.402303447169, 2493.9650045231206, 2496.226169887341, 2084.4997200671805, 2179.7820217978233, 2431.7203521595065, 2499.187763976715, 2509.1845150326126, 2438.207582535674, 2443.584590619599, 2476.2695004973575, 2478.7025556933104, 2479.6776419065586, 2478.5414698280874, 2481.5161043596504, 2485.254423672909, 2486.9005239790386, 2489.8879550420274, 2418.697662792151, 2440.3777036855668, 2447.596146635803, 2454.4232105455203, 2456.250843492734, 11443.054680704301, 11671.358075305854, 11673.299602023906, 11701.765964680744, 11702.0, 5833.533317334603, 6049.243844519435, 6064.9090263646085, 6064.96967515164, 6067.029275315928, 3490.1100219444133, 3564.7861128332124, 3654.3056819204267, 3734.719896007783, 3752.3808571585655, 1252.6930901928995, 1262.1543565810928, 1893.8958357290344, 1918.5011896906906, 1968.7735910370204, 16204.675906481922, 16344.75482867758, 16455.83544164555, 16480.42318518858, 16490.422835200712, 4631.305304204329, 4782.33047373368, 4843.418789745253, 4844.32179494871, 4848.587870031087, 10106.595736170619, 12254.448549815279, 12264.141510094209, 12280.754384912252, 12282.570110046105, 5970.522358211333, 5987.191729116601, 5990.610610310316, 5996.790112346047, 5999.370066143079, 4693.06138772247, 5219.399769026534, 5399.4600539945695, 5457.45425457459, 5467.0705979983495, 3619.2037751694584, 3686.8156592170285, 3690.8523659053876, 3691.317106335283, 3696.094456858087, 765.5521519910915, 775.3913178155121, 977.5307852230969, 1060.7295139739317, 1061.0397590180899, 959.9968033405108, 971.1114330387758, 971.9319647624599, 1007.8034783217349, 1012.3065699995526, 6829.146356705412, 7038.331358520933, 7050.6827192776445, 7202.279772022861, 7317.487775855746, 1044.6448207609449, 1058.4972138234277, 1067.204932325407, 1086.5110700184791, 1120.7030137013699, 4171.165766846643, 4244.511881133647, 4455.643548516111, 4581.106684196549, 4594.931076033862, 13565.253911034988, 14270.643233919234, 14273.64315892111, 14297.571072867831, 14305.0, 13717.519886803913, 14036.157830530201, 14150.36323365451, 14248.216348100746, 14271.64320891986, 9996.200303975664, 10249.077583017415, 10433.478326083665, 10563.313384629975, 10588.100011498955, 6901.516893817385, 7164.355208031302, 7181.856362872818, 7203.351698347174, 7377.0, 12881.549145779853, 12882.227066376048, 12887.291198984145, 12998.285094319903, 13152.276624785345, 13196.0, 13280.867191328349, 13288.468461261442, 13496.0, 13498.920086393262, 7249.601271929883, 9385.296102792181, 9464.816897887764, 9613.375130616487, 9621.134097931219, 10034.548445319831, 10270.435126068138, 10389.584416623553, 10407.895921040692, 10413.0, 7041.0, 7206.927930720625, 8913.777155571162, 9034.86447703272, 9241.630334786532, 8113.716019939274, 8378.874316885129, 8404.705835295736, 8431.578421079044, 8554.657813687383, 8196.959015204886, 8208.466449680991, 8219.79450513718, 8311.542865142233, 8336.291415229773, 5878.647281163144, 5948.702564871653, 5979.5814292999075, 5994.010988187075, 6179.474744646755, 5022.84931452057, 6101.237345331833, 6143.447089761943, 6227.96886015567, 6329.082283068838], "value": 5290.696950475518, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.68339253330925, 385.4642047553901, 391.8843941037394, 392.2351414741255, 396.08701942023635, 5015.874603134924, 5193.584982982912, 5214.66104703195, 5267.552258058065, 5288.444713305101, 4298.46269216348, 5026.974865125679, 5034.82378116766, 5063.21526157781, 5078.289039534468, 4123.752574845511, 4439.511653718088, 4450.443694538183, 4457.59881610655, 4477.6417886569, 4221.881201481609, 4231.682623803212, 4473.329000649896, 4488.214562451574, 4501.909961800762, 3716.331060409139, 4005.6595189408936, 4131.88439121437, 4420.0, 4422.380866678652, 4132.421460995433, 4391.49497807753, 4414.94041430056, 4416.249237629579, 4432.290833466662, 4241.766702831343, 4288.742675439484, 4297.914041719148, 4321.157374312011, 4321.2653848845775, 4182.895427614303, 4677.345171675968, 4949.455559888409, 4974.651774375795, 5057.772400241998, 4532.70537415067, 4585.065558042856, 4697.0, 4770.61835053195, 4893.09477746618, 5177.1864635028005, 5294.708791016493, 5298.913722686879, 5481.835544933619, 5517.337919449652, 3613.8554457821656, 4150.634138541002, 4321.978390108061, 4375.833962188705, 4420.889477763049, 5294.364676238837, 5738.971305143489, 5786.276715410574, 5807.216025836543, 5817.563682723812, 4195.8741237762915, 4530.660200484911, 4549.385832912581, 4566.26939689648, 4604.240300350405, 3862.8261728222296, 4134.896627584334, 4528.5245049270015, 4627.838025669085, 4667.789949452283, 4603.930941035887, 4695.460022097503, 4922.138625740481, 4927.876803079952, 4933.3586633738105, 4511.255642818898, 4649.325847752057, 4681.6722829401615, 5488.945110548843, 5492.670439773627, 1384.4047059764196, 1409.7875826788954, 1410.6896482773773, 1427.557457188275, 1483.2361333913043, 993.8161440133598, 1022.2026819081128, 1081.8431327457631, 1102.5865300512307, 1175.3359351966112, 4685.266451412999, 4874.8050077997195, 5102.5252752415045, 5145.588352931756, 5161.52228952662, 5076.619253555924, 5453.590980676386, 5467.715086954562, 5657.3776884543495, 5707.914381284284, 4099.221147981933, 4517.5482451755215, 4794.7362895040405, 4815.662903596784, 4898.089744999453, 2576.0082368288345, 2724.5368287391193, 2736.7263273672474, 2917.7467124156415, 2931.0, 5138.537531622172, 5476.863078423071, 5675.489205971482, 5770.730439303346, 5811.4018644872995, 4663.253879379283, 5102.0, 5336.4129945705945, 5344.676174636637, 5656.377798442168, 5178.239398604493, 5774.0, 5822.446867547576, 5860.38465961068, 5883.882322353615, 4961.42943561495, 5204.297419848272, 5525.336959564878, 5552.278203833475, 5616.297962754656, 4323.632491238154, 5505.678042736433, 5533.6403133796175, 5544.445555444423, 5581.7767289309595, 4793.472718001087, 4901.754912254301, 5009.5491405773655, 5061.8734531637, 5782.421757824184, 4168.708190426641, 4197.5802419759, 4478.283474644041, 4490.865274041784, 4525.004499010212, 4956.504349565014, 5192.3769147701005, 5484.945150548603, 5537.674176845654, 5650.417882992769, 5316.23555751015, 5352.250684904195, 5459.0347474909795, 5482.533984611193, 5527.3744971139995, 5443.564514838724, 5443.700596467233, 5486.259354987025, 5494.835154945358, 5500.889982200253, 4706.976465117789, 5013.949860501494, 5039.84880453587, 5372.570194384518, 5386.811461598825, 4483.977580112079, 4880.731559764247, 5219.217117432416, 5407.378151512469, 5416.350037995466, 4594.701344412602, 5379.73101344939, 5380.789322402585, 5389.622726409114, 5419.945800541944], "value": 4185.549407568396, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.0699586011272, 769.445998880806, 786.7875673568137, 886.3263919421239, 887.8357503861786, 14277.50028748994, 15620.218989050545, 17341.0, 17372.0, 17430.954142751412, 16015.679686406265, 16178.0, 16210.865239433215, 16253.349866005376, 16287.91856040718, 998.483820771655, 1012.6683411314135, 1026.9678972632494, 1042.1558537584542, 1059.0362769879373, 1028.2647906746674, 1033.0237925160689, 1044.2324891204958, 1044.5247412427366, 1044.7492601775596, 1080.2114456446798, 1080.2654195147336, 1080.4651697409793, 1080.778440419716, 1083.9241253112286, 1075.6826736112866, 1075.930064545802, 1075.9731006724894, 1076.252004856625, 1077.6012875236174, 797.3023604346197, 798.7084714079377, 799.2487062161549, 799.7440818937943, 800.3477166109602, 16412.83587164125, 16824.07467589282, 17337.393191238247, 17378.39175628847, 17493.950362978263, 12367.938160309232, 14357.425702971868, 14593.0, 14620.342084606218, 14636.121832689967, 11944.581939632071, 12001.459934302977, 12102.394880255952, 12220.511179552896, 12707.237565745992, 3776.131489757344, 3856.6914646828186, 3948.309045916953, 4003.3594624860175, 4034.6080602192196, 89122.99999999935, 115552.0, 118509.0, 119945.0, 120128.0, 9243.39917905334, 11091.83362249567, 11464.942675286737, 11516.251443656136, 11638.185327027197, 22394.88802555977, 23333.94997225129, 23795.0, 23844.0, 23862.403439914142, 8075.596220189084, 8080.393970452122, 8118.837623247502, 8247.298979586802, 8344.874826877602, 4416.381706561084, 4539.387182730356, 4559.635229181657, 4695.990362072171, 4704.7412392318065, 3381.746369022333, 3406.233597440556, 3437.415639341318, 3454.1191996041352, 3471.5139880416764, 604.3231580629723, 604.5194070713793, 619.6715740657459, 619.9876002479925, 629.0187307799847, 669.8057563306684, 701.6176183979743, 707.3209718670031, 712.5404114346218, 715.7602203261965, 10393.713383055716, 10632.893705993596, 10683.14534837211, 11119.888801112047, 11151.0, 687.3916583823352, 694.9617771022643, 745.8657441660445, 752.2778132992279, 765.8047197964595, 4808.230683090758, 5130.666506677054, 5137.2037334213255, 5144.742762861917, 5157.58739300855, 105176.0, 105493.89179755672, 105552.47223763831, 107870.0, 111953.88046119598, 82214.58892705498, 87901.0, 88865.0, 89484.552577238, 91832.0, 76368.23631763611, 77181.0, 77977.61011194908, 78811.0, 79499.0, 7583.05211848519, 9828.0, 10070.44612546317, 10129.189664826943, 10140.391576505433, 50749.49250507448, 51060.48939510557, 52063.958720824616, 52280.0, 53592.73203633957, 63308.050379243425, 65754.67122664356, 66098.66950665216, 66919.78928535891, 67922.0, 10306.278560500694, 11450.541978320774, 11765.941170294436, 11792.29246245228, 11806.551202185956, 13028.804567931298, 13297.933510332387, 13307.268100254192, 13312.733745325233, 13330.666733331744, 12451.875481245434, 12571.748565028465, 12733.29966851795, 12845.550405735754, 13171.40728667193, 12044.156909016285, 12383.814242786546, 12412.81380779307, 12440.626781196579, 12879.678008049874, 10227.43749093807, 12325.815112773495, 12381.380930953235, 12735.172213806072, 12742.554010609585, 9270.953645231732, 9318.297693668761, 9789.657361992297, 9820.11618954269, 9824.5087745611, 8773.744733804228, 9700.304900721127, 10419.687409377731, 10624.628138015132, 10656.786864262827], "value": 7760.737573091254, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 115.0, 116.0, 114.0, 116.0, 113.0, 113.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 113.0, 170.0, 137.0, 138.0, 107.0, 107.0, 129.0, 132.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 184.0, 182.0, 186.0, 183.0, 184.0, 184.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 89.0, 59.0, 61.0, 65.0, 81.0, 98.0, 86.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 88.0, 69.0, 70.0, 68.0, 81.0, 70.0, 68.0, 81.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 92.0, 135.0, 110.0, 89.0, 87.0, 88.0, 89.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 104.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 86.0, 84.0, 85.0, 83.0, 89.0, 87.0, 83.0, 101.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 61.0, 62.0, 61.0, 62.0, 64.0, 65.0, 65.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 66.0, 65.0, 60.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 83.0, 80.0, 76.0, 98.0, 78.0, 85.0, 88.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 148.0, 134.0, 133.0, 132.0, 145.0, 136.0, 201.0, 178.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 162.0, 161.0, 161.0, 161.0, 165.0, 160.0, 160.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 64.0, 63.0, 63.0, 64.0, 61.0, 63.0], "value": 63.3, "unit": "score"}]}]} 11:20:03 INFO - Return code: 0 11:20:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:20:03 INFO - # TBPL SUCCESS # 11:20:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:20:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:20:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:20:03 INFO - 2017-04-25 11:20:03.759 screenresolution[1657:9668] starting screenresolution argv=screenresolution get 11:20:03 INFO - 2017-04-25 11:20:03.761 screenresolution[1657:9668] Display 0: 1600x1200x32@60 11:20:03 INFO - 2017-04-25 11:20:03.767 screenresolution[1658:9671] starting screenresolution argv=screenresolution list 11:20:03 INFO - Available Modes on Display 0 11:20:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:20:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:20:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:20:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:20:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:20:03 INFO - Intel Iris: 11:20:03 INFO - Chipset Model: Intel Iris 11:20:03 INFO - Type: GPU 11:20:03 INFO - Bus: Built-In 11:20:03 INFO - VRAM (Dynamic, Max): 1536 MB 11:20:03 INFO - Vendor: Intel (0x8086) 11:20:03 INFO - Device ID: 0x0a2e 11:20:03 INFO - Revision ID: 0x0009 11:20:03 INFO - Displays: 11:20:03 INFO - Display: 11:20:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:20:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:20:03 INFO - Display Serial Number: 1600x1200 60 11:20:03 INFO - Main Display: Yes 11:20:03 INFO - Mirror: Off 11:20:04 INFO - Online: Yes 11:20:04 INFO - Rotation: Supported 11:20:04 INFO - Return code: 0 11:20:04 INFO - Running post-action listener: _resource_record_post_action 11:20:04 INFO - [mozharness: 2017-04-25 18:20:04.003798Z] Finished run-tests step (success) 11:20:04 INFO - Running post-run listener: _resource_record_post_run 11:20:04 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 39404544; Write bytes: 423279616; Read time: 380; Write time: 1692 11:20:04 INFO - TinderboxPrint: CPU usage
53.7% 11:20:04 INFO - TinderboxPrint: I/O read bytes / time
39,404,544 / 380 11:20:04 INFO - TinderboxPrint: I/O write bytes / time
423,279,616 / 1,692 11:20:04 INFO - TinderboxPrint: CPU idle
2,211.9 (46.3%) 11:20:04 INFO - TinderboxPrint: CPU system
954.4 (20.0%) 11:20:04 INFO - TinderboxPrint: CPU user
1,615.5 (33.8%) 11:20:04 INFO - TinderboxPrint: Swap in / out
161,001,472 / 0 11:20:04 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119540224; Write bytes: 115832832; Read time: 11053; Write time: 292 11:20:04 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37299200; Write bytes: 296379392; Read time: 354; Write time: 1366 11:20:04 INFO - Running post-run listener: _upload_blobber_files 11:20:04 INFO - Blob upload gear active. 11:20:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:20:04 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 11:20:04 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'] 11:20:04 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 11:20:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:20:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:06 INFO - (blobuploader) - INFO - Done attempting. 11:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:06 INFO - (blobuploader) - INFO - Done attempting. 11:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:07 INFO - (blobuploader) - INFO - Done attempting. 11:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:09 INFO - (blobuploader) - INFO - Done attempting. 11:20:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:09 INFO - Return code: 0 11:20:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5813a3f167c16e26a1b7531061ec1dd2cd5e260cc406f2c0b5dd45dd88578c70bd2adda6e25b3423af0aa803237116725917e2abe5477daa534b300b464d5a71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9661585a2d48396594c56651e2a5f36df50d9259b5c45c927bc4dd06dcfcc507cf1b7dca1bdc42343fde716df159babbe64c5c071f86114d1ffa89935a3d716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5d27de3e4b7c83a28fb589d02b4fd5085e4dee575bc34b0948840ae87db62957dc5118de5a9da6d54ad51368583bf66e5e183156a62c394e7e210fbf032aa57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55b46fc41e812cc1c48f85c67b001a8e7c467231c83b6644adf215ae8b8a88ffc6441c73707c26dc565cd352ecf5cb762ca8b162eac694446e82073ae30c7327"} 11:20:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:09 INFO - Contents: 11:20:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5813a3f167c16e26a1b7531061ec1dd2cd5e260cc406f2c0b5dd45dd88578c70bd2adda6e25b3423af0aa803237116725917e2abe5477daa534b300b464d5a71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9661585a2d48396594c56651e2a5f36df50d9259b5c45c927bc4dd06dcfcc507cf1b7dca1bdc42343fde716df159babbe64c5c071f86114d1ffa89935a3d716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5d27de3e4b7c83a28fb589d02b4fd5085e4dee575bc34b0948840ae87db62957dc5118de5a9da6d54ad51368583bf66e5e183156a62c394e7e210fbf032aa57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55b46fc41e812cc1c48f85c67b001a8e7c467231c83b6644adf215ae8b8a88ffc6441c73707c26dc565cd352ecf5cb762ca8b162eac694446e82073ae30c7327"} 11:20:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:09 INFO - Copying logs to upload dir... 11:20:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.250519 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 11:20:10.012362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 11:20:10.015776) ========= 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.85yGcpqIzF/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.7VcDJkiAnj/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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/5813a3f167c16e26a1b7531061ec1dd2cd5e260cc406f2c0b5dd45dd88578c70bd2adda6e25b3423af0aa803237116725917e2abe5477daa534b300b464d5a71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9661585a2d48396594c56651e2a5f36df50d9259b5c45c927bc4dd06dcfcc507cf1b7dca1bdc42343fde716df159babbe64c5c071f86114d1ffa89935a3d716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5d27de3e4b7c83a28fb589d02b4fd5085e4dee575bc34b0948840ae87db62957dc5118de5a9da6d54ad51368583bf66e5e183156a62c394e7e210fbf032aa57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55b46fc41e812cc1c48f85c67b001a8e7c467231c83b6644adf215ae8b8a88ffc6441c73707c26dc565cd352ecf5cb762ca8b162eac694446e82073ae30c7327"} build_url:https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010850 build_url: 'https://queue.taskcluster.net/v1/task/Ddk0nQf-TyOunbGWr6xWDQ/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/5813a3f167c16e26a1b7531061ec1dd2cd5e260cc406f2c0b5dd45dd88578c70bd2adda6e25b3423af0aa803237116725917e2abe5477daa534b300b464d5a71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9661585a2d48396594c56651e2a5f36df50d9259b5c45c927bc4dd06dcfcc507cf1b7dca1bdc42343fde716df159babbe64c5c071f86114d1ffa89935a3d716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b5d27de3e4b7c83a28fb589d02b4fd5085e4dee575bc34b0948840ae87db62957dc5118de5a9da6d54ad51368583bf66e5e183156a62c394e7e210fbf032aa57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/55b46fc41e812cc1c48f85c67b001a8e7c467231c83b6644adf215ae8b8a88ffc6441c73707c26dc565cd352ecf5cb762ca8b162eac694446e82073ae30c7327"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 11:20:10.050357) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 11:20:10.050684) ========= 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.85yGcpqIzF/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.7VcDJkiAnj/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005174 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 11:20:10.100852) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 11:20:10.101414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 11:20:10.102001) ========= ========= Total master_lag: 0.18 =========