builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0026 starttime: 1481829636.3 results: success (0) buildid: 20161215085501 builduid: 2fac92de9cb2479eab5a0a8b6ea37a67 revision: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.296660) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.297096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.297367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.323085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.323341) ========= 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.KOLyllnX3i/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.1EMdh6vf6j/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 --2016-12-15 11:20:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.4M=0.001s 2016-12-15 11:20:36 (11.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159766 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.506619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.509929) ========= 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.KOLyllnX3i/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.1EMdh6vf6j/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.026079 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:36.558273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 11:20:36.558586) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 --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 ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KOLyllnX3i/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.1EMdh6vf6j/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 2016-12-15 11:20:36,657 truncating revision to first 12 chars 2016-12-15 11:20:36,657 Setting DEBUG logging. 2016-12-15 11:20:36,657 attempt 1/10 2016-12-15 11:20:36,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ae5275b8c53b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 11:20:38,033 unpacking tar archive at: mozilla-beta-ae5275b8c53b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.668649 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 11:20:38.255001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:38.255364) ========= script_repo_revision: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:38.255796) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:38.256098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 11:20:38.275612) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-15 11:20:38.275930) ========= /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.KOLyllnX3i/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.1EMdh6vf6j/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 11:20:38 INFO - MultiFileLogger online at 20161215 11:20:38 in /builds/slave/test 11:20:38 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 11:20:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:38 INFO - {'append_to_log': False, 11:20:38 INFO - 'base_work_dir': '/builds/slave/test', 11:20:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:20:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:38 INFO - 'branch': 'Mozilla-Beta', 11:20:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:38 INFO - 'config_files': ('talos/mac_config.py',), 11:20:38 INFO - 'default_actions': ('clobber', 11:20:38 INFO - 'read-buildbot-config', 11:20:38 INFO - 'download-and-extract', 11:20:38 INFO - 'populate-webroot', 11:20:38 INFO - 'create-virtualenv', 11:20:38 INFO - 'install', 11:20:38 INFO - 'run-tests'), 11:20:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:38 INFO - 'download_minidump_stackwalk': True, 11:20:38 INFO - 'download_symbols': 'ondemand', 11:20:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:38 INFO - 'installer_path': 'installer.exe', 11:20:38 INFO - 'log_level': 'info', 11:20:38 INFO - 'log_name': 'talos', 11:20:38 INFO - 'log_to_console': True, 11:20:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:20:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:20:38 INFO - 'opt_config_files': (), 11:20:38 INFO - 'pip_index': False, 11:20:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:20:38 INFO - 'cmd': ('bash', 11:20:38 INFO - '-c', 11:20:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:20:38 INFO - 'enabled': True, 11:20:38 INFO - 'halt_on_failure': False, 11:20:38 INFO - 'name': 'check_screen_resolution'},), 11:20:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:20:38 INFO - 'cmd': ('bash', 11:20:38 INFO - '-c', 11:20:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:20:38 INFO - 'enabled': True, 11:20:38 INFO - 'halt_on_failure': False, 11:20:38 INFO - 'name': 'check_screen_resolution'},), 11:20:38 INFO - 'run_cmd_checks_enabled': True, 11:20:38 INFO - 'sps_profile': False, 11:20:38 INFO - 'sps_profile_interval': 0, 11:20:38 INFO - 'suite': 'dromaeojs', 11:20:38 INFO - 'system_bits': '32', 11:20:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:38 INFO - 'title': 't-yosemite-r7-0026', 11:20:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:38 INFO - 'use_talos_json': True, 11:20:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:38 INFO - 'work_dir': 'build'} 11:20:38 INFO - [mozharness: 2016-12-15 19:20:38.466182Z] Running clobber step. 11:20:38 INFO - Running pre-action listener: _resource_record_pre_action 11:20:38 INFO - Running main action method: clobber 11:20:38 INFO - rmtree: /builds/slave/test/build 11:20:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:40 INFO - Running post-action listener: _resource_record_post_action 11:20:40 INFO - [mozharness: 2016-12-15 19:20:40.888785Z] Finished clobber step (success) 11:20:40 INFO - [mozharness: 2016-12-15 19:20:40.888931Z] Running read-buildbot-config step. 11:20:40 INFO - Running pre-action listener: _resource_record_pre_action 11:20:40 INFO - Running main action method: read_buildbot_config 11:20:40 INFO - Using buildbot properties: 11:20:40 INFO - { 11:20:40 INFO - "project": "", 11:20:40 INFO - "product": "firefox", 11:20:40 INFO - "script_repo_revision": "production", 11:20:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:20:40 INFO - "repository": "", 11:20:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:20:40 INFO - "buildid": "20161215085501", 11:20:40 INFO - "pgo_build": "False", 11:20:40 INFO - "basedir": "/builds/slave/test", 11:20:40 INFO - "buildnumber": 3, 11:20:40 INFO - "slavename": "t-yosemite-r7-0026", 11:20:40 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:20:40 INFO - "platform": "yosemite_r7", 11:20:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:20:40 INFO - "branch": "mozilla-beta", 11:20:40 INFO - "repo_path": "releases/mozilla-beta", 11:20:40 INFO - "revision": "ae5275b8c53ba76cb98576e4e2a3031b0d659ba3", 11:20:40 INFO - "stage_platform": "macosx64", 11:20:40 INFO - "builduid": "2fac92de9cb2479eab5a0a8b6ea37a67", 11:20:40 INFO - "slavebuilddir": "test" 11:20:40 INFO - } 11:20:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 11:20:40 INFO - Running post-action listener: _resource_record_post_action 11:20:40 INFO - [mozharness: 2016-12-15 19:20:40.892288Z] Finished read-buildbot-config step (success) 11:20:40 INFO - [mozharness: 2016-12-15 19:20:40.892440Z] Running download-and-extract step. 11:20:40 INFO - Running pre-action listener: _resource_record_pre_action 11:20:40 INFO - Running main action method: download_and_extract 11:20:40 INFO - mkdir: /builds/slave/test/build/tests 11:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:40 INFO - trying https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 11:20:40 INFO - Downloading https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 11:20:41 INFO - Downloaded 1165 bytes. 11:20:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:20:41 INFO - Using the following test package requirements: 11:20:41 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:20:41 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:20:41 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 11:20:41 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:20:41 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 11:20:41 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:20:41 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:20:41 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 11:20:41 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:20:41 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:20:41 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 11:20:41 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:20:41 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 11:20:41 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:20:41 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 11:20:41 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:20:41 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 11:20:41 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 11:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:20:41 INFO - Fetch https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:20:42 INFO - Expected file size: 16232525 11:20:49 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:20:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:20:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:20:49 INFO - Fetch https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:20:50 INFO - Expected file size: 16232525 11:20:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 11:20:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 11:20:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 11:20:57 INFO - Expected file size: 14414089 11:20:58 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:20:58 INFO - trying https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:20:58 INFO - Downloading https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 11:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 11:21:00 INFO - Downloaded 86078229 bytes. 11:21:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:21:00 INFO - mkdir: /builds/slave/test/properties 11:21:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:21:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:21:00 INFO - Contents: 11:21:00 INFO - build_url:https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:21:01 INFO - Running post-action listener: _resource_record_post_action 11:21:01 INFO - Running post-action listener: set_extra_try_arguments 11:21:01 INFO - [mozharness: 2016-12-15 19:21:01.588216Z] Finished download-and-extract step (success) 11:21:01 INFO - [mozharness: 2016-12-15 19:21:01.588350Z] Running populate-webroot step. 11:21:01 INFO - Running pre-action listener: _resource_record_pre_action 11:21:01 INFO - Running main action method: populate_webroot 11:21:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:21:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:21:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:21:01 INFO - '--tppagecycles', 11:21:01 INFO - '7'], 11:21:01 INFO - 'tests': ['tsvgm']}}, 11:21:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:21:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:21:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:21:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:21:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['damp', 'tps']}, 11:21:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'tests': ['damp', 'tps']}, 11:21:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['dromaeo_dom']}, 11:21:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:21:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['basic_compositor_video']}, 11:21:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:21:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['a11yr', 11:21:01 INFO - 'ts_paint', 11:21:01 INFO - 'tpaint', 11:21:01 INFO - 'sessionrestore', 11:21:01 INFO - 'sessionrestore_no_auto_restore', 11:21:01 INFO - 'tabpaint']}, 11:21:01 INFO - 'other-e10s': {'tests': ['a11yr', 11:21:01 INFO - 'ts_paint', 11:21:01 INFO - 'tpaint', 11:21:01 INFO - 'sessionrestore', 11:21:01 INFO - 'sessionrestore_no_auto_restore', 11:21:01 INFO - 'tabpaint']}, 11:21:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:21:01 INFO - 'ts_paint', 11:21:01 INFO - 'tpaint', 11:21:01 INFO - 'sessionrestore', 11:21:01 INFO - 'sessionrestore_no_auto_restore', 11:21:01 INFO - 'tabpaint']}, 11:21:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:21:01 INFO - 'ts_paint', 11:21:01 INFO - 'tpaint', 11:21:01 INFO - 'sessionrestore', 11:21:01 INFO - 'sessionrestore_no_auto_restore', 11:21:01 INFO - 'tabpaint']}, 11:21:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['a11yr', 11:21:01 INFO - 'ts_paint', 11:21:01 INFO - 'tpaint', 11:21:01 INFO - 'sessionrestore', 11:21:01 INFO - 'sessionrestore_no_auto_restore', 11:21:01 INFO - 'tabpaint']}, 11:21:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['a11yr', 11:21:01 INFO - 'ts_paint', 11:21:01 INFO - 'tpaint', 11:21:01 INFO - 'sessionrestore', 11:21:01 INFO - 'sessionrestore_no_auto_restore', 11:21:01 INFO - 'tabpaint']}, 11:21:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['tsvgx', 11:21:01 INFO - 'tsvgr_opacity', 11:21:01 INFO - 'tart', 11:21:01 INFO - 'tscrollx', 11:21:01 INFO - 'cart']}, 11:21:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:21:01 INFO - 'tsvgr_opacity', 11:21:01 INFO - 'tart', 11:21:01 INFO - 'tscrollx', 11:21:01 INFO - 'cart']}, 11:21:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'talos_options': ['--disable-e10s'], 11:21:01 INFO - 'tests': ['tp5o']}, 11:21:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'tests': ['tp5o']}, 11:21:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'talos_options': ['--disable-e10s', 11:21:01 INFO - '--xperf_path', 11:21:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:01 INFO - 'tests': ['tp5n']}, 11:21:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:01 INFO - 'talos_options': ['--xperf_path', 11:21:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:01 INFO - 'tests': ['tp5n']}}, 11:21:01 INFO - 'talos.zip': {'path': '', 11:21:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:21:01 INFO - Running post-action listener: _resource_record_post_action 11:21:01 INFO - [mozharness: 2016-12-15 19:21:01.606621Z] Finished populate-webroot step (success) 11:21:01 INFO - [mozharness: 2016-12-15 19:21:01.606745Z] Running create-virtualenv step. 11:21:01 INFO - Running pre-action listener: _resource_record_pre_action 11:21:01 INFO - Running main action method: create_virtualenv 11:21:01 INFO - Creating virtualenv /builds/slave/test/build/venv 11:21:01 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 11:21:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:21:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:21:01 INFO - Using real prefix '/tools/python27' 11:21:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:21:02 INFO - Installing distribute.............................................................................................................................................................................................done. 11:21:05 INFO - Installing pip.................done. 11:21:05 INFO - Return code: 0 11:21:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:21:05 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:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 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:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:05 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 11:21:05 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 11:21:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:05 INFO - 'HOME': '/Users/cltbld', 11:21:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PAGER': '/bin/cat', 11:21:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:05 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - 'XPC_FLAGS': '0x0', 11:21:05 INFO - 'XPC_SERVICE_NAME': '0', 11:21:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:05 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 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:21:05 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:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 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:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:05 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 11:21:05 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 11:21:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:05 INFO - 'HOME': '/Users/cltbld', 11:21:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PAGER': '/bin/cat', 11:21:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:05 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - 'XPC_FLAGS': '0x0', 11:21:05 INFO - 'XPC_SERVICE_NAME': '0', 11:21:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:05 INFO - Downloading/unpacking psutil>=3.1.1 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:09 INFO - Installing collected packages: psutil 11:21:09 INFO - Running setup.py install for psutil 11:21:09 INFO - building 'psutil._psutil_osx' extension 11:21:09 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 11:21:10 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 11:21:10 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 11:21:10 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 11:21:10 INFO - building 'psutil._psutil_posix' extension 11:21:10 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 11:21:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:21:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:21:10 INFO - ^ 11:21:10 INFO - 1 warning generated. 11:21:10 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 11:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:10 INFO - Successfully installed psutil 11:21:10 INFO - Cleaning up... 11:21:10 INFO - Return code: 0 11:21:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:21:10 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:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:10 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:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:10 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:10 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 11:21:10 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 11:21:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:10 INFO - 'HOME': '/Users/cltbld', 11:21:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:10 INFO - 'LOGNAME': 'cltbld', 11:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:10 INFO - 'MOZ_NO_REMOTE': '1', 11:21:10 INFO - 'NO_EM_RESTART': '1', 11:21:10 INFO - 'PAGER': '/bin/cat', 11:21:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:10 INFO - 'PWD': '/builds/slave/test', 11:21:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:10 INFO - 'SHELL': '/bin/bash', 11:21:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:10 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:10 INFO - 'USER': 'cltbld', 11:21:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:10 INFO - 'XPC_FLAGS': '0x0', 11:21:10 INFO - 'XPC_SERVICE_NAME': '0', 11:21:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:21:10 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:21:10 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:21:10 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:21:10 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:21:10 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:21:10 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:21:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:13 INFO - Installing collected packages: mozsystemmonitor 11:21:13 INFO - Running setup.py install for mozsystemmonitor 11:21:13 INFO - Successfully installed mozsystemmonitor 11:21:13 INFO - Cleaning up... 11:21:13 INFO - Return code: 0 11:21:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21:13 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:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:13 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:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:13 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:13 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 11:21:13 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 11:21:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:13 INFO - 'HOME': '/Users/cltbld', 11:21:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:13 INFO - 'LOGNAME': 'cltbld', 11:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:13 INFO - 'MOZ_NO_REMOTE': '1', 11:21:13 INFO - 'NO_EM_RESTART': '1', 11:21:13 INFO - 'PAGER': '/bin/cat', 11:21:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:13 INFO - 'PWD': '/builds/slave/test', 11:21:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:13 INFO - 'SHELL': '/bin/bash', 11:21:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:13 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:13 INFO - 'USER': 'cltbld', 11:21:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:13 INFO - 'XPC_FLAGS': '0x0', 11:21:13 INFO - 'XPC_SERVICE_NAME': '0', 11:21:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:13 INFO - Downloading/unpacking jsonschema==2.5.1 11:21:13 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:21:13 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:21:13 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:21:13 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:21:13 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:21:13 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:21:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:16 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:21:16 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:21:16 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:21:16 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:21:16 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:21:16 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:21:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:17 INFO - warning: no files found matching '*.txt' 11:21:17 INFO - no previously-included directories found matching 'build' 11:21:17 INFO - no previously-included directories found matching 'dist' 11:21:17 INFO - no previously-included directories found matching '.git*' 11:21:17 INFO - Installing collected packages: jsonschema, functools32 11:21:17 INFO - Running setup.py install for functools32 11:21:17 INFO - warning: no files found matching '*.txt' 11:21:17 INFO - no previously-included directories found matching 'build' 11:21:17 INFO - no previously-included directories found matching 'dist' 11:21:17 INFO - no previously-included directories found matching '.git*' 11:21:17 INFO - Successfully installed jsonschema functools32 11:21:17 INFO - Cleaning up... 11:21:17 INFO - Return code: 0 11:21:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:21:17 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:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:17 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:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:17 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:17 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 11:21:17 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 11:21:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:17 INFO - 'HOME': '/Users/cltbld', 11:21:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:17 INFO - 'LOGNAME': 'cltbld', 11:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:17 INFO - 'MOZ_NO_REMOTE': '1', 11:21:17 INFO - 'NO_EM_RESTART': '1', 11:21:17 INFO - 'PAGER': '/bin/cat', 11:21:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:17 INFO - 'PWD': '/builds/slave/test', 11:21:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:17 INFO - 'SHELL': '/bin/bash', 11:21:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:17 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:17 INFO - 'USER': 'cltbld', 11:21:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:17 INFO - 'XPC_FLAGS': '0x0', 11:21:17 INFO - 'XPC_SERVICE_NAME': '0', 11:21:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:21:17 INFO - Cleaning up... 11:21:17 INFO - Return code: 0 11:21:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:17 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:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:17 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:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:17 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:17 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 11:21:17 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 11:21:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:17 INFO - 'HOME': '/Users/cltbld', 11:21:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:17 INFO - 'LOGNAME': 'cltbld', 11:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:17 INFO - 'MOZ_NO_REMOTE': '1', 11:21:17 INFO - 'NO_EM_RESTART': '1', 11:21:17 INFO - 'PAGER': '/bin/cat', 11:21:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:17 INFO - 'PWD': '/builds/slave/test', 11:21:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:17 INFO - 'SHELL': '/bin/bash', 11:21:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:17 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:17 INFO - 'USER': 'cltbld', 11:21:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:17 INFO - 'XPC_FLAGS': '0x0', 11:21:17 INFO - 'XPC_SERVICE_NAME': '0', 11:21:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:17 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:17 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:21:17 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:21:17 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:21:17 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:21:17 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:21:17 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:21:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:20 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:21:20 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:21:20 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:21:20 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:21:20 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:21:20 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:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:21 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:21:21 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:21:21 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:21:21 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:21:21 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:21:21 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:21:21 INFO - Downloading docopt-0.6.1.tar.gz 11:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:21 INFO - Running setup.py install for blobuploader 11:21:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:21 INFO - Running setup.py install for requests 11:21:22 INFO - Running setup.py install for docopt 11:21:22 INFO - Successfully installed blobuploader requests docopt 11:21:22 INFO - Cleaning up... 11:21:22 INFO - Return code: 0 11:21:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:22 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:22 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 11:21:22 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 11:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:22 INFO - 'HOME': '/Users/cltbld', 11:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:22 INFO - 'LOGNAME': 'cltbld', 11:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:22 INFO - 'MOZ_NO_REMOTE': '1', 11:21:22 INFO - 'NO_EM_RESTART': '1', 11:21:22 INFO - 'PAGER': '/bin/cat', 11:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:22 INFO - 'PWD': '/builds/slave/test', 11:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:22 INFO - 'SHELL': '/bin/bash', 11:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:22 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:22 INFO - 'USER': 'cltbld', 11:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:22 INFO - 'XPC_FLAGS': '0x0', 11:21:22 INFO - 'XPC_SERVICE_NAME': '0', 11:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:22 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-UgcxRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-pzvjYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-WjboED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-XGD55L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-BfvfXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Aoi240-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-SQmIfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-wrUejx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-igZriU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:23 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-CDbrXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-HAkrIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-EuqSTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7duR6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0FPynW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-L9cnaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qqT2PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-G3fmX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:24 INFO - Running setup.py install for manifestparser 11:21:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:24 INFO - Running setup.py install for mozcrash 11:21:25 INFO - Running setup.py install for mozdebug 11:21:25 INFO - Running setup.py install for mozdevice 11:21:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Running setup.py install for mozfile 11:21:25 INFO - Running setup.py install for mozhttpd 11:21:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Running setup.py install for mozinfo 11:21:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Running setup.py install for mozInstall 11:21:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:25 INFO - Running setup.py install for mozleak 11:21:26 INFO - Running setup.py install for mozlog 11:21:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:26 INFO - Running setup.py install for moznetwork 11:21:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:26 INFO - Running setup.py install for mozprocess 11:21:26 INFO - Running setup.py install for mozprofile 11:21:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:26 INFO - Running setup.py install for mozrunner 11:21:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:26 INFO - Running setup.py install for mozscreenshot 11:21:27 INFO - Running setup.py install for moztest 11:21:27 INFO - Running setup.py install for mozversion 11:21:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:27 INFO - Cleaning up... 11:21:27 INFO - Return code: 0 11:21:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:27 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:27 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:21:27 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:21:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:27 INFO - 'HOME': '/Users/cltbld', 11:21:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:27 INFO - 'LOGNAME': 'cltbld', 11:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:27 INFO - 'MOZ_NO_REMOTE': '1', 11:21:27 INFO - 'NO_EM_RESTART': '1', 11:21:27 INFO - 'PAGER': '/bin/cat', 11:21:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:27 INFO - 'PWD': '/builds/slave/test', 11:21:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:27 INFO - 'SHELL': '/bin/bash', 11:21:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:27 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:27 INFO - 'USER': 'cltbld', 11:21:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:27 INFO - 'XPC_FLAGS': '0x0', 11:21:27 INFO - 'XPC_SERVICE_NAME': '0', 11:21:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qefrit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:27 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:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-W6Umq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-63Z1ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:27 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:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-rWxGEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-lFk49C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-e2VLiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-RqpQhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-sxVkcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-IfVWUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Djov42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Np8vmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-xbxYVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-lJdy6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:28 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:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qgXtVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-eZnceY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:29 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:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-z6SShD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-jFgHEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:29 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:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:29 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:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:29 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:21:32 INFO - Downloading blessings-1.6.tar.gz 11:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:32 INFO - Installing collected packages: blessings 11:21:32 INFO - Running setup.py install for blessings 11:21:32 INFO - Successfully installed blessings 11:21:32 INFO - Cleaning up... 11:21:32 INFO - Return code: 0 11:21:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:32 INFO - Reading from file tmpfile_stdout 11:21:32 INFO - Current package versions: 11:21:32 INFO - blessings == 1.6 11:21:32 INFO - blobuploader == 1.2.4 11:21:32 INFO - docopt == 0.6.1 11:21:32 INFO - functools32 == 3.2.3-2 11:21:32 INFO - jsonschema == 2.5.1 11:21:32 INFO - manifestparser == 1.1 11:21:32 INFO - mozInstall == 1.12 11:21:32 INFO - mozcrash == 0.17 11:21:32 INFO - mozdebug == 0.1 11:21:32 INFO - mozdevice == 0.48 11:21:32 INFO - mozfile == 1.2 11:21:32 INFO - mozhttpd == 0.7 11:21:32 INFO - mozinfo == 0.9 11:21:32 INFO - mozleak == 0.1 11:21:32 INFO - mozlog == 3.4 11:21:32 INFO - moznetwork == 0.27 11:21:32 INFO - mozprocess == 0.23 11:21:32 INFO - mozprofile == 0.28 11:21:32 INFO - mozrunner == 6.12 11:21:32 INFO - mozscreenshot == 0.1 11:21:32 INFO - mozsystemmonitor == 0.3 11:21:32 INFO - moztest == 0.7 11:21:32 INFO - mozversion == 1.4 11:21:32 INFO - psutil == 3.1.1 11:21:32 INFO - requests == 1.2.3 11:21:32 INFO - wsgiref == 0.1.2 11:21:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:33 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 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:33 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:21:33 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:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:33 INFO - 'HOME': '/Users/cltbld', 11:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:33 INFO - 'LOGNAME': 'cltbld', 11:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:33 INFO - 'MOZ_NO_REMOTE': '1', 11:21:33 INFO - 'NO_EM_RESTART': '1', 11:21:33 INFO - 'PAGER': '/bin/cat', 11:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:33 INFO - 'PWD': '/builds/slave/test', 11:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:33 INFO - 'SHELL': '/bin/bash', 11:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:33 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:33 INFO - 'USER': 'cltbld', 11:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:33 INFO - 'XPC_FLAGS': '0x0', 11:21:33 INFO - 'XPC_SERVICE_NAME': '0', 11:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 INFO - Cleaning up... 11:21:33 INFO - Return code: 0 11:21:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ea3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8614ca1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, '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.KOLyllnX3i/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.1EMdh6vf6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:33 INFO - 'HOME': '/Users/cltbld', 11:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:33 INFO - 'LOGNAME': 'cltbld', 11:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:33 INFO - 'MOZ_NO_REMOTE': '1', 11:21:33 INFO - 'NO_EM_RESTART': '1', 11:21:33 INFO - 'PAGER': '/bin/cat', 11:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:33 INFO - 'PWD': '/builds/slave/test', 11:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:33 INFO - 'SHELL': '/bin/bash', 11:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:33 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:33 INFO - 'USER': 'cltbld', 11:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:33 INFO - 'XPC_FLAGS': '0x0', 11:21:33 INFO - 'XPC_SERVICE_NAME': '0', 11:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:33 INFO - Cleaning up... 11:21:33 INFO - Return code: 0 11:21:33 INFO - Running post-action listener: _resource_record_post_action 11:21:33 INFO - Running post-action listener: _start_resource_monitoring 11:21:33 INFO - Starting resource monitoring. 11:21:33 INFO - [mozharness: 2016-12-15 19:21:33.664327Z] Finished create-virtualenv step (success) 11:21:33 INFO - [mozharness: 2016-12-15 19:21:33.665297Z] Running install step. 11:21:33 INFO - Running pre-action listener: _resource_record_pre_action 11:21:33 INFO - Running main action method: install 11:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:33 INFO - Reading from file tmpfile_stdout 11:21:33 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:34 INFO - Reading from file tmpfile_stdout 11:21:34 INFO - Output received: 11:21:34 INFO - Usage: mozinstall [options] installer 11:21:34 INFO - Options: 11:21:34 INFO - -h, --help show this help message and exit 11:21:34 INFO - -d DEST, --destination=DEST 11:21:34 INFO - Directory to install application into. [default: 11:21:34 INFO - "/builds/slave/test"] 11:21:34 INFO - --app=APP Application being installed. [default: firefox] 11:21:34 INFO - mkdir: /builds/slave/test/build/application 11:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:21:56 INFO - Reading from file tmpfile_stdout 11:21:56 INFO - Output received: 11:21:56 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:21:56 INFO - Running post-action listener: _resource_record_post_action 11:21:56 INFO - [mozharness: 2016-12-15 19:21:56.534742Z] Finished install step (success) 11:21:56 INFO - [mozharness: 2016-12-15 19:21:56.534880Z] Running run-tests step. 11:21:56 INFO - Running pre-action listener: _resource_record_pre_action 11:21:56 INFO - Running main action method: run_tests 11:21:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:21:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:21:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:21:56 INFO - 2016-12-15 11:21:56.549 screenresolution[1625:7545] starting screenresolution argv=screenresolution get 11:21:56 INFO - 2016-12-15 11:21:56.552 screenresolution[1625:7545] Display 0: 1600x1200x32@60 11:21:56 INFO - 2016-12-15 11:21:56.558 screenresolution[1626:7548] starting screenresolution argv=screenresolution list 11:21:56 INFO - Available Modes on Display 0 11:21:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:21:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:21:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:21:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:21:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:21:56 INFO - Intel Iris: 11:21:56 INFO - Chipset Model: Intel Iris 11:21:56 INFO - Type: GPU 11:21:56 INFO - Bus: Built-In 11:21:56 INFO - VRAM (Dynamic, Max): 1536 MB 11:21:56 INFO - Vendor: Intel (0x8086) 11:21:56 INFO - Device ID: 0x0a2e 11:21:56 INFO - Revision ID: 0x0009 11:21:56 INFO - Displays: 11:21:56 INFO - Display: 11:21:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:21:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:21:56 INFO - Display Serial Number: 1600x1200 60 11:21:56 INFO - Main Display: Yes 11:21:56 INFO - Mirror: Off 11:21:56 INFO - Online: Yes 11:21:56 INFO - Rotation: Supported 11:21:56 INFO - Return code: 0 11:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:56 INFO - Python 2.7.3 11:21:56 INFO - Return code: 0 11:21:56 INFO - grabbing minidump binary from tooltool 11:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:56 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 0x100d41d30>, '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 0x100ba7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d39b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:56 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:21:56 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:21:56 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:21:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:56 INFO - Return code: 0 11:21:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:21:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:21:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:56 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/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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:21:56 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/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KOLyllnX3i/Render', 11:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:56 INFO - 'HOME': '/Users/cltbld', 11:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:56 INFO - 'LOGNAME': 'cltbld', 11:21:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:56 INFO - 'MOZ_NO_REMOTE': '1', 11:21:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:56 INFO - 'NO_EM_RESTART': '1', 11:21:56 INFO - 'PAGER': '/bin/cat', 11:21:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:56 INFO - 'PWD': '/builds/slave/test', 11:21:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:56 INFO - 'SHELL': '/bin/bash', 11:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1EMdh6vf6j/Listeners', 11:21:56 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 11:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:56 INFO - 'USER': 'cltbld', 11:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:56 INFO - 'XPC_FLAGS': '0x0', 11:21:56 INFO - 'XPC_SERVICE_NAME': '0', 11:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:56 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/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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:21:57 INFO - mozversion application_buildid: 20161215085501 11:21:57 INFO - mozversion application_changeset: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 11:21:57 INFO - mozversion application_display_name: Firefox 11:21:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:57 INFO - mozversion application_name: Firefox 11:21:57 INFO - mozversion application_remotingname: firefox 11:21:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:57 INFO - mozversion application_vendor: Mozilla 11:21:57 INFO - mozversion application_version: 51.0 11:21:57 INFO - mozversion platform_buildid: 20161215085501 11:21:57 INFO - mozversion platform_changeset: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 11:21:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:57 INFO - mozversion platform_version: 51.0 11:21:57 INFO - using testdate: 1481829717 11:21:57 INFO - actual date: 1481829717 11:21:57 INFO - starting webserver on 'localhost:49249' 11:21:57 INFO - SUITE-START | Running 2 tests 11:21:57 INFO - TEST-START | dromaeo_css 11:21:57 INFO - operating with platform_type : mac_ 11:21:57 INFO - Initialising browser for dromaeo_css test... 11:21:57 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmprdLozu/profile http://localhost:49249/getInfo.html) 11:21:59 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 11:21:59 INFO - PROCESS | 1636 | colorDepth:24 11:21:59 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 11:21:59 INFO - PROCESS | 1636 | __metrics 11:21:59 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:21:59 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:22:00 INFO - TEST-INFO | 1636: exit 0 11:22:00 INFO - Browser initialized. 11:22:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:22:00 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmprdLozu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:12 INFO - PROCESS | 1639 | RSS: Main: 168697856 11:22:12 INFO - PROCESS | 1639 | 11:23:06 INFO - PROCESS | 1639 | 1481829786530 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:25:14 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 11:25:16 INFO - PROCESS | 1639 | RSS: Main: 311726080 11:25:16 INFO - PROCESS | 1639 | 11:28:19 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 11:28:19 INFO - PROCESS | 1639 | RSS: Main: 303452160 11:28:19 INFO - PROCESS | 1639 | 11:31:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 11:31:22 INFO - PROCESS | 1639 | RSS: Main: 270901248 11:31:22 INFO - PROCESS | 1639 | 11:34:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 11:34:25 INFO - PROCESS | 1639 | RSS: Main: 271683584 11:34:25 INFO - PROCESS | 1639 | 11:37:28 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 11:37:29 INFO - PROCESS | 1639 | RSS: Main: 261992448 11:37:29 INFO - PROCESS | 1639 | 11:40:31 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 11:40:32 INFO - PROCESS | 1639 | RSS: Main: 364380160 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | __start_tp_report 11:40:32 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 11:40:32 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 11:40:32 INFO - PROCESS | 1639 | |i|pagename|runs| 11:40:32 INFO - PROCESS | 1639 | |0;dojo.html;2928.282570770161;3439.0886415099985;3476.1657202271444;3493.3362661094375;3504.491848681941;5631.267935168427;5703.515201207892;5730.7707691692385;5742.799002034924;5746.770129194832;5699.487046165844;5792.739326730297;5795;5798.246227990366;5800.216970708953;5251.501107394792;5267.789288428458;5275.630705850592;5318.095923692962;5325.094733895227;5209.348831396075;5215.1655735082395;5225.947740522584;5297.5232229099565;5379.704116273603;5322.787088516455;5327.866803329909;5332.33345831771;5337.946620533784;5338.06583847827;5245.554127899133;5262.60530460217;5304.549113325372;5331.600129990266;5351.170568561879;5211.166213405837;5215;5222.73886305687;5245.659032162897;5319.361676598833;5140.897182056376;5834.124881267801;5852.824415267549;5914.172015917775;5988.670623115727;5234.555062819665;6137.070562331796;6196.473299769525;6275.246970363585;6298.338674439164;6197.16338294329;6217.751289948396;6263.4989200864275;6263.937360626381;6269.435750782406;5901.704914754245;5913.733881975321;5930.7924222652;5940.910886336708;5951.642901425928;5384.703841288689;6200.689965501707;6274.152989346471;6299.905501417483;6332.95506241465;6236.532260080512;6246.781362652377;6247.812565623039;6248.937510624926;6259.217597800275;6297.307296197415;6301.52738544611;6324.588901721373;6326.6520341381665;6328.905066424008;6135.385782596134;6143.477804386677;6174.660393678301;6302.716377763011;6309.873802523924;5446.645968012067;6044.909326360108;6267.2479302484;6311.431971122621;6318.526110541728;4043.7169398141846;5048.570871475892;5056.342675452168;5060.620453465931;5093.032323858455;4470.798814053375;4483.3723278741;4505.842295519641;4531.68278220528;4549;5799.623024503394;5844.620099693507;5926.703664816742;5954.583179177416;6028.758849645965;6268.592541484789;6306;6328;6340.873182536416;6343.682815859189;5974.880502390015;5992.161097446361;5996.2504686914135;6014.308354539284;6030.668313242726;5411.918821217685;5426.213199086111;5461.2354270402175;5488.368837583649;5507.531859791962;6393.904091438632;6396.872062558723;6416.550841441054;6421.5504914657395;6446.80659580204;6300.7479700811455;6313.368663133833;6324.557280990287;6335.841603959938;6351.237851457855;6207.534434917309;6249.843753906189;6276.215473065867;6357.777477788255;6414.390632889868;6256.655883926428;6307.495400368051;6325.082862984749;6328.050792381179;6328.557001009885;6189.473894718999;6318.368163183645;6331.715072821827;6337.8732425352155;6349.206349206349;6107.480864126599;6137.693115344304;6194.504439644727;6205.348438414082;6266.592671476339;6135.998322734094;6144.634315788364;6190.7523699051535;6262;6275.278342990615;6086.72609732572;6088.695565221809;6113.755449781959;6121.663308517896;6136.846578835565;5840.415958404125;6126.877462450815;6246.281677607133;6256.280527739368;6263.3736626337;6000.609960352563;6037.275526936795;6073.180120683828;6092.086187071975;6155.446009858955 11:40:32 INFO - PROCESS | 1639 | |1;ext.html;509.5439581574491;524.6353784120038;532.4568939681525;535.7321339330335;549.3682265394793;32084;34359;42699.57300426995;42752.78623606878;45273.54726452735;44702.55297447024;44932.775336123275;44943.101137977304;45121.774391128;45205.54794452054;10038.799224015496;10227.642032528864;10229.590816367336;10235.692929212099;10235.846462303072;9386.953065234664;9589.04109589039;12304.200226985262;12571.874281257207;12589.992800575932;12545.937270313636;12629.747405051894;12635.368231588383;12642.747145057094;12652.17760845542;12570.937145314261;12635;12636.557720479832;12642.55751048718;12685.492580296777;12405.875941240562;12478.625641230778;12494.562690305796;12503;12506.437210325557;41318.1736365271;41510.37734433986;41578;41588.37617435741;41625.791871040754;3636.8727094551828;3658.268346330718;3704.6110158433517;4020.4170395292813;4021.070328937871;31729.524057139162;31782.682173178204;31903.840480797448;32175.19562010945;32303.030909072764;3356.9160770980675;3366.309906469168;3437.9656203437894;3446.7070299024613;3531.770434921722;394903;395117.024414879;396576;396599;396736.0163199165;33869;34231;34443.4833477493;58527.70736146377;58661;36463.63536364656;36529;36554.451683224775;36600.45099323512;36651.4502282466;15667.373305067898;15850.60373490672;15862.52412427629;15871.20643967797;15897.046177229404;12073.87926120745;12304.323262220485;13206.933965330112;13335;13352.46590136403;7999.640016199285;8120.75637730869;8152.184781521801;8180.672773089129;8224.136465671138;3357.9758173757236;3401.5407919930985;3403.149212696826;3417.726581873444;3432.090496018557;885.6590212768131;989.3865803201917;1000.4597517340554;1006.9395836249848;1018.8777346718441;30396.392072158433;30996.845015775227;31000.22499437532;31327.686723132476;31928.68071319257;1045.5869931377063;1054.8997845204694;1060.2737125069352;1107.9279846809932;1163.3601519164426;16296.777741669423;16988.49034528966;17010.659786804194;17023.06373149464;17430.564235894206;643975;647906;650772;652596;653325;59843.700781496686;60398;60462;60613.393866061655;60892.086618700756;1299.6555912683148;1327.3495986966318;1419.2761691537185;1429.9142051476945;1461.1817382265965;29520.96676616308;30982.22544436407;31581;31847.885324013547;32166.035018949467;48211;57274.14088788588;58433.70783146057;58477.415225847195;62315;628904;634644;635887;636115;638549;37206.25587488289;37843.62156378401;41857.372139417326;44197.779011104736;44255;48330.758346208044;49042.509574903794;49073.5092649069;49404.258936116705;49628;39343;40377;41579.89334680105;41755.7912210437;42051;38960.610393895695;40876.59123408728;41078.38382424326;42063;42535.361969569865;39642.207155856144;40043;40466.1906761869;40600;40766.38850417187;29825.70174298316;33070.00789976305;35408.58365665344;35992.820035899655;36388.27223455463;22685.319440416813;25860.482790344464;26073.869630651727;26301;26334 11:40:32 INFO - PROCESS | 1639 | |2;jquery.html;355.21851925763326;386.68098818474755;386.87039841653046;396.26888390918754;407.9204555111754;20497.795022049773;21168.25911093112;21990.450238744;22110;22433;21177.258795942143;21264.681029784566;21530.784692153073;22051.779482205173;22273.331800046024;5649.096144616852;6093.207882975207;6161.845953851167;6163.322034576193;6183.1961844960315;4362.672799540047;4437.6671749618745;4453.955460445402;6026.0960855871535;6169.352218017111;4414.911701765963;6747.0216818561275;6832.2826103259185;6833.863322733542;6835.350641689057;6538.346165383447;6753.966230168867;6811.386975172259;6814.420774234196;6822.215445223813;5936.436038576328;5977.820665380045;5988.461038506555;5989.700514974277;5999.490043346321;26465.338366540796;26806.731932680617;26820.59769103465;26978.325541861414;27162.456750864872;2330.603797354454;2419.5765740995257;2515.4717509323063;2644.9603255951174;2973.509370953812;15973.92013039939;16161.9494732842;16368.299230626932;16539.586510337216;17079.829201707948;1818.9636207275912;1910.149983257451;1926.7109933509946;1944.9708254376196;1979.960400791976;97151.51424242904;104657.47671261671;111223;111555.44222278918;112539;10765.01694373087;11096.00135987765;11119.55521779136;11361.829572556418;11405.201635885574;14481.348339324755;14501.854981450051;14530.346134423977;14533;14551;8967;9090.818183636422;9094.499802510925;9102.908970910206;9216.308776841764;9140.497272649935;9146.496942668084;9165.762622045939;9322.114399132071;9322.114399132071;5879.676617786063;6801.251862295144;6921.781371662201;6930.688119034656;6931.480138989495;1728.809830918623;1849.7687789026372;1885.9905700471684;1924.874883132592;1926.5954149628456;748.4648476339444;850.5237067242364;952.6094301336419;968.2979839616363;986.2504496582505;18998;22462.550748985257;23311.417214569432;23504;23524.529509409716;977.6822532676908;1012.3419777144768;1030.407515678473;1047.2669131607904;1082.0729925551366;11638;12141.878581214252;12336.259824410565;12345.135840491079;12430.254184748945;556721;562619.1869040629;564144;564881;568519;115070;115813.42093289479;119871.2019319711;120119;123811;1044.2637940252105;1050.175612144463;1051.295631926611;1053.562771449855;1081.6971248050559;19646.91941943207;19885.502862428555;20244;20255.696164557838;20302.289419870234;36850;49074.773130672016;49368.50631493639;50376.740581485756;51395;70645;73123.63438182775;73239.1690207749;74856;75482.24517754752;7347.66935487915;7675.501092429197;7831.2560306770765;8324.958375208085;8414.579271036302;12973.935130324287;13413.396397162347;13484.460621575026;13654.453821847015;13979.301034948416;10847.837282440612;11210.607628732956;11578.131640127192;11907.583234587095;12084.637460876187;11433.371164585695;11458.369789661649;11620.709482263012;11774.3524106175;11929.940350298193;10843.295185812896;11181.273217240854;11669.88330116688;11999.82000270014;12105;6397.904031439439;7539.736109236151;7601.6579253934815;7727.188645192174;7728.845423091394;10262.230332725225;11742.58900938463;11794.882051179378;12108.273503589813;12166.026717862727 11:40:32 INFO - PROCESS | 1639 | |3;mootools.html;1495.4541592318803;1561.039960424339;1709.1112621436853;1808.2043900683707;1855.4619160443472;8627.482351058932;9197.540122993849;9200.309976751745;9209.861852072225;9213.861792073125;8102.351811855052;8320.251177394033;8334;8750.08124146965;8942.061083586212;2383.0467812874904;2424.9272521824287;2429.2226487524;2433.4889673168655;2433.9513209735796;2413.81896357773;2430.3924018995253;2452.3010941881566;2454.6563481112657;2457.213691618683;2421.6004359280787;2443.5601591713485;2449.363165576954;2455.4966231922413;2462.6182941644074;2410.3853517352964;2411.807055435561;2424.103081859714;2427.7329493755674;2434.9878250608813;2399.2082612737754;2411.2163546847346;2416.6012607919674;2418.093215044358;2421.539907417585;9011.188992990663;9022.052684468168;9140.90859091414;9152.31357648179;9156.954215228949;5341.1187154119525;5498.422665620133;5501.14732216507;5512.834614961557;5516.475934786189;3425.5889293284717;3554.0937061049267;3596.5504311961004;3607.603163651996;3613.4218525035867;993.3493561717087;1120.523777394604;1126.0709914320719;1142.582957220617;1142.8228624563205;11947.462364193632;11975.161738678296;11979.28124312544;12008.519659213622;12020.939895300555;4383.890402739957;4606.493285738566;4746.525347465225;4913.803447862117;4929.408470983505;10250.179985601135;10254.794904101876;10267.794644107225;10273.02406271403;10282.640107596199;5441.455854414606;5441.59188060897;5449;5460;5466.890662186734;4524.04994951064;4652.976735116303;4660.231061874821;4934.481879402683;4976.104301225741;3701.222743223899;4013.2141197167566;4034.636882680573;4063.045184381668;4173.871325623953;1288.9291088990196;1293.5084667826354;1295.9546415875589;1309.4958441000092;1311.5868501422021;905.6050412674471;926.754410081329;937.9108984646448;943.9716808495756;964.81668482988;5860.970695146582;5870.970645146833;6046.879062418727;6108.900397928415;6305.14880491137;376.20808198741804;426.94876614806424;427.542529493439;430.9979298131856;440.96251818595135;4041.333180025263;4047.575004624472;4055.3105971984833;4100.976209558971;4144.150449157915;10631.893681063091;10900.781984360268;11028.338299702044;11055.72360690989;11093.667189984313;10982.945085274683;11013.614523491638;11014.559417623366;11033.227674062899;11074;8213.753587392388;8282.302128063733;8293.585320733939;8296.377771667148;8302.83394332122;5333.7866485340155;5494.120940649477;5614.747336369792;5762.078067509178;5770.596058275881;9995.350302230332;10217.948910255402;10269.281150319406;10270.640527581798;10367;10048.799024019332;10302.536385862804;10476.895231047592;10564.630237941636;10592.682219533426;7044.119485064367;7241.131064272321;7244.275572442713;7819.726309579138;7911.8813217800625;8018.4787988780545;8093.35253179756;8199.795005124919;8366.205210504992;8504.617292221988;6503.51223658237;7678.61606919663;7709.344705699854;7719.266669666373;7856.607169641609;7569.507981981374;7583.886241706489;7642.312191902755;7652;7738.690452381842;7148.320909513588;7263.854722905407;7266.527675701062;7278.272172782679;7287.562746235243;4981.950180498148;5026.52248036436;5155;5166.173412254021;5203.814397952945;5215.5827533797965;5222.764975576184;5226.346706661668;5233.7383130842545;5278.261043453843 11:40:32 INFO - PROCESS | 1639 | |4;prototype.html;306.36429408976375;309.1436720284811;314.7938100544144;320.4136430332492;322.4373468297821;5354.357477102753;5371.75827087781;5403.540699040582;5410.756515956781;5443.8094666686675;4274.572542745724;5076.974615126919;5183.496785932085;5214.374275086985;5290.788368465257;3465;3553.5380400547892;3777.9044077217573;4113.897152571187;4204.957950420502;3548.6273941236186;4048.4615845978487;4065.796710164495;4082.040720430696;4127.814248358831;3861.903452413684;4012.358022716366;4085.6527195188446;4098.364753463218;4132.5040995080635;3473.94789078164;3916.608339166089;4076.266272071026;4089.9386509202236;4100.91798164035;3530.505729197914;3547.4324108142573;3559.0568499347437;3576.8390422431053;3590.281943611288;4476.895858946323;5066.594672426197;5249.585190812231;5263.078991159905;5284.5243928046275;3905.519994803292;4093.6111069448357;4640;4648.209804333272;4657.417822772153;5120.667156634807;5308.416074231832;5610.943890561083;5612.747426365823;5673.26247587815;3900.64894159527;3909.5113110861143;3939.660515424741;3946.3685810270217;3955.802209889494;5486.31421072366;5870.73581688825;5874.765009399619;5897.528197744213;5901.704914754245;3332.950005749916;3341.2649217172184;3516.804286542537;3890.2414029264023;3943.507061617298;3499.4575840744724;4030.6372426481757;4030.6775457963295;4053.1285773558825;4060.817263223162;4258.254115812502;4259.531451540328;4300.720453170597;4559.361689363492;4599.724016559017;4228.682848786353;4629.259318509023;5466.753996070186;5609.607327487037;5645.717714114277;1038.8597539332245;1129.390129330169;1234.8209509621233;1309.5351150341683;1364.8944355072424;824.1634740738156;843.1989609870648;869.452245085592;894.8926128864448;895.892492900856;4443.577860103285;5024.748762561857;5394.78420863169;5405.918911216335;5483.972580137074;4661.930071048937;4879.804807807648;5162.716050617252;5656.745446454919;5812.953668339739;4889.682170658896;5273.367195936512;5294.947050529446;5440.047991601454;5460.699661518575;2327.93016209514;2827.632407787016;3025.759438630151;3101.201303244113;3110.460322140555;5093.490650934951;5532.585056120807;5752.059932467699;6038.154658347835;6069;5313;5938.970305148533;6011.639301641915;6015.3383127855905;6043.456088951927;5635.6323849017335;6107.358727333655;6113.23584551931;6148.78479253224;6168.475679567287;4778.928316075192;5511.724413779215;5830.416958304136;5849.415058494116;5858.736356863866;5076.390833099904;5771.5759381059215;5802.709864506842;5812.273465816773;5851.853703657443;4539.750313732644;5865.328381411277;6074.969625151846;6084.969575152096;6094.695265236632;2917.4456853197826;3226.822524761161;3333.2166940769384;3350.3969285528838;3358.6473420291495;4140.743294904224;4758.952410475851;4883.80464781419;4884.7069175849565;4936.630417399597;4025.149694618037;4157.667386609124;4427.512973572969;4713.952860471351;4750.382450281441;4851.593038018935;5054.671446355975;5672.914906276492;5712.0860662293835;5719.113537401709;4246.681498887658;5250.711210883285;5379.892402152013;5578.442155784552;5588.764494202352;5250.579953603627;5603.719814009365;5643.548516118619;5698.572607054404;5713.771449141987;5647.689377084135;5648.729035966875;5677.154924649588;5732;5743.684097374685 11:40:32 INFO - PROCESS | 1639 | |5;yui.html;706.8550947055854;732.3152852083302;736.9078865141857;797.7965618767214;839.4459656626627;16387.918060409695;17093.743593846088;17119.999999999967;17130.400435984742;17149.31402743892;15320.387184512607;15389.923050384732;15411.46059887904;15429.074255544676;15430.305636246369;697.8394969157072;720.6396801599201;722.12622726501;870.6256309786789;873.7509809704204;881.4711173296035;888.3692578269437;900.7748062984253;903.3586153830788;905.0361365146131;955.4124213608616;957.4398976598663;957.5643082397527;958.3626888119393;963.4460185393392;949.4967667136428;952.4095061062186;952.6856137474651;953.5899563187896;954.0554850697829;703.8099713077492;704.24997377793;704.3977399323555;705.1608585782953;706.0750416953807;16033.438829640907;16343.918280408641;16515.6696866062;16518.917405413016;16599.41902033423;13743.931280343535;14148.858511414857;14385.78421323681;14388.28058597066;15154.090754554652;11813.940930295379;12106.878931210664;12326.876731232662;12400.81398779019;12512.304495242222;3778.9055273618105;3857.8071096445065;3900.0639846436934;3914.5106861642294;3930.78380689062;131106.99999999904;131386;131776.34111829475;132714;132740;10831.133509319236;11023.228374013903;11431.714207144887;11629.47667354971;11721;23435.296941091794;23446;23458;23463.7653623465;23477.943492542876;8059.274665280153;8237.629306681214;8306.335493160532;8450.830983380298;8669.956650216709;4589.908201835945;4594.1730488512385;4655;4713.552212539803;4867.853964381075;3270.5094235864335;3693.926121477555;3774.962250377516;3821.140243445258;3832.405977073558;669.3808227389645;678.2640834694313;679.3546131175304;689.2556039477353;691.4364792693939;666.5833853841349;679.4486702432433;686.9416099631487;690.147667630486;726.8001299642641;8525.44584601999;9242.353035287466;9751.609935602497;9883.654072107442;9904.257180711475;684.7537481783107;689.7861662884521;708.0901042160799;708.2280314457163;714.1644276196862;4593.425821772278;4806.182948898696;4837.7097374157665;4854.271859221074;4863.927041094386;102967.4851625752;137559;141186;168633.15683421504;174098.12950935418;78515.60742196253;93515.53242233745;104560;148051.2597437006;154930.22534887254;99561;100722.49638751759;100800.99199007916;102294;109997;9643.662471813454;10396.272260941661;10419.531121099417;10453.529591168568;10580.100691441314;58713;62414.68792656008;64513.677431612545;65135;66058.00912986213;85053.57473212594;99350;99500.50749238912;99523.50238248763;101740;12499.625011249676;12905;13302.93348533251;13399.464021439033;13877.861221387657;12866.485340586272;15404.15277159767;15444.691106178037;15619.687606248039;16372.345106195618;12062.51749929993;14015.299235038412;14587.927060365055;14675.706485870436;14708.191049492381;13937.442502299795;14166.079204851652;14330.57008289753;14348.210848403438;14371.137731735711;13440.865591344353;14093.506727264497;14173.787393189317;14424.42302307896;14622.488212912496;11620.758602166703;11643.53425862956;11823.645290641294;11970.324154618535;12380.752384952431;10079.899201007896;11653.242539234923;11724.179307448398;11940.940295298467;11974.221675591407 11:40:32 INFO - PROCESS | 1639 | __end_tp_report 11:40:32 INFO - PROCESS | 1639 | __start_cc_report 11:40:32 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1314 11:40:32 INFO - PROCESS | 1639 | __end_cc_report 11:40:32 INFO - PROCESS | 1639 | __startTimestamp1481830832200__endTimestamp 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | ------- Summary: start ------- 11:40:32 INFO - PROCESS | 1639 | Number of tests: 6 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5806.26 Median:6073.18 stddev:655.90 (10.8%) stddev-sans-first:617.83 11:40:32 INFO - PROCESS | 1639 | Values: 2928.3 3439.1 3476.2 3493.3 3504.5 5631.3 5703.5 5730.8 5742.8 5746.8 5699.5 5792.7 5795.0 5798.2 5800.2 5251.5 5267.8 5275.6 5318.1 5325.1 5209.3 5215.2 5225.9 5297.5 5379.7 5322.8 5327.9 5332.3 5337.9 5338.1 5245.6 5262.6 5304.5 5331.6 5351.2 5211.2 5215.0 5222.7 5245.7 5319.4 5140.9 5834.1 5852.8 5914.2 5988.7 5234.6 6137.1 6196.5 6275.2 6298.3 6197.2 6217.8 6263.5 6263.9 6269.4 5901.7 5913.7 5930.8 5940.9 5951.6 5384.7 6200.7 6274.2 6299.9 6333.0 6236.5 6246.8 6247.8 6248.9 6259.2 6297.3 6301.5 6324.6 6326.7 6328.9 6135.4 6143.5 6174.7 6302.7 6309.9 5446.6 6044.9 6267.2 6311.4 6318.5 4043.7 5048.6 5056.3 5060.6 5093.0 4470.8 4483.4 4505.8 4531.7 4549.0 5799.6 5844.6 5926.7 5954.6 6028.8 6268.6 6306.0 6328.0 6340.9 6343.7 5974.9 5992.2 5996.3 6014.3 6030.7 5411.9 5426.2 5461.2 5488.4 5507.5 6393.9 6396.9 6416.6 6421.6 6446.8 6300.7 6313.4 6324.6 6335.8 6351.2 6207.5 6249.8 6276.2 6357.8 6414.4 6256.7 6307.5 6325.1 6328.1 6328.6 6189.5 6318.4 6331.7 6337.9 6349.2 6107.5 6137.7 6194.5 6205.3 6266.6 6136.0 6144.6 6190.8 6262.0 6275.3 6086.7 6088.7 6113.8 6121.7 6136.8 5840.4 6126.9 6246.3 6256.3 6263.4 6000.6 6037.3 6073.2 6092.1 6155.4 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:69401.94 Median:20012.57 stddev:153144.66 (765.2%) stddev-sans-first:153486.92 11:40:32 INFO - PROCESS | 1639 | Values: 509.5 524.6 532.5 535.7 549.4 32084.0 34359.0 42699.6 42752.8 45273.5 44702.6 44932.8 44943.1 45121.8 45205.5 10038.8 10227.6 10229.6 10235.7 10235.8 9387.0 9589.0 12304.2 12571.9 12590.0 12545.9 12629.7 12635.4 12642.7 12652.2 12570.9 12635.0 12636.6 12642.6 12685.5 12405.9 12478.6 12494.6 12503.0 12506.4 41318.2 41510.4 41578.0 41588.4 41625.8 3636.9 3658.3 3704.6 4020.4 4021.1 31729.5 31782.7 31903.8 32175.2 32303.0 3356.9 3366.3 3438.0 3446.7 3531.8 394903.0 395117.0 396576.0 396599.0 396736.0 33869.0 34231.0 34443.5 58527.7 58661.0 36463.6 36529.0 36554.5 36600.5 36651.5 15667.4 15850.6 15862.5 15871.2 15897.0 12073.9 12304.3 13206.9 13335.0 13352.5 7999.6 8120.8 8152.2 8180.7 8224.1 3358.0 3401.5 3403.1 3417.7 3432.1 885.7 989.4 1000.5 1006.9 1018.9 30396.4 30996.8 31000.2 31327.7 31928.7 1045.6 1054.9 1060.3 1107.9 1163.4 16296.8 16988.5 17010.7 17023.1 17430.6 643975.0 647906.0 650772.0 652596.0 653325.0 59843.7 60398.0 60462.0 60613.4 60892.1 1299.7 1327.3 1419.3 1429.9 1461.2 29521.0 30982.2 31581.0 31847.9 32166.0 48211.0 57274.1 58433.7 58477.4 62315.0 628904.0 634644.0 635887.0 636115.0 638549.0 37206.3 37843.6 41857.4 44197.8 44255.0 48330.8 49042.5 49073.5 49404.3 49628.0 39343.0 40377.0 41579.9 41755.8 42051.0 38960.6 40876.6 41078.4 42063.0 42535.4 39642.2 40043.0 40466.2 40600.0 40766.4 29825.7 33070.0 35408.6 35992.8 36388.3 22685.3 25860.5 26073.9 26301.0 26334.0 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:33821.26 Median:12821.01 stddev:93684.33 (730.7%) stddev-sans-first:93913.44 11:40:32 INFO - PROCESS | 1639 | Values: 355.2 386.7 386.9 396.3 407.9 20497.8 21168.3 21990.5 22110.0 22433.0 21177.3 21264.7 21530.8 22051.8 22273.3 5649.1 6093.2 6161.8 6163.3 6183.2 4362.7 4437.7 4454.0 6026.1 6169.4 4414.9 6747.0 6832.3 6833.9 6835.4 6538.3 6754.0 6811.4 6814.4 6822.2 5936.4 5977.8 5988.5 5989.7 5999.5 26465.3 26806.7 26820.6 26978.3 27162.5 2330.6 2419.6 2515.5 2645.0 2973.5 15973.9 16161.9 16368.3 16539.6 17079.8 1819.0 1910.1 1926.7 1945.0 1980.0 97151.5 104657.5 111223.0 111555.4 112539.0 10765.0 11096.0 11119.6 11361.8 11405.2 14481.3 14501.9 14530.3 14533.0 14551.0 8967.0 9090.8 9094.5 9102.9 9216.3 9140.5 9146.5 9165.8 9322.1 9322.1 5879.7 6801.3 6921.8 6930.7 6931.5 1728.8 1849.8 1886.0 1924.9 1926.6 748.5 850.5 952.6 968.3 986.3 18998.0 22462.6 23311.4 23504.0 23524.5 977.7 1012.3 1030.4 1047.3 1082.1 11638.0 12141.9 12336.3 12345.1 12430.3 556721.0 562619.2 564144.0 564881.0 568519.0 115070.0 115813.4 119871.2 120119.0 123811.0 1044.3 1050.2 1051.3 1053.6 1081.7 19646.9 19885.5 20244.0 20255.7 20302.3 36850.0 49074.8 49368.5 50376.7 51395.0 70645.0 73123.6 73239.2 74856.0 75482.2 7347.7 7675.5 7831.3 8325.0 8414.6 12973.9 13413.4 13484.5 13654.5 13979.3 10847.8 11210.6 11578.1 11907.6 12084.6 11433.4 11458.4 11620.7 11774.4 11929.9 10843.3 11181.3 11669.9 11999.8 12105.0 6397.9 7539.7 7601.7 7727.2 7728.8 10262.2 11742.6 11794.9 12108.3 12166.0 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5818.17 Median:4629.74 stddev:3295.64 (71.2%) stddev-sans-first:3288.88 11:40:32 INFO - PROCESS | 1639 | Values: 1495.5 1561.0 1709.1 1808.2 1855.5 8627.5 9197.5 9200.3 9209.9 9213.9 8102.4 8320.3 8334.0 8750.1 8942.1 2383.0 2424.9 2429.2 2433.5 2434.0 2413.8 2430.4 2452.3 2454.7 2457.2 2421.6 2443.6 2449.4 2455.5 2462.6 2410.4 2411.8 2424.1 2427.7 2435.0 2399.2 2411.2 2416.6 2418.1 2421.5 9011.2 9022.1 9140.9 9152.3 9157.0 5341.1 5498.4 5501.1 5512.8 5516.5 3425.6 3554.1 3596.6 3607.6 3613.4 993.3 1120.5 1126.1 1142.6 1142.8 11947.5 11975.2 11979.3 12008.5 12020.9 4383.9 4606.5 4746.5 4913.8 4929.4 10250.2 10254.8 10267.8 10273.0 10282.6 5441.5 5441.6 5449.0 5460.0 5466.9 4524.0 4653.0 4660.2 4934.5 4976.1 3701.2 4013.2 4034.6 4063.0 4173.9 1288.9 1293.5 1296.0 1309.5 1311.6 905.6 926.8 937.9 944.0 964.8 5861.0 5871.0 6046.9 6108.9 6305.1 376.2 426.9 427.5 431.0 441.0 4041.3 4047.6 4055.3 4101.0 4144.2 10631.9 10900.8 11028.3 11055.7 11093.7 10982.9 11013.6 11014.6 11033.2 11074.0 8213.8 8282.3 8293.6 8296.4 8302.8 5333.8 5494.1 5614.7 5762.1 5770.6 9995.4 10217.9 10269.3 10270.6 10367.0 10048.8 10302.5 10476.9 10564.6 10592.7 7044.1 7241.1 7244.3 7819.7 7911.9 8018.5 8093.4 8199.8 8366.2 8504.6 6503.5 7678.6 7709.3 7719.3 7856.6 7569.5 7583.9 7642.3 7652.0 7738.7 7148.3 7263.9 7266.5 7278.3 7287.6 4982.0 5026.5 5155.0 5166.2 5203.8 5215.6 5222.8 5226.3 5233.7 5278.3 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4477.44 Median:4913.16 stddev:1417.90 (28.9%) stddev-sans-first:1386.88 11:40:32 INFO - PROCESS | 1639 | Values: 306.4 309.1 314.8 320.4 322.4 5354.4 5371.8 5403.5 5410.8 5443.8 4274.6 5077.0 5183.5 5214.4 5290.8 3465.0 3553.5 3777.9 4113.9 4205.0 3548.6 4048.5 4065.8 4082.0 4127.8 3861.9 4012.4 4085.7 4098.4 4132.5 3473.9 3916.6 4076.3 4089.9 4100.9 3530.5 3547.4 3559.1 3576.8 3590.3 4476.9 5066.6 5249.6 5263.1 5284.5 3905.5 4093.6 4640.0 4648.2 4657.4 5120.7 5308.4 5610.9 5612.7 5673.3 3900.6 3909.5 3939.7 3946.4 3955.8 5486.3 5870.7 5874.8 5897.5 5901.7 3333.0 3341.3 3516.8 3890.2 3943.5 3499.5 4030.6 4030.7 4053.1 4060.8 4258.3 4259.5 4300.7 4559.4 4599.7 4228.7 4629.3 5466.8 5609.6 5645.7 1038.9 1129.4 1234.8 1309.5 1364.9 824.2 843.2 869.5 894.9 895.9 4443.6 5024.7 5394.8 5405.9 5484.0 4661.9 4879.8 5162.7 5656.7 5813.0 4889.7 5273.4 5294.9 5440.0 5460.7 2327.9 2827.6 3025.8 3101.2 3110.5 5093.5 5532.6 5752.1 6038.2 6069.0 5313.0 5939.0 6011.6 6015.3 6043.5 5635.6 6107.4 6113.2 6148.8 6168.5 4778.9 5511.7 5830.4 5849.4 5858.7 5076.4 5771.6 5802.7 5812.3 5851.9 4539.8 5865.3 6075.0 6085.0 6094.7 2917.4 3226.8 3333.2 3350.4 3358.6 4140.7 4759.0 4883.8 4884.7 4936.6 4025.1 4157.7 4427.5 4714.0 4750.4 4851.6 5054.7 5672.9 5712.1 5719.1 4246.7 5250.7 5379.9 5578.4 5588.8 5250.6 5603.7 5643.5 5698.6 5713.8 5647.7 5648.7 5677.2 5732.0 5743.7 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:25342.48 Median:23470.85 stddev:40169.70 (171.1%) stddev-sans-first:40239.80 11:40:32 INFO - PROCESS | 1639 | Values: 706.9 732.3 736.9 797.8 839.4 16387.9 17093.7 17120.0 17130.4 17149.3 15320.4 15389.9 15411.5 15429.1 15430.3 697.8 720.6 722.1 870.6 873.8 881.5 888.4 900.8 903.4 905.0 955.4 957.4 957.6 958.4 963.4 949.5 952.4 952.7 953.6 954.1 703.8 704.2 704.4 705.2 706.1 16033.4 16343.9 16515.7 16518.9 16599.4 13743.9 14148.9 14385.8 14388.3 15154.1 11813.9 12106.9 12326.9 12400.8 12512.3 3778.9 3857.8 3900.1 3914.5 3930.8 131107.0 131386.0 131776.3 132714.0 132740.0 10831.1 11023.2 11431.7 11629.5 11721.0 23435.3 23446.0 23458.0 23463.8 23477.9 8059.3 8237.6 8306.3 8450.8 8670.0 4589.9 4594.2 4655.0 4713.6 4867.9 3270.5 3693.9 3775.0 3821.1 3832.4 669.4 678.3 679.4 689.3 691.4 666.6 679.4 686.9 690.1 726.8 8525.4 9242.4 9751.6 9883.7 9904.3 684.8 689.8 708.1 708.2 714.2 4593.4 4806.2 4837.7 4854.3 4863.9 102967.5 137559.0 141186.0 168633.2 174098.1 78515.6 93515.5 104560.0 148051.3 154930.2 99561.0 100722.5 100801.0 102294.0 109997.0 9643.7 10396.3 10419.5 10453.5 10580.1 58713.0 62414.7 64513.7 65135.0 66058.0 85053.6 99350.0 99500.5 99523.5 101740.0 12499.6 12905.0 13302.9 13399.5 13877.9 12866.5 15404.2 15444.7 15619.7 16372.3 12062.5 14015.3 14587.9 14675.7 14708.2 13937.4 14166.1 14330.6 14348.2 14371.1 13440.9 14093.5 14173.8 14424.4 14622.5 11620.8 11643.5 11823.6 11970.3 12380.8 10079.9 11653.2 11724.2 11940.9 11974.2 11:40:32 INFO - PROCESS | 1639 | -------- Summary: end -------- 11:40:32 INFO - PROCESS | 1639 | 11:40:32 INFO - TEST-INFO | 1639: exit 0 11:40:32 INFO - TEST-OK | dromaeo_css | took 1115668ms 11:40:32 INFO - TEST-START | kraken 11:40:32 INFO - operating with platform_type : mac_ 11:40:32 INFO - Initialising browser for kraken test... 11:40:32 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpY_JUGm/profile http://localhost:49249/getInfo.html) 11:40:34 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 11:40:34 INFO - PROCESS | 1649 | colorDepth:24 11:40:34 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 11:40:34 INFO - PROCESS | 1649 | __metrics 11:40:35 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:40:35 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:35 INFO - TEST-INFO | 1649: exit 0 11:40:35 INFO - Browser initialized. 11:40:35 INFO - Running cycle 1/1 for kraken test... 11:40:35 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpY_JUGm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:47 INFO - PROCESS | 1651 | RSS: Main: 168861696 11:40:47 INFO - PROCESS | 1651 | 11:40:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:51 INFO - PROCESS | 1651 | RSS: Main: 218959872 11:40:51 INFO - PROCESS | 1651 | 11:40:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 11:40:54 INFO - PROCESS | 1651 | RSS: Main: 232583168 11:40:54 INFO - PROCESS | 1651 | 11:40:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 11:40:58 INFO - PROCESS | 1651 | RSS: Main: 331046912 11:40:58 INFO - PROCESS | 1651 | 11:41:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 11:41:00 INFO - PROCESS | 1651 | RSS: Main: 228548608 11:41:00 INFO - PROCESS | 1651 | 11:41:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:03 INFO - PROCESS | 1651 | RSS: Main: 228884480 11:41:03 INFO - PROCESS | 1651 | 11:41:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:06 INFO - PROCESS | 1651 | RSS: Main: 269692928 11:41:06 INFO - PROCESS | 1651 | 11:41:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 11:41:10 INFO - PROCESS | 1651 | RSS: Main: 269287424 11:41:10 INFO - PROCESS | 1651 | 11:41:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 11:41:13 INFO - PROCESS | 1651 | RSS: Main: 267919360 11:41:13 INFO - PROCESS | 1651 | 11:41:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:41:15 INFO - PROCESS | 1651 | RSS: Main: 241455104 11:41:15 INFO - PROCESS | 1651 | 11:41:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:18 INFO - PROCESS | 1651 | RSS: Main: 245592064 11:41:18 INFO - PROCESS | 1651 | 11:41:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:21 INFO - PROCESS | 1651 | RSS: Main: 253558784 11:41:21 INFO - PROCESS | 1651 | 11:41:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:24 INFO - PROCESS | 1651 | RSS: Main: 260571136 11:41:24 INFO - PROCESS | 1651 | 11:41:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:27 INFO - PROCESS | 1651 | RSS: Main: 260968448 11:41:27 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 11:41:29 INFO - PROCESS | 1651 | RSS: Main: 304652288 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | __start_tp_report 11:41:29 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 11:41:29 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 11:41:29 INFO - PROCESS | 1651 | |i|pagename|runs| 11:41:29 INFO - PROCESS | 1651 | |0;ai-astar;116;113;113;112;114;112;114;114;112;112 11:41:29 INFO - PROCESS | 1651 | |1;audio-beat-detection;142;108;108;144;114;94;124;94;129;115 11:41:29 INFO - PROCESS | 1651 | |2;audio-dft;182;187;184;184;183;182;185;185;181;184 11:41:29 INFO - PROCESS | 1651 | |3;audio-fft;80;59;59;89;76;82;58;58;82;57 11:41:29 INFO - PROCESS | 1651 | |4;audio-oscillator;83;68;93;68;68;69;90;64;64;88 11:41:29 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;90;74;112;91;88;91;88;92;88 11:41:29 INFO - PROCESS | 1651 | |6;imaging-darkroom;143;138;99;113;159;160;99;99;100;105 11:41:29 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;83;85;85;85;83;83;86;84;85 11:41:29 INFO - PROCESS | 1651 | |8;json-parse-financial;53;54;52;52;54;55;56;56;55;56 11:41:29 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;62;73;79;71;67;68;67;68;69;68 11:41:29 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;83;82;82;85;84;80;97;102;82;83 11:41:29 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;137;136;136;135;141;145;151;137;165;145 11:41:29 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;161;162;162;155;161;165;163;162;163;162 11:41:29 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;69;66;64;67;66;67;66;65;66;66 11:41:29 INFO - PROCESS | 1651 | __end_tp_report 11:41:29 INFO - PROCESS | 1651 | __start_cc_report 11:41:29 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2026 11:41:29 INFO - PROCESS | 1651 | __end_cc_report 11:41:29 INFO - PROCESS | 1651 | __startTimestamp1481830889924__endTimestamp 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | ------- Summary: start ------- 11:41:29 INFO - PROCESS | 1651 | Number of tests: 14 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.32 (1.2%) stddev-sans-first:0.93 11:41:29 INFO - PROCESS | 1651 | Values: 116.0 113.0 113.0 112.0 114.0 112.0 114.0 114.0 112.0 112.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:135.50 stddev:17.57 (13.0%) stddev-sans-first:16.19 11:41:29 INFO - PROCESS | 1651 | Values: 142.0 108.0 108.0 144.0 114.0 94.0 124.0 94.0 129.0 115.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.77 (1.0%) stddev-sans-first:1.76 11:41:29 INFO - PROCESS | 1651 | Values: 182.0 187.0 184.0 184.0 183.0 182.0 185.0 185.0 181.0 184.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:70.00 Median:78.00 stddev:12.84 (16.5%) stddev-sans-first:13.10 11:41:29 INFO - PROCESS | 1651 | Values: 80.0 59.0 59.0 89.0 76.0 82.0 58.0 58.0 82.0 57.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:11.57 (15.2%) stddev-sans-first:11.95 11:41:29 INFO - PROCESS | 1651 | Values: 83.0 68.0 93.0 68.0 68.0 69.0 90.0 64.0 64.0 88.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:90.00 stddev:9.17 (10.2%) stddev-sans-first:9.72 11:41:29 INFO - PROCESS | 1651 | Values: 90.0 90.0 74.0 112.0 91.0 88.0 91.0 88.0 92.0 88.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:121.50 Median:159.50 stddev:25.71 (16.1%) stddev-sans-first:26.06 11:41:29 INFO - PROCESS | 1651 | Values: 143.0 138.0 99.0 113.0 159.0 160.0 99.0 99.0 100.0 105.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:1.18 (1.4%) stddev-sans-first:1.12 11:41:29 INFO - PROCESS | 1651 | Values: 86.0 83.0 85.0 85.0 85.0 83.0 83.0 86.0 84.0 85.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.57 (2.8%) stddev-sans-first:1.59 11:41:29 INFO - PROCESS | 1651 | Values: 53.0 54.0 52.0 52.0 54.0 55.0 56.0 56.0 55.0 56.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:68.50 stddev:4.47 (6.5%) stddev-sans-first:3.91 11:41:29 INFO - PROCESS | 1651 | Values: 62.0 73.0 79.0 71.0 67.0 68.0 67.0 68.0 69.0 68.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.00 stddev:7.33 (8.8%) stddev-sans-first:7.70 11:41:29 INFO - PROCESS | 1651 | Values: 83.0 82.0 82.0 85.0 84.0 80.0 97.0 102.0 82.0 83.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:143.00 stddev:9.39 (6.6%) stddev-sans-first:9.72 11:41:29 INFO - PROCESS | 1651 | Values: 137.0 136.0 136.0 135.0 141.0 145.0 151.0 137.0 165.0 145.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:2.59 (1.6%) stddev-sans-first:2.74 11:41:29 INFO - PROCESS | 1651 | Values: 161.0 162.0 162.0 155.0 161.0 165.0 163.0 162.0 163.0 162.0 11:41:29 INFO - PROCESS | 1651 | 11:41:29 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:0.93 11:41:29 INFO - PROCESS | 1651 | Values: 69.0 66.0 64.0 67.0 66.0 67.0 66.0 65.0 66.0 66.0 11:41:29 INFO - PROCESS | 1651 | -------- Summary: end -------- 11:41:29 INFO - PROCESS | 1651 | 11:41:30 INFO - TEST-INFO | 1651: exit 0 11:41:30 INFO - TEST-OK | kraken | took 57939ms 11:41:30 INFO - SUITE-END | took 1173s 11:41:31 INFO - Completed test suite (00:19:33) 11:41:31 INFO - javascript benchmark 11:41:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2928.282570770161, 3439.0886415099985, 3476.1657202271444, 3493.3362661094375, 3504.491848681941, 5631.267935168427, 5703.515201207892, 5730.7707691692385, 5742.799002034924, 5746.770129194832, 5699.487046165844, 5792.739326730297, 5795.0, 5798.246227990366, 5800.216970708953, 5251.501107394792, 5267.789288428458, 5275.630705850592, 5318.095923692962, 5325.094733895227, 5209.348831396075, 5215.1655735082395, 5225.947740522584, 5297.5232229099565, 5379.704116273603, 5322.787088516455, 5327.866803329909, 5332.33345831771, 5337.946620533784, 5338.06583847827, 5245.554127899133, 5262.60530460217, 5304.549113325372, 5331.600129990266, 5351.170568561879, 5211.166213405837, 5215.0, 5222.73886305687, 5245.659032162897, 5319.361676598833, 5140.897182056376, 5834.124881267801, 5852.824415267549, 5914.172015917775, 5988.670623115727, 5234.555062819665, 6137.070562331796, 6196.473299769525, 6275.246970363585, 6298.338674439164, 6197.16338294329, 6217.751289948396, 6263.4989200864275, 6263.937360626381, 6269.435750782406, 5901.704914754245, 5913.733881975321, 5930.7924222652, 5940.910886336708, 5951.642901425928, 5384.703841288689, 6200.689965501707, 6274.152989346471, 6299.905501417483, 6332.95506241465, 6236.532260080512, 6246.781362652377, 6247.812565623039, 6248.937510624926, 6259.217597800275, 6297.307296197415, 6301.52738544611, 6324.588901721373, 6326.6520341381665, 6328.905066424008, 6135.385782596134, 6143.477804386677, 6174.660393678301, 6302.716377763011, 6309.873802523924, 5446.645968012067, 6044.909326360108, 6267.2479302484, 6311.431971122621, 6318.526110541728, 4043.7169398141846, 5048.570871475892, 5056.342675452168, 5060.620453465931, 5093.032323858455, 4470.798814053375, 4483.3723278741, 4505.842295519641, 4531.68278220528, 4549.0, 5799.623024503394, 5844.620099693507, 5926.703664816742, 5954.583179177416, 6028.758849645965, 6268.592541484789, 6306.0, 6328.0, 6340.873182536416, 6343.682815859189, 5974.880502390015, 5992.161097446361, 5996.2504686914135, 6014.308354539284, 6030.668313242726, 5411.918821217685, 5426.213199086111, 5461.2354270402175, 5488.368837583649, 5507.531859791962, 6393.904091438632, 6396.872062558723, 6416.550841441054, 6421.5504914657395, 6446.80659580204, 6300.7479700811455, 6313.368663133833, 6324.557280990287, 6335.841603959938, 6351.237851457855, 6207.534434917309, 6249.843753906189, 6276.215473065867, 6357.777477788255, 6414.390632889868, 6256.655883926428, 6307.495400368051, 6325.082862984749, 6328.050792381179, 6328.557001009885, 6189.473894718999, 6318.368163183645, 6331.715072821827, 6337.8732425352155, 6349.206349206349, 6107.480864126599, 6137.693115344304, 6194.504439644727, 6205.348438414082, 6266.592671476339, 6135.998322734094, 6144.634315788364, 6190.7523699051535, 6262.0, 6275.278342990615, 6086.72609732572, 6088.695565221809, 6113.755449781959, 6121.663308517896, 6136.846578835565, 5840.415958404125, 6126.877462450815, 6246.281677607133, 6256.280527739368, 6263.3736626337, 6000.609960352563, 6037.275526936795, 6073.180120683828, 6092.086187071975, 6155.446009858955], "value": 5764.326879493196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.5439581574491, 524.6353784120038, 532.4568939681525, 535.7321339330335, 549.3682265394793, 32084.0, 34359.0, 42699.57300426995, 42752.78623606878, 45273.54726452735, 44702.55297447024, 44932.775336123275, 44943.101137977304, 45121.774391128, 45205.54794452054, 10038.799224015496, 10227.642032528864, 10229.590816367336, 10235.692929212099, 10235.846462303072, 9386.953065234664, 9589.04109589039, 12304.200226985262, 12571.874281257207, 12589.992800575932, 12545.937270313636, 12629.747405051894, 12635.368231588383, 12642.747145057094, 12652.17760845542, 12570.937145314261, 12635.0, 12636.557720479832, 12642.55751048718, 12685.492580296777, 12405.875941240562, 12478.625641230778, 12494.562690305796, 12503.0, 12506.437210325557, 41318.1736365271, 41510.37734433986, 41578.0, 41588.37617435741, 41625.791871040754, 3636.8727094551828, 3658.268346330718, 3704.6110158433517, 4020.4170395292813, 4021.070328937871, 31729.524057139162, 31782.682173178204, 31903.840480797448, 32175.19562010945, 32303.030909072764, 3356.9160770980675, 3366.309906469168, 3437.9656203437894, 3446.7070299024613, 3531.770434921722, 394903.0, 395117.024414879, 396576.0, 396599.0, 396736.0163199165, 33869.0, 34231.0, 34443.4833477493, 58527.70736146377, 58661.0, 36463.63536364656, 36529.0, 36554.451683224775, 36600.45099323512, 36651.4502282466, 15667.373305067898, 15850.60373490672, 15862.52412427629, 15871.20643967797, 15897.046177229404, 12073.87926120745, 12304.323262220485, 13206.933965330112, 13335.0, 13352.46590136403, 7999.640016199285, 8120.75637730869, 8152.184781521801, 8180.672773089129, 8224.136465671138, 3357.9758173757236, 3401.5407919930985, 3403.149212696826, 3417.726581873444, 3432.090496018557, 885.6590212768131, 989.3865803201917, 1000.4597517340554, 1006.9395836249848, 1018.8777346718441, 30396.392072158433, 30996.845015775227, 31000.22499437532, 31327.686723132476, 31928.68071319257, 1045.5869931377063, 1054.8997845204694, 1060.2737125069352, 1107.9279846809932, 1163.3601519164426, 16296.777741669423, 16988.49034528966, 17010.659786804194, 17023.06373149464, 17430.564235894206, 643975.0, 647906.0, 650772.0, 652596.0, 653325.0, 59843.700781496686, 60398.0, 60462.0, 60613.393866061655, 60892.086618700756, 1299.6555912683148, 1327.3495986966318, 1419.2761691537185, 1429.9142051476945, 1461.1817382265965, 29520.96676616308, 30982.22544436407, 31581.0, 31847.885324013547, 32166.035018949467, 48211.0, 57274.14088788588, 58433.70783146057, 58477.415225847195, 62315.0, 628904.0, 634644.0, 635887.0, 636115.0, 638549.0, 37206.25587488289, 37843.62156378401, 41857.372139417326, 44197.779011104736, 44255.0, 48330.758346208044, 49042.509574903794, 49073.5092649069, 49404.258936116705, 49628.0, 39343.0, 40377.0, 41579.89334680105, 41755.7912210437, 42051.0, 38960.610393895695, 40876.59123408728, 41078.38382424326, 42063.0, 42535.361969569865, 39642.207155856144, 40043.0, 40466.1906761869, 40600.0, 40766.38850417187, 29825.70174298316, 33070.00789976305, 35408.58365665344, 35992.820035899655, 36388.27223455463, 22685.319440416813, 25860.482790344464, 26073.869630651727, 26301.0, 26334.0], "value": 19879.67557766447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.21851925763326, 386.68098818474755, 386.87039841653046, 396.26888390918754, 407.9204555111754, 20497.795022049773, 21168.25911093112, 21990.450238744, 22110.0, 22433.0, 21177.258795942143, 21264.681029784566, 21530.784692153073, 22051.779482205173, 22273.331800046024, 5649.096144616852, 6093.207882975207, 6161.845953851167, 6163.322034576193, 6183.1961844960315, 4362.672799540047, 4437.6671749618745, 4453.955460445402, 6026.0960855871535, 6169.352218017111, 4414.911701765963, 6747.0216818561275, 6832.2826103259185, 6833.863322733542, 6835.350641689057, 6538.346165383447, 6753.966230168867, 6811.386975172259, 6814.420774234196, 6822.215445223813, 5936.436038576328, 5977.820665380045, 5988.461038506555, 5989.700514974277, 5999.490043346321, 26465.338366540796, 26806.731932680617, 26820.59769103465, 26978.325541861414, 27162.456750864872, 2330.603797354454, 2419.5765740995257, 2515.4717509323063, 2644.9603255951174, 2973.509370953812, 15973.92013039939, 16161.9494732842, 16368.299230626932, 16539.586510337216, 17079.829201707948, 1818.9636207275912, 1910.149983257451, 1926.7109933509946, 1944.9708254376196, 1979.960400791976, 97151.51424242904, 104657.47671261671, 111223.0, 111555.44222278918, 112539.0, 10765.01694373087, 11096.00135987765, 11119.55521779136, 11361.829572556418, 11405.201635885574, 14481.348339324755, 14501.854981450051, 14530.346134423977, 14533.0, 14551.0, 8967.0, 9090.818183636422, 9094.499802510925, 9102.908970910206, 9216.308776841764, 9140.497272649935, 9146.496942668084, 9165.762622045939, 9322.114399132071, 9322.114399132071, 5879.676617786063, 6801.251862295144, 6921.781371662201, 6930.688119034656, 6931.480138989495, 1728.809830918623, 1849.7687789026372, 1885.9905700471684, 1924.874883132592, 1926.5954149628456, 748.4648476339444, 850.5237067242364, 952.6094301336419, 968.2979839616363, 986.2504496582505, 18998.0, 22462.550748985257, 23311.417214569432, 23504.0, 23524.529509409716, 977.6822532676908, 1012.3419777144768, 1030.407515678473, 1047.2669131607904, 1082.0729925551366, 11638.0, 12141.878581214252, 12336.259824410565, 12345.135840491079, 12430.254184748945, 556721.0, 562619.1869040629, 564144.0, 564881.0, 568519.0, 115070.0, 115813.42093289479, 119871.2019319711, 120119.0, 123811.0, 1044.2637940252105, 1050.175612144463, 1051.295631926611, 1053.562771449855, 1081.6971248050559, 19646.91941943207, 19885.502862428555, 20244.0, 20255.696164557838, 20302.289419870234, 36850.0, 49074.773130672016, 49368.50631493639, 50376.740581485756, 51395.0, 70645.0, 73123.63438182775, 73239.1690207749, 74856.0, 75482.24517754752, 7347.66935487915, 7675.501092429197, 7831.2560306770765, 8324.958375208085, 8414.579271036302, 12973.935130324287, 13413.396397162347, 13484.460621575026, 13654.453821847015, 13979.301034948416, 10847.837282440612, 11210.607628732956, 11578.131640127192, 11907.583234587095, 12084.637460876187, 11433.371164585695, 11458.369789661649, 11620.709482263012, 11774.3524106175, 11929.940350298193, 10843.295185812896, 11181.273217240854, 11669.88330116688, 11999.82000270014, 12105.0, 6397.904031439439, 7539.736109236151, 7601.6579253934815, 7727.188645192174, 7728.845423091394, 10262.230332725225, 11742.58900938463, 11794.882051179378, 12108.273503589813, 12166.026717862727], "value": 10003.2649732233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.4541592318803, 1561.039960424339, 1709.1112621436853, 1808.2043900683707, 1855.4619160443472, 8627.482351058932, 9197.540122993849, 9200.309976751745, 9209.861852072225, 9213.861792073125, 8102.351811855052, 8320.251177394033, 8334.0, 8750.08124146965, 8942.061083586212, 2383.0467812874904, 2424.9272521824287, 2429.2226487524, 2433.4889673168655, 2433.9513209735796, 2413.81896357773, 2430.3924018995253, 2452.3010941881566, 2454.6563481112657, 2457.213691618683, 2421.6004359280787, 2443.5601591713485, 2449.363165576954, 2455.4966231922413, 2462.6182941644074, 2410.3853517352964, 2411.807055435561, 2424.103081859714, 2427.7329493755674, 2434.9878250608813, 2399.2082612737754, 2411.2163546847346, 2416.6012607919674, 2418.093215044358, 2421.539907417585, 9011.188992990663, 9022.052684468168, 9140.90859091414, 9152.31357648179, 9156.954215228949, 5341.1187154119525, 5498.422665620133, 5501.14732216507, 5512.834614961557, 5516.475934786189, 3425.5889293284717, 3554.0937061049267, 3596.5504311961004, 3607.603163651996, 3613.4218525035867, 993.3493561717087, 1120.523777394604, 1126.0709914320719, 1142.582957220617, 1142.8228624563205, 11947.462364193632, 11975.161738678296, 11979.28124312544, 12008.519659213622, 12020.939895300555, 4383.890402739957, 4606.493285738566, 4746.525347465225, 4913.803447862117, 4929.408470983505, 10250.179985601135, 10254.794904101876, 10267.794644107225, 10273.02406271403, 10282.640107596199, 5441.455854414606, 5441.59188060897, 5449.0, 5460.0, 5466.890662186734, 4524.04994951064, 4652.976735116303, 4660.231061874821, 4934.481879402683, 4976.104301225741, 3701.222743223899, 4013.2141197167566, 4034.636882680573, 4063.045184381668, 4173.871325623953, 1288.9291088990196, 1293.5084667826354, 1295.9546415875589, 1309.4958441000092, 1311.5868501422021, 905.6050412674471, 926.754410081329, 937.9108984646448, 943.9716808495756, 964.81668482988, 5860.970695146582, 5870.970645146833, 6046.879062418727, 6108.900397928415, 6305.14880491137, 376.20808198741804, 426.94876614806424, 427.542529493439, 430.9979298131856, 440.96251818595135, 4041.333180025263, 4047.575004624472, 4055.3105971984833, 4100.976209558971, 4144.150449157915, 10631.893681063091, 10900.781984360268, 11028.338299702044, 11055.72360690989, 11093.667189984313, 10982.945085274683, 11013.614523491638, 11014.559417623366, 11033.227674062899, 11074.0, 8213.753587392388, 8282.302128063733, 8293.585320733939, 8296.377771667148, 8302.83394332122, 5333.7866485340155, 5494.120940649477, 5614.747336369792, 5762.078067509178, 5770.596058275881, 9995.350302230332, 10217.948910255402, 10269.281150319406, 10270.640527581798, 10367.0, 10048.799024019332, 10302.536385862804, 10476.895231047592, 10564.630237941636, 10592.682219533426, 7044.119485064367, 7241.131064272321, 7244.275572442713, 7819.726309579138, 7911.8813217800625, 8018.4787988780545, 8093.35253179756, 8199.795005124919, 8366.205210504992, 8504.617292221988, 6503.51223658237, 7678.61606919663, 7709.344705699854, 7719.266669666373, 7856.607169641609, 7569.507981981374, 7583.886241706489, 7642.312191902755, 7652.0, 7738.690452381842, 7148.320909513588, 7263.854722905407, 7266.527675701062, 7278.272172782679, 7287.562746235243, 4981.950180498148, 5026.52248036436, 5155.0, 5166.173412254021, 5203.814397952945, 5215.5827533797965, 5222.764975576184, 5226.346706661668, 5233.7383130842545, 5278.261043453843], "value": 4588.587362030552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.36429408976375, 309.1436720284811, 314.7938100544144, 320.4136430332492, 322.4373468297821, 5354.357477102753, 5371.75827087781, 5403.540699040582, 5410.756515956781, 5443.8094666686675, 4274.572542745724, 5076.974615126919, 5183.496785932085, 5214.374275086985, 5290.788368465257, 3465.0, 3553.5380400547892, 3777.9044077217573, 4113.897152571187, 4204.957950420502, 3548.6273941236186, 4048.4615845978487, 4065.796710164495, 4082.040720430696, 4127.814248358831, 3861.903452413684, 4012.358022716366, 4085.6527195188446, 4098.364753463218, 4132.5040995080635, 3473.94789078164, 3916.608339166089, 4076.266272071026, 4089.9386509202236, 4100.91798164035, 3530.505729197914, 3547.4324108142573, 3559.0568499347437, 3576.8390422431053, 3590.281943611288, 4476.895858946323, 5066.594672426197, 5249.585190812231, 5263.078991159905, 5284.5243928046275, 3905.519994803292, 4093.6111069448357, 4640.0, 4648.209804333272, 4657.417822772153, 5120.667156634807, 5308.416074231832, 5610.943890561083, 5612.747426365823, 5673.26247587815, 3900.64894159527, 3909.5113110861143, 3939.660515424741, 3946.3685810270217, 3955.802209889494, 5486.31421072366, 5870.73581688825, 5874.765009399619, 5897.528197744213, 5901.704914754245, 3332.950005749916, 3341.2649217172184, 3516.804286542537, 3890.2414029264023, 3943.507061617298, 3499.4575840744724, 4030.6372426481757, 4030.6775457963295, 4053.1285773558825, 4060.817263223162, 4258.254115812502, 4259.531451540328, 4300.720453170597, 4559.361689363492, 4599.724016559017, 4228.682848786353, 4629.259318509023, 5466.753996070186, 5609.607327487037, 5645.717714114277, 1038.8597539332245, 1129.390129330169, 1234.8209509621233, 1309.5351150341683, 1364.8944355072424, 824.1634740738156, 843.1989609870648, 869.452245085592, 894.8926128864448, 895.892492900856, 4443.577860103285, 5024.748762561857, 5394.78420863169, 5405.918911216335, 5483.972580137074, 4661.930071048937, 4879.804807807648, 5162.716050617252, 5656.745446454919, 5812.953668339739, 4889.682170658896, 5273.367195936512, 5294.947050529446, 5440.047991601454, 5460.699661518575, 2327.93016209514, 2827.632407787016, 3025.759438630151, 3101.201303244113, 3110.460322140555, 5093.490650934951, 5532.585056120807, 5752.059932467699, 6038.154658347835, 6069.0, 5313.0, 5938.970305148533, 6011.639301641915, 6015.3383127855905, 6043.456088951927, 5635.6323849017335, 6107.358727333655, 6113.23584551931, 6148.78479253224, 6168.475679567287, 4778.928316075192, 5511.724413779215, 5830.416958304136, 5849.415058494116, 5858.736356863866, 5076.390833099904, 5771.5759381059215, 5802.709864506842, 5812.273465816773, 5851.853703657443, 4539.750313732644, 5865.328381411277, 6074.969625151846, 6084.969575152096, 6094.695265236632, 2917.4456853197826, 3226.822524761161, 3333.2166940769384, 3350.3969285528838, 3358.6473420291495, 4140.743294904224, 4758.952410475851, 4883.80464781419, 4884.7069175849565, 4936.630417399597, 4025.149694618037, 4157.667386609124, 4427.512973572969, 4713.952860471351, 4750.382450281441, 4851.593038018935, 5054.671446355975, 5672.914906276492, 5712.0860662293835, 5719.113537401709, 4246.681498887658, 5250.711210883285, 5379.892402152013, 5578.442155784552, 5588.764494202352, 5250.579953603627, 5603.719814009365, 5643.548516118619, 5698.572607054404, 5713.771449141987, 5647.689377084135, 5648.729035966875, 5677.154924649588, 5732.0, 5743.684097374685], "value": 4029.1421069471867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.8550947055854, 732.3152852083302, 736.9078865141857, 797.7965618767214, 839.4459656626627, 16387.918060409695, 17093.743593846088, 17119.999999999967, 17130.400435984742, 17149.31402743892, 15320.387184512607, 15389.923050384732, 15411.46059887904, 15429.074255544676, 15430.305636246369, 697.8394969157072, 720.6396801599201, 722.12622726501, 870.6256309786789, 873.7509809704204, 881.4711173296035, 888.3692578269437, 900.7748062984253, 903.3586153830788, 905.0361365146131, 955.4124213608616, 957.4398976598663, 957.5643082397527, 958.3626888119393, 963.4460185393392, 949.4967667136428, 952.4095061062186, 952.6856137474651, 953.5899563187896, 954.0554850697829, 703.8099713077492, 704.24997377793, 704.3977399323555, 705.1608585782953, 706.0750416953807, 16033.438829640907, 16343.918280408641, 16515.6696866062, 16518.917405413016, 16599.41902033423, 13743.931280343535, 14148.858511414857, 14385.78421323681, 14388.28058597066, 15154.090754554652, 11813.940930295379, 12106.878931210664, 12326.876731232662, 12400.81398779019, 12512.304495242222, 3778.9055273618105, 3857.8071096445065, 3900.0639846436934, 3914.5106861642294, 3930.78380689062, 131106.99999999904, 131386.0, 131776.34111829475, 132714.0, 132740.0, 10831.133509319236, 11023.228374013903, 11431.714207144887, 11629.47667354971, 11721.0, 23435.296941091794, 23446.0, 23458.0, 23463.7653623465, 23477.943492542876, 8059.274665280153, 8237.629306681214, 8306.335493160532, 8450.830983380298, 8669.956650216709, 4589.908201835945, 4594.1730488512385, 4655.0, 4713.552212539803, 4867.853964381075, 3270.5094235864335, 3693.926121477555, 3774.962250377516, 3821.140243445258, 3832.405977073558, 669.3808227389645, 678.2640834694313, 679.3546131175304, 689.2556039477353, 691.4364792693939, 666.5833853841349, 679.4486702432433, 686.9416099631487, 690.147667630486, 726.8001299642641, 8525.44584601999, 9242.353035287466, 9751.609935602497, 9883.654072107442, 9904.257180711475, 684.7537481783107, 689.7861662884521, 708.0901042160799, 708.2280314457163, 714.1644276196862, 4593.425821772278, 4806.182948898696, 4837.7097374157665, 4854.271859221074, 4863.927041094386, 102967.4851625752, 137559.0, 141186.0, 168633.15683421504, 174098.12950935418, 78515.60742196253, 93515.53242233745, 104560.0, 148051.2597437006, 154930.22534887254, 99561.0, 100722.49638751759, 100800.99199007916, 102294.0, 109997.0, 9643.662471813454, 10396.272260941661, 10419.531121099417, 10453.529591168568, 10580.100691441314, 58713.0, 62414.68792656008, 64513.677431612545, 65135.0, 66058.00912986213, 85053.57473212594, 99350.0, 99500.50749238912, 99523.50238248763, 101740.0, 12499.625011249676, 12905.0, 13302.93348533251, 13399.464021439033, 13877.861221387657, 12866.485340586272, 15404.15277159767, 15444.691106178037, 15619.687606248039, 16372.345106195618, 12062.51749929993, 14015.299235038412, 14587.927060365055, 14675.706485870436, 14708.191049492381, 13937.442502299795, 14166.079204851652, 14330.57008289753, 14348.210848403438, 14371.137731735711, 13440.865591344353, 14093.506727264497, 14173.787393189317, 14424.42302307896, 14622.488212912496, 11620.758602166703, 11643.53425862956, 11823.645290641294, 11970.324154618535, 12380.752384952431, 10079.899201007896, 11653.242539234923, 11724.179307448398, 11940.940295298467, 11974.221675591407], "value": 8151.192591834354, "unit": "score"}], "name": "dromaeo_css", "value": 7462.939583395448, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 113.0, 112.0, 114.0, 112.0, 114.0, 114.0, 112.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 108.0, 144.0, 114.0, 94.0, 124.0, 94.0, 129.0, 115.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 184.0, 184.0, 183.0, 182.0, 185.0, 185.0, 181.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 89.0, 76.0, 82.0, 58.0, 58.0, 82.0, 57.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 68.0, 93.0, 68.0, 68.0, 69.0, 90.0, 64.0, 64.0, 88.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 74.0, 112.0, 91.0, 88.0, 91.0, 88.0, 92.0, 88.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 99.0, 113.0, 159.0, 160.0, 99.0, 99.0, 100.0, 105.0], "value": 121.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 85.0, 85.0, 83.0, 83.0, 86.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 52.0, 54.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 73.0, 79.0, 71.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 85.0, 84.0, 80.0, 97.0, 102.0, 82.0, 83.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 136.0, 135.0, 141.0, 145.0, 151.0, 137.0, 165.0, 145.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 155.0, 161.0, 165.0, 163.0, 162.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 64.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1436.1, "alertThreshold": 2.0}]} 11:41:31 INFO - Return code: 0 11:41:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:31 INFO - # TBPL SUCCESS # 11:41:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:41:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:41:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:41:31 INFO - 2016-12-15 11:41:31.222 screenresolution[1655:10117] starting screenresolution argv=screenresolution get 11:41:31 INFO - 2016-12-15 11:41:31.224 screenresolution[1655:10117] Display 0: 1600x1200x32@60 11:41:31 INFO - 2016-12-15 11:41:31.231 screenresolution[1656:10120] starting screenresolution argv=screenresolution list 11:41:31 INFO - Available Modes on Display 0 11:41:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:41:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:41:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:41:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:41:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:41:31 INFO - Intel Iris: 11:41:31 INFO - Chipset Model: Intel Iris 11:41:31 INFO - Type: GPU 11:41:31 INFO - Bus: Built-In 11:41:31 INFO - VRAM (Dynamic, Max): 1536 MB 11:41:31 INFO - Vendor: Intel (0x8086) 11:41:31 INFO - Device ID: 0x0a2e 11:41:31 INFO - Revision ID: 0x0009 11:41:31 INFO - Displays: 11:41:31 INFO - Display: 11:41:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:41:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:41:31 INFO - Display Serial Number: 1600x1200 60 11:41:31 INFO - Main Display: Yes 11:41:31 INFO - Mirror: Off 11:41:31 INFO - Online: Yes 11:41:31 INFO - Rotation: Supported 11:41:31 INFO - Return code: 0 11:41:31 INFO - Running post-action listener: _resource_record_post_action 11:41:31 INFO - [mozharness: 2016-12-15 19:41:31.466246Z] Finished run-tests step (success) 11:41:31 INFO - Running post-run listener: _resource_record_post_run 11:41:31 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 38847488; Write bytes: 494629376; Read time: 382; Write time: 1749 11:41:31 INFO - TinderboxPrint: CPU usage
53.4% 11:41:31 INFO - TinderboxPrint: I/O read bytes / time
38,847,488 / 382 11:41:31 INFO - TinderboxPrint: I/O write bytes / time
494,629,376 / 1,749 11:41:31 INFO - TinderboxPrint: CPU idle
2,233.0 (46.6%) 11:41:31 INFO - TinderboxPrint: CPU system
961.2 (20.1%) 11:41:31 INFO - TinderboxPrint: CPU user
1,595.5 (33.3%) 11:41:31 INFO - TinderboxPrint: Swap in / out
233,926,656 / 0 11:41:31 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 187214336; Write bytes: 187475968; Read time: 17629; Write time: 391 11:41:31 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 37884928; Write bytes: 296991232; Read time: 367; Write time: 1323 11:41:31 INFO - Running post-run listener: _upload_blobber_files 11:41:31 INFO - Blob upload gear active. 11:41:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:31 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:41:31 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:41:31 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:41:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:41:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:33 INFO - (blobuploader) - INFO - Done attempting. 11:41:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:41:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:41:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:34 INFO - (blobuploader) - INFO - Done attempting. 11:41:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:36 INFO - (blobuploader) - INFO - Done attempting. 11:41:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:36 INFO - Return code: 0 11:41:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0328bd5378e7135af6f289f1aaf97d4c29fd053d29982f98c2b28c4001e7016a0540603b70127382133b582862db85473815c41a5a5e3fcfcc95633ab5251908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db0779f00542ce1ae842ff3762d3585a58aef8a627a69a64d944ad019ad64b2d4d234e96cf92e2ab9d78e851f1c20ec39a2e16ce5a847d4e3ef07b34c7a11d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca4db99f1bf74583d486ae7244023aea8673a523e24247e8f401926ed588d81680b737d9ad8f66a576e13701cefeacb31f2f0e9be3cccc17170fc0cab4988131"} 11:41:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:36 INFO - Contents: 11:41:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0328bd5378e7135af6f289f1aaf97d4c29fd053d29982f98c2b28c4001e7016a0540603b70127382133b582862db85473815c41a5a5e3fcfcc95633ab5251908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db0779f00542ce1ae842ff3762d3585a58aef8a627a69a64d944ad019ad64b2d4d234e96cf92e2ab9d78e851f1c20ec39a2e16ce5a847d4e3ef07b34c7a11d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca4db99f1bf74583d486ae7244023aea8673a523e24247e8f401926ed588d81680b737d9ad8f66a576e13701cefeacb31f2f0e9be3cccc17170fc0cab4988131"} 11:41:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:36 INFO - Copying logs to upload dir... 11:41:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.582253 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-15 11:41:36.915026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 11:41:36.919248) ========= 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.KOLyllnX3i/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.1EMdh6vf6j/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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/0328bd5378e7135af6f289f1aaf97d4c29fd053d29982f98c2b28c4001e7016a0540603b70127382133b582862db85473815c41a5a5e3fcfcc95633ab5251908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db0779f00542ce1ae842ff3762d3585a58aef8a627a69a64d944ad019ad64b2d4d234e96cf92e2ab9d78e851f1c20ec39a2e16ce5a847d4e3ef07b34c7a11d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca4db99f1bf74583d486ae7244023aea8673a523e24247e8f401926ed588d81680b737d9ad8f66a576e13701cefeacb31f2f0e9be3cccc17170fc0cab4988131"} build_url:https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/dq_AfhWZRFS0FhJDkJZ-Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0328bd5378e7135af6f289f1aaf97d4c29fd053d29982f98c2b28c4001e7016a0540603b70127382133b582862db85473815c41a5a5e3fcfcc95633ab5251908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db0779f00542ce1ae842ff3762d3585a58aef8a627a69a64d944ad019ad64b2d4d234e96cf92e2ab9d78e851f1c20ec39a2e16ce5a847d4e3ef07b34c7a11d3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca4db99f1bf74583d486ae7244023aea8673a523e24247e8f401926ed588d81680b737d9ad8f66a576e13701cefeacb31f2f0e9be3cccc17170fc0cab4988131"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 11:41:36.952815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:41:36.956142) ========= 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.KOLyllnX3i/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.1EMdh6vf6j/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005299 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 11:41:37.004490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 11:41:37.004785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 11:41:37.008110) ========= ========= Total master_lag: 0.20 =========