builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0011 starttime: 1483664797.16 results: success (0) buildid: 20170105155013 builduid: 1e491eec93884624aaf2d154000ebd94 revision: 9ddd4fee07842e72ba49f1583ec5f596f6e60e72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.163785) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.164687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.164997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.233623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.234039) ========= 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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-05 17:06:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-01-05 17:06:37 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.622805 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.883266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.883617) ========= 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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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.021166 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:37.941738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-05 17:06:37.942136) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9ddd4fee07842e72ba49f1583ec5f596f6e60e72 --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 9ddd4fee07842e72ba49f1583ec5f596f6e60e72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d86sucNZGZ/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.QbEsgK2YCZ/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-05 17:06:38,017 truncating revision to first 12 chars 2017-01-05 17:06:38,017 Setting DEBUG logging. 2017-01-05 17:06:38,017 attempt 1/10 2017-01-05 17:06:38,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9ddd4fee0784?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 17:06:38,797 unpacking tar archive at: mozilla-beta-9ddd4fee0784/testing/mozharness/ program finished with exit code 0 elapsedTime=1.063794 ========= master_lag: 3.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-05 17:06:42.847149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:42.847527) ========= script_repo_revision: 9ddd4fee07842e72ba49f1583ec5f596f6e60e72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:42.847995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:42.848299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:06:42.931924) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-05 17:06:42.932367) ========= /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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:06:43 INFO - MultiFileLogger online at 20170105 17:06:43 in /builds/slave/test 17:06:43 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 17:06:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:43 INFO - {'append_to_log': False, 17:06:43 INFO - 'base_work_dir': '/builds/slave/test', 17:06:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:06:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:43 INFO - 'branch': 'Mozilla-Beta', 17:06:43 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:43 INFO - 'config_files': ('talos/mac_config.py',), 17:06:43 INFO - 'default_actions': ('clobber', 17:06:43 INFO - 'read-buildbot-config', 17:06:43 INFO - 'download-and-extract', 17:06:43 INFO - 'populate-webroot', 17:06:43 INFO - 'create-virtualenv', 17:06:43 INFO - 'install', 17:06:43 INFO - 'run-tests'), 17:06:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:43 INFO - 'download_minidump_stackwalk': True, 17:06:43 INFO - 'download_symbols': 'ondemand', 17:06:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:43 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:43 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:43 INFO - 'installer_path': 'installer.exe', 17:06:43 INFO - 'log_level': 'info', 17:06:43 INFO - 'log_name': 'talos', 17:06:43 INFO - 'log_to_console': True, 17:06:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:06:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:06:43 INFO - 'opt_config_files': (), 17:06:43 INFO - 'pip_index': False, 17:06:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:06:43 INFO - 'cmd': ('bash', 17:06:43 INFO - '-c', 17:06:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:06:43 INFO - 'enabled': True, 17:06:43 INFO - 'halt_on_failure': False, 17:06:43 INFO - 'name': 'check_screen_resolution'},), 17:06:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:06:43 INFO - 'cmd': ('bash', 17:06:43 INFO - '-c', 17:06:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:06:43 INFO - 'enabled': True, 17:06:43 INFO - 'halt_on_failure': False, 17:06:43 INFO - 'name': 'check_screen_resolution'},), 17:06:43 INFO - 'run_cmd_checks_enabled': True, 17:06:43 INFO - 'sps_profile': False, 17:06:43 INFO - 'sps_profile_interval': 0, 17:06:43 INFO - 'suite': 'dromaeojs', 17:06:43 INFO - 'system_bits': '32', 17:06:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:43 INFO - 'title': 't-yosemite-r7-0011', 17:06:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:43 INFO - 'use_talos_json': True, 17:06:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:43 INFO - 'work_dir': 'build'} 17:06:43 INFO - [mozharness: 2017-01-06 01:06:43.134839Z] Running clobber step. 17:06:43 INFO - Running pre-action listener: _resource_record_pre_action 17:06:43 INFO - Running main action method: clobber 17:06:43 INFO - rmtree: /builds/slave/test/build 17:06:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:44 INFO - Running post-action listener: _resource_record_post_action 17:06:44 INFO - [mozharness: 2017-01-06 01:06:44.026752Z] Finished clobber step (success) 17:06:44 INFO - [mozharness: 2017-01-06 01:06:44.026867Z] Running read-buildbot-config step. 17:06:44 INFO - Running pre-action listener: _resource_record_pre_action 17:06:44 INFO - Running main action method: read_buildbot_config 17:06:44 INFO - Using buildbot properties: 17:06:44 INFO - { 17:06:44 INFO - "project": "", 17:06:44 INFO - "product": "firefox", 17:06:44 INFO - "script_repo_revision": "production", 17:06:44 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:06:44 INFO - "repository": "", 17:06:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:06:44 INFO - "buildid": "20170105155013", 17:06:44 INFO - "pgo_build": "False", 17:06:44 INFO - "basedir": "/builds/slave/test", 17:06:44 INFO - "buildnumber": 6, 17:06:44 INFO - "slavename": "t-yosemite-r7-0011", 17:06:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:06:44 INFO - "platform": "yosemite_r7", 17:06:44 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:06:44 INFO - "branch": "mozilla-beta", 17:06:44 INFO - "repo_path": "releases/mozilla-beta", 17:06:44 INFO - "revision": "9ddd4fee07842e72ba49f1583ec5f596f6e60e72", 17:06:44 INFO - "stage_platform": "macosx64", 17:06:44 INFO - "builduid": "1e491eec93884624aaf2d154000ebd94", 17:06:44 INFO - "slavebuilddir": "test" 17:06:44 INFO - } 17:06:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 17:06:44 INFO - Running post-action listener: _resource_record_post_action 17:06:44 INFO - [mozharness: 2017-01-06 01:06:44.030171Z] Finished read-buildbot-config step (success) 17:06:44 INFO - [mozharness: 2017-01-06 01:06:44.030291Z] Running download-and-extract step. 17:06:44 INFO - Running pre-action listener: _resource_record_pre_action 17:06:44 INFO - Running main action method: download_and_extract 17:06:44 INFO - mkdir: /builds/slave/test/build/tests 17:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:06:44 INFO - trying https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 17:06:44 INFO - Downloading https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/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 17:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/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 17:06:45 INFO - Downloaded 1165 bytes. 17:06:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 17:06:45 INFO - Using the following test package requirements: 17:06:45 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:06:45 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:06:45 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 17:06:45 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:06:45 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 17:06:45 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:06:45 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:06:45 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 17:06:45 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:06:45 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:06:45 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 17:06:45 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:06:45 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 17:06:45 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:06:45 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 17:06:45 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:06:45 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 17:06:45 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 17:06:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:06:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:06:45 INFO - Fetch https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:06:46 INFO - Expected file size: 16234496 17:06:52 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 17:06:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:06:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:06:52 INFO - Fetch https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:06:53 INFO - Expected file size: 16234496 17:07:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 17:07:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 17:07:00 INFO - Fetch https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 17:07:01 INFO - Expected file size: 14414089 17:07:01 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')]} 17:07:01 INFO - trying https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:07:01 INFO - Downloading https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 17:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/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 17:07:03 INFO - Downloaded 86140267 bytes. 17:07:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:07:03 INFO - mkdir: /builds/slave/test/properties 17:07:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:07:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:07:03 INFO - Contents: 17:07:03 INFO - build_url:https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:07:04 INFO - Running post-action listener: _resource_record_post_action 17:07:04 INFO - Running post-action listener: set_extra_try_arguments 17:07:04 INFO - [mozharness: 2017-01-06 01:07:04.641477Z] Finished download-and-extract step (success) 17:07:04 INFO - [mozharness: 2017-01-06 01:07:04.641639Z] Running populate-webroot step. 17:07:04 INFO - Running pre-action listener: _resource_record_pre_action 17:07:04 INFO - Running main action method: populate_webroot 17:07:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:07:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:07:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:07:04 INFO - '--tppagecycles', 17:07:04 INFO - '7'], 17:07:04 INFO - 'tests': ['tsvgm']}}, 17:07:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:07:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:07:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:07:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:07:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['damp', 'tps']}, 17:07:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'tests': ['damp', 'tps']}, 17:07:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['dromaeo_dom']}, 17:07:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:07:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['basic_compositor_video']}, 17:07:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:07:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['a11yr', 17:07:04 INFO - 'ts_paint', 17:07:04 INFO - 'tpaint', 17:07:04 INFO - 'sessionrestore', 17:07:04 INFO - 'sessionrestore_no_auto_restore', 17:07:04 INFO - 'tabpaint']}, 17:07:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tsvgx', 17:07:04 INFO - 'tsvgr_opacity', 17:07:04 INFO - 'tart', 17:07:04 INFO - 'tscrollx', 17:07:04 INFO - 'cart']}, 17:07:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:07:04 INFO - 'tsvgr_opacity', 17:07:04 INFO - 'tart', 17:07:04 INFO - 'tscrollx', 17:07:04 INFO - 'cart']}, 17:07:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s'], 17:07:04 INFO - 'tests': ['tp5o']}, 17:07:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'tests': ['tp5o']}, 17:07:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--disable-e10s', 17:07:04 INFO - '--xperf_path', 17:07:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:04 INFO - 'tests': ['tp5n']}, 17:07:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:04 INFO - 'talos_options': ['--xperf_path', 17:07:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:04 INFO - 'tests': ['tp5n']}}, 17:07:04 INFO - 'talos.zip': {'path': '', 17:07:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:07:04 INFO - Running post-action listener: _resource_record_post_action 17:07:04 INFO - [mozharness: 2017-01-06 01:07:04.660529Z] Finished populate-webroot step (success) 17:07:04 INFO - [mozharness: 2017-01-06 01:07:04.660666Z] Running create-virtualenv step. 17:07:04 INFO - Running pre-action listener: _resource_record_pre_action 17:07:04 INFO - Running main action method: create_virtualenv 17:07:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:07:04 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 17:07:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:07:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:07:04 INFO - Using real prefix '/tools/python27' 17:07:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:07:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:07:08 INFO - Installing pip.................done. 17:07:08 INFO - Return code: 0 17:07:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:07:08 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')]} 17:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:08 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')]} 17:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:08 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:08 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 17:07:08 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 17:07:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:08 INFO - 'HOME': '/Users/cltbld', 17:07:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:08 INFO - 'LOGNAME': 'cltbld', 17:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:08 INFO - 'MOZ_NO_REMOTE': '1', 17:07:08 INFO - 'NO_EM_RESTART': '1', 17:07:08 INFO - 'PAGER': '/bin/cat', 17:07:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:08 INFO - 'PWD': '/builds/slave/test', 17:07:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:08 INFO - 'SHELL': '/bin/bash', 17:07:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:08 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:08 INFO - 'USER': 'cltbld', 17:07:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:08 INFO - 'XPC_FLAGS': '0x0', 17:07:08 INFO - 'XPC_SERVICE_NAME': '0', 17:07:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:08 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 17:07:08 INFO - Cleaning up... 17:07:08 INFO - Return code: 0 17:07:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:07:08 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')]} 17:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:08 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')]} 17:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:08 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:08 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 17:07:08 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 17:07:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:08 INFO - 'HOME': '/Users/cltbld', 17:07:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:08 INFO - 'LOGNAME': 'cltbld', 17:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:08 INFO - 'MOZ_NO_REMOTE': '1', 17:07:08 INFO - 'NO_EM_RESTART': '1', 17:07:08 INFO - 'PAGER': '/bin/cat', 17:07:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:08 INFO - 'PWD': '/builds/slave/test', 17:07:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:08 INFO - 'SHELL': '/bin/bash', 17:07:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:08 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:08 INFO - 'USER': 'cltbld', 17:07:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:08 INFO - 'XPC_FLAGS': '0x0', 17:07:08 INFO - 'XPC_SERVICE_NAME': '0', 17:07:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:08 INFO - Downloading/unpacking psutil>=3.1.1 17:07:08 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 17:07:08 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 17:07:08 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 17:07:08 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 17:07:08 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 17:07:08 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 17:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:12 INFO - Installing collected packages: psutil 17:07:12 INFO - Running setup.py install for psutil 17:07:12 INFO - building 'psutil._psutil_osx' extension 17:07:12 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 17:07:13 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 17:07:13 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 17:07:13 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 17:07:13 INFO - building 'psutil._psutil_posix' extension 17:07:13 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 17:07:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:07:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:07:13 INFO - ^ 17:07:13 INFO - 1 warning generated. 17:07:13 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 17:07:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:13 INFO - Successfully installed psutil 17:07:13 INFO - Cleaning up... 17:07:13 INFO - Return code: 0 17:07:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:07: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')]} 17:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07: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')]} 17:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:07: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 mozsystemmonitor==0.3 17:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:13 INFO - 'HOME': '/Users/cltbld', 17:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:13 INFO - 'LOGNAME': 'cltbld', 17:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:13 INFO - 'MOZ_NO_REMOTE': '1', 17:07:13 INFO - 'NO_EM_RESTART': '1', 17:07:13 INFO - 'PAGER': '/bin/cat', 17:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:13 INFO - 'PWD': '/builds/slave/test', 17:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:13 INFO - 'SHELL': '/bin/bash', 17:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:13 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:13 INFO - 'USER': 'cltbld', 17:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:13 INFO - 'XPC_FLAGS': '0x0', 17:07:13 INFO - 'XPC_SERVICE_NAME': '0', 17:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:07:16 INFO - Installing collected packages: mozsystemmonitor 17:07:16 INFO - Running setup.py install for mozsystemmonitor 17:07:16 INFO - Successfully installed mozsystemmonitor 17:07:16 INFO - Cleaning up... 17:07:16 INFO - Return code: 0 17:07:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:07:16 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')]} 17:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:16 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')]} 17:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:16 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:16 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 17:07:16 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 17:07:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:16 INFO - 'HOME': '/Users/cltbld', 17:07:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:16 INFO - 'LOGNAME': 'cltbld', 17:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:16 INFO - 'MOZ_NO_REMOTE': '1', 17:07:16 INFO - 'NO_EM_RESTART': '1', 17:07:16 INFO - 'PAGER': '/bin/cat', 17:07:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:16 INFO - 'PWD': '/builds/slave/test', 17:07:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:16 INFO - 'SHELL': '/bin/bash', 17:07:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:16 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:16 INFO - 'USER': 'cltbld', 17:07:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:16 INFO - 'XPC_FLAGS': '0x0', 17:07:16 INFO - 'XPC_SERVICE_NAME': '0', 17:07:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:07:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:07:19 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 17:07:19 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 17:07:19 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 17:07:19 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 17:07:19 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 17:07:19 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 17:07:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:20 INFO - warning: no files found matching '*.txt' 17:07:20 INFO - no previously-included directories found matching 'build' 17:07:20 INFO - no previously-included directories found matching 'dist' 17:07:20 INFO - no previously-included directories found matching '.git*' 17:07:20 INFO - Installing collected packages: jsonschema, functools32 17:07:20 INFO - Running setup.py install for functools32 17:07:20 INFO - warning: no files found matching '*.txt' 17:07:20 INFO - no previously-included directories found matching 'build' 17:07:20 INFO - no previously-included directories found matching 'dist' 17:07:20 INFO - no previously-included directories found matching '.git*' 17:07:20 INFO - Successfully installed jsonschema functools32 17:07:20 INFO - Cleaning up... 17:07:20 INFO - Return code: 0 17:07:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:20 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:20 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 17:07:20 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 17:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:20 INFO - 'HOME': '/Users/cltbld', 17:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:20 INFO - 'LOGNAME': 'cltbld', 17:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:20 INFO - 'MOZ_NO_REMOTE': '1', 17:07:20 INFO - 'NO_EM_RESTART': '1', 17:07:20 INFO - 'PAGER': '/bin/cat', 17:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:20 INFO - 'PWD': '/builds/slave/test', 17:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:20 INFO - 'SHELL': '/bin/bash', 17:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:20 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:20 INFO - 'USER': 'cltbld', 17:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:20 INFO - 'XPC_FLAGS': '0x0', 17:07:20 INFO - 'XPC_SERVICE_NAME': '0', 17:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:07:20 INFO - Cleaning up... 17:07:20 INFO - Return code: 0 17:07:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:20 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:20 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 17:07:20 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 17:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:20 INFO - 'HOME': '/Users/cltbld', 17:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:20 INFO - 'LOGNAME': 'cltbld', 17:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:20 INFO - 'MOZ_NO_REMOTE': '1', 17:07:20 INFO - 'NO_EM_RESTART': '1', 17:07:20 INFO - 'PAGER': '/bin/cat', 17:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:20 INFO - 'PWD': '/builds/slave/test', 17:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:20 INFO - 'SHELL': '/bin/bash', 17:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:20 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:20 INFO - 'USER': 'cltbld', 17:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:20 INFO - 'XPC_FLAGS': '0x0', 17:07:20 INFO - 'XPC_SERVICE_NAME': '0', 17:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:20 INFO - Downloading/unpacking blobuploader==1.2.4 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07: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 17:07:23 INFO - Downloading blobuploader-1.2.4.tar.gz 17:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:07:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:07:23 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 17:07:23 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 17:07:23 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 17:07:23 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 17:07:23 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 17:07:23 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 17:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:07:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:07:24 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 17:07:24 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 17:07:24 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 17:07:24 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 17:07:24 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 17:07:24 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 17:07:24 INFO - Downloading docopt-0.6.1.tar.gz 17:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:07:24 INFO - Installing collected packages: blobuploader, requests, docopt 17:07:24 INFO - Running setup.py install for blobuploader 17:07:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:07:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:07:24 INFO - Running setup.py install for requests 17:07:25 INFO - Running setup.py install for docopt 17:07:25 INFO - Successfully installed blobuploader requests docopt 17:07:25 INFO - Cleaning up... 17:07:25 INFO - Return code: 0 17:07:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:25 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')]} 17:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:25 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')]} 17:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:25 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:25 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 17:07:25 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 17:07:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:25 INFO - 'HOME': '/Users/cltbld', 17:07:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:25 INFO - 'LOGNAME': 'cltbld', 17:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:25 INFO - 'MOZ_NO_REMOTE': '1', 17:07:25 INFO - 'NO_EM_RESTART': '1', 17:07:25 INFO - 'PAGER': '/bin/cat', 17:07:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:25 INFO - 'PWD': '/builds/slave/test', 17:07:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:25 INFO - 'SHELL': '/bin/bash', 17:07:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:25 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:25 INFO - 'USER': 'cltbld', 17:07:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:25 INFO - 'XPC_FLAGS': '0x0', 17:07:25 INFO - 'XPC_SERVICE_NAME': '0', 17:07:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:07:25 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-U9f2y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-5Pt6mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-1YzMOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-BOWgja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-NKjMP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-oRfuP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-asNGlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-mMZy5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-oY92Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-ddxV2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:07:26 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-3oIBIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:07:27 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-JlmVKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:07:27 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-g2ezF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:07:27 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-J_ixF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:27 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-UBYYvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:07:27 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-28BRar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:07:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:07:27 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-dwZ9Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:07:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:07:27 INFO - Running setup.py install for manifestparser 17:07:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:07:27 INFO - Running setup.py install for mozcrash 17:07:28 INFO - Running setup.py install for mozdebug 17:07:28 INFO - Running setup.py install for mozdevice 17:07:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Running setup.py install for mozfile 17:07:28 INFO - Running setup.py install for mozhttpd 17:07:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Running setup.py install for mozinfo 17:07:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Running setup.py install for mozInstall 17:07:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:07:28 INFO - Running setup.py install for mozleak 17:07:29 INFO - Running setup.py install for mozlog 17:07:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:07:29 INFO - Running setup.py install for moznetwork 17:07:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:07:29 INFO - Running setup.py install for mozprocess 17:07:29 INFO - Running setup.py install for mozprofile 17:07:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:07:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:07:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:07:29 INFO - Running setup.py install for mozrunner 17:07:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:07:29 INFO - Running setup.py install for mozscreenshot 17:07:30 INFO - Running setup.py install for moztest 17:07:30 INFO - Running setup.py install for mozversion 17:07:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:07:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:07:30 INFO - Cleaning up... 17:07:30 INFO - Return code: 0 17:07:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:30 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:30 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 17:07:30 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 17:07:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:30 INFO - 'HOME': '/Users/cltbld', 17:07:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:30 INFO - 'LOGNAME': 'cltbld', 17:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:30 INFO - 'MOZ_NO_REMOTE': '1', 17:07:30 INFO - 'NO_EM_RESTART': '1', 17:07:30 INFO - 'PAGER': '/bin/cat', 17:07:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:30 INFO - 'PWD': '/builds/slave/test', 17:07:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:30 INFO - 'SHELL': '/bin/bash', 17:07:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:30 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:30 INFO - 'USER': 'cltbld', 17:07:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:30 INFO - 'XPC_FLAGS': '0x0', 17:07:30 INFO - 'XPC_SERVICE_NAME': '0', 17:07:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:07:30 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-51Sgma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:07:30 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)) 17:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:07:30 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-haimKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:07:30 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)) 17:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:07:30 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-62Wpox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:07:30 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)) 17:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:07:30 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-Zh8I8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-SliLL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-lWw_p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-wr2ZOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-_z_7uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-zVKI1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-LV7W4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-7uuOhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-YkOq7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-KWr8J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:07:31 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)) 17:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:07:31 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-_LOdnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:07:32 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)) 17:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:32 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-N3oIi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:32 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)) 17:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:07:32 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-cD6lyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:07:32 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)) 17:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:07:32 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-rquOIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:07:32 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)) 17:07:32 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)) 17:07:32 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)) 17:07:32 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)) 17:07:32 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)) 17:07:32 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)) 17:07:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:07:32 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 17:07:32 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 17:07:32 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 17:07:32 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 17:07:32 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 17:07:32 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 17:07:34 INFO - Downloading blessings-1.6.tar.gz 17:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:07:35 INFO - Installing collected packages: blessings 17:07:35 INFO - Running setup.py install for blessings 17:07:35 INFO - Successfully installed blessings 17:07:35 INFO - Cleaning up... 17:07:35 INFO - Return code: 0 17:07:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:07:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:35 INFO - Reading from file tmpfile_stdout 17:07:35 INFO - Current package versions: 17:07:35 INFO - blessings == 1.6 17:07:35 INFO - blobuploader == 1.2.4 17:07:35 INFO - docopt == 0.6.1 17:07:35 INFO - functools32 == 3.2.3-2 17:07:35 INFO - jsonschema == 2.5.1 17:07:35 INFO - manifestparser == 1.1 17:07:35 INFO - mozInstall == 1.12 17:07:35 INFO - mozcrash == 0.17 17:07:35 INFO - mozdebug == 0.1 17:07:35 INFO - mozdevice == 0.48 17:07:35 INFO - mozfile == 1.2 17:07:35 INFO - mozhttpd == 0.7 17:07:35 INFO - mozinfo == 0.9 17:07:35 INFO - mozleak == 0.1 17:07:35 INFO - mozlog == 3.4 17:07:35 INFO - moznetwork == 0.27 17:07:35 INFO - mozprocess == 0.23 17:07:35 INFO - mozprofile == 0.28 17:07:35 INFO - mozrunner == 6.12 17:07:35 INFO - mozscreenshot == 0.1 17:07:35 INFO - mozsystemmonitor == 0.3 17:07:35 INFO - moztest == 0.7 17:07:35 INFO - mozversion == 1.4 17:07:35 INFO - psutil == 3.1.1 17:07:35 INFO - requests == 1.2.3 17:07:35 INFO - wsgiref == 0.1.2 17:07:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:35 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 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:35 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 17:07:35 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 17:07:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:35 INFO - 'HOME': '/Users/cltbld', 17:07:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:35 INFO - 'LOGNAME': 'cltbld', 17:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:35 INFO - 'MOZ_NO_REMOTE': '1', 17:07:35 INFO - 'NO_EM_RESTART': '1', 17:07:35 INFO - 'PAGER': '/bin/cat', 17:07:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:35 INFO - 'PWD': '/builds/slave/test', 17:07:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:35 INFO - 'SHELL': '/bin/bash', 17:07:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:35 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:35 INFO - 'USER': 'cltbld', 17:07:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:35 INFO - 'XPC_FLAGS': '0x0', 17:07:35 INFO - 'XPC_SERVICE_NAME': '0', 17:07:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 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)) 17:07:35 INFO - Cleaning up... 17:07:35 INFO - Return code: 0 17:07:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bfc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82ba5c2160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, '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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 17:07:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:07:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:07:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:35 INFO - 'HOME': '/Users/cltbld', 17:07:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:35 INFO - 'LOGNAME': 'cltbld', 17:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:35 INFO - 'MOZ_NO_REMOTE': '1', 17:07:35 INFO - 'NO_EM_RESTART': '1', 17:07:35 INFO - 'PAGER': '/bin/cat', 17:07:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:35 INFO - 'PWD': '/builds/slave/test', 17:07:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:35 INFO - 'SHELL': '/bin/bash', 17:07:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:35 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:35 INFO - 'USER': 'cltbld', 17:07:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:35 INFO - 'XPC_FLAGS': '0x0', 17:07:35 INFO - 'XPC_SERVICE_NAME': '0', 17:07:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:07:36 INFO - Cleaning up... 17:07:36 INFO - Return code: 0 17:07:36 INFO - Running post-action listener: _resource_record_post_action 17:07:36 INFO - Running post-action listener: _start_resource_monitoring 17:07:36 INFO - Starting resource monitoring. 17:07:36 INFO - [mozharness: 2017-01-06 01:07:36.202867Z] Finished create-virtualenv step (success) 17:07:36 INFO - [mozharness: 2017-01-06 01:07:36.203876Z] Running install step. 17:07:36 INFO - Running pre-action listener: _resource_record_pre_action 17:07:36 INFO - Running main action method: install 17:07:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:36 INFO - Reading from file tmpfile_stdout 17:07:36 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:07:36 INFO - Reading from file tmpfile_stdout 17:07:36 INFO - Output received: 17:07:36 INFO - Usage: mozinstall [options] installer 17:07:36 INFO - Options: 17:07:36 INFO - -h, --help show this help message and exit 17:07:36 INFO - -d DEST, --destination=DEST 17:07:36 INFO - Directory to install application into. [default: 17:07:36 INFO - "/builds/slave/test"] 17:07:36 INFO - --app=APP Application being installed. [default: firefox] 17:07:36 INFO - mkdir: /builds/slave/test/build/application 17:07:36 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'] 17:07:36 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 17:07:58 INFO - Reading from file tmpfile_stdout 17:07:58 INFO - Output received: 17:07:58 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:07:58 INFO - Running post-action listener: _resource_record_post_action 17:07:58 INFO - [mozharness: 2017-01-06 01:07:58.099648Z] Finished install step (success) 17:07:58 INFO - [mozharness: 2017-01-06 01:07:58.099787Z] Running run-tests step. 17:07:58 INFO - Running pre-action listener: _resource_record_pre_action 17:07:58 INFO - Running main action method: run_tests 17:07:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:07:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:07:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:07:58 INFO - 2017-01-05 17:07:58.114 screenresolution[1909:13777] starting screenresolution argv=screenresolution get 17:07:58 INFO - 2017-01-05 17:07:58.117 screenresolution[1909:13777] Display 0: 1600x1200x32@50 17:07:58 INFO - 2017-01-05 17:07:58.123 screenresolution[1910:13780] starting screenresolution argv=screenresolution list 17:07:58 INFO - Available Modes on Display 0 17:07:58 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 17:07:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:07:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:07:58 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 17:07:58 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 17:07:58 INFO - Graphics/Displays: 17:07:58 INFO - Intel Iris: 17:07:58 INFO - Chipset Model: Intel Iris 17:07:58 INFO - Type: GPU 17:07:58 INFO - Bus: Built-In 17:07:58 INFO - VRAM (Dynamic, Max): 1536 MB 17:07:58 INFO - Vendor: Intel (0x8086) 17:07:58 INFO - Device ID: 0x0a2e 17:07:58 INFO - Revision ID: 0x0009 17:07:58 INFO - Displays: 17:07:58 INFO - Display: 17:07:58 INFO - Resolution: 1600 x 1200 @ 50 Hz 17:07:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:07:58 INFO - Display Serial Number: 1600x1200 50 17:07:58 INFO - Main Display: Yes 17:07:58 INFO - Mirror: Off 17:07:58 INFO - Online: Yes 17:07:58 INFO - Rotation: Supported 17:07:58 INFO - Return code: 0 17:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:58 INFO - Python 2.7.3 17:07:58 INFO - Return code: 0 17:07:58 INFO - grabbing minidump binary from tooltool 17:07: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')]} 17:07:58 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 0x102a9ad30>, '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 0x102900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a92b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:58 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 17:07:58 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 17:07:58 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 17:07:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:58 INFO - Return code: 0 17:07:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:07:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:07:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:58 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/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--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 17:07:58 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/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0011 --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 17:07:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d86sucNZGZ/Render', 17:07:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:58 INFO - 'HOME': '/Users/cltbld', 17:07:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:58 INFO - 'LOGNAME': 'cltbld', 17:07:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:58 INFO - 'MOZ_NO_REMOTE': '1', 17:07:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:58 INFO - 'NO_EM_RESTART': '1', 17:07:58 INFO - 'PAGER': '/bin/cat', 17:07:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:58 INFO - 'PWD': '/builds/slave/test', 17:07:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:58 INFO - 'SHELL': '/bin/bash', 17:07:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QbEsgK2YCZ/Listeners', 17:07:58 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 17:07:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:58 INFO - 'USER': 'cltbld', 17:07:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:58 INFO - 'XPC_FLAGS': '0x0', 17:07:58 INFO - 'XPC_SERVICE_NAME': '0', 17:07:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:58 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/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--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 17:07:58 INFO - mozversion application_buildid: 20170105155013 17:07:58 INFO - mozversion application_changeset: 9ddd4fee07842e72ba49f1583ec5f596f6e60e72 17:07:58 INFO - mozversion application_display_name: Firefox 17:07:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:58 INFO - mozversion application_name: Firefox 17:07:58 INFO - mozversion application_remotingname: firefox 17:07:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:07:58 INFO - mozversion application_vendor: Mozilla 17:07:58 INFO - mozversion application_version: 51.0 17:07:58 INFO - mozversion platform_buildid: 20170105155013 17:07:58 INFO - mozversion platform_changeset: 9ddd4fee07842e72ba49f1583ec5f596f6e60e72 17:07:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:07:58 INFO - mozversion platform_version: 51.0 17:07:58 INFO - using testdate: 1483664878 17:07:58 INFO - actual date: 1483664878 17:07:58 INFO - starting webserver on 'localhost:51985' 17:07:58 INFO - SUITE-START | Running 2 tests 17:07:58 INFO - TEST-START | dromaeo_css 17:07:58 INFO - operating with platform_type : mac_ 17:07:58 INFO - Initialising browser for dromaeo_css test... 17:07:58 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpgdLkyd/profile http://localhost:51985/getInfo.html) 17:08:00 INFO - PROCESS | 1920 | __metrics Screen width/height:1600/1200 17:08:00 INFO - PROCESS | 1920 | colorDepth:24 17:08:00 INFO - PROCESS | 1920 | Browser inner width/height: 1024/689 17:08:00 INFO - PROCESS | 1920 | __metrics 17:08:01 INFO - PROCESS | 1920 | 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" 17:08:01 INFO - PROCESS | 1920 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:01 INFO - TEST-INFO | 1920: exit 0 17:08:01 INFO - Browser initialized. 17:08:01 INFO - Running cycle 1/1 for dromaeo_css test... 17:08:01 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpgdLkyd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:13 INFO - PROCESS | 1923 | RSS: Main: 169025536 17:08:13 INFO - PROCESS | 1923 | 17:09:05 INFO - PROCESS | 1923 | 1483664945598 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] 17:11:15 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51985/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51985/tests/dromaeo/cssquery-ext.html) 17:11:17 INFO - PROCESS | 1923 | RSS: Main: 301510656 17:11:17 INFO - PROCESS | 1923 | 17:14:20 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51985/tests/dromaeo/cssquery-ext.html (next: http://localhost:51985/tests/dromaeo/cssquery-jquery.html) 17:14:20 INFO - PROCESS | 1923 | RSS: Main: 302198784 17:14:20 INFO - PROCESS | 1923 | 17:17:22 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51985/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51985/tests/dromaeo/cssquery-mootools.html) 17:17:23 INFO - PROCESS | 1923 | RSS: Main: 287793152 17:17:23 INFO - PROCESS | 1923 | 17:20:25 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51985/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51985/tests/dromaeo/cssquery-prototype.html) 17:20:26 INFO - PROCESS | 1923 | RSS: Main: 267038720 17:20:26 INFO - PROCESS | 1923 | 17:23:29 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51985/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51985/tests/dromaeo/cssquery-yui.html) 17:23:30 INFO - PROCESS | 1923 | RSS: Main: 265383936 17:23:30 INFO - PROCESS | 1923 | 17:26:32 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51985/tests/dromaeo/cssquery-yui.html (next: http://localhost:51985/tests/dromaeo/cssquery-dojo.html) 17:26:33 INFO - PROCESS | 1923 | RSS: Main: 306872320 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | __start_tp_report 17:26:33 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 17:26:33 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 17:26:33 INFO - PROCESS | 1923 | |i|pagename|runs| 17:26:33 INFO - PROCESS | 1923 | |0;dojo.html;3438.346714124317;3442.6385229550897;3475.669811367919;3479.8608055677773;3525.312564050011;4837.540433658801;5792.304923409186;5889.676067816279;5910.113482977556;5960.82117536474;5861.062230043194;5946.702664866761;5954.13665018572;5961.552883533731;5972.850678733033;5262.105442074847;5286.735663216843;5362.249285100089;5363.9463605363835;5368.1679339702405;5240.240165176047;5269.156934890419;5410.134378499441;5412.91880621791;5418.972905135469;5334.839954801362;5369.167778994242;5377.435369286227;5385.192221166837;5396.865078373053;5256.842294731164;5314.62797604164;5332.440093790155;5332.68003919766;5346.786128554853;5232.607554433433;5251.842444726664;5269.262303277545;5337.332833395825;5386.3536375634785;5740.052891272935;5972.850678733023;6031.849203769897;6039.214902062704;6056.878862422727;6134.00801433197;6138.24286178211;6141.7543298268465;6160.599561028519;6171.537134714869;6241.594296370721;6286.308506064329;6316.873662526769;6373.203349581302;6375.266844312917;6077.4226448487325;6078.908816367758;6083.057126145454;6088.939110608926;6096.786612468542;6252.968735156386;6295.464885484785;6325.240971083499;6363.236411630634;6391.42477177047;6161.168242287234;6166.81499555014;6177.166082578794;6180.196574445294;6185.072239164161;6280.089387038854;6304;6304.65324407162;6307.4954003679595;6311.274203466568;6111.07520520229;6144.109104179869;6166.537509686791;6168.537359698041;6191.721372538246;6111.191249546102;6143.818944274807;6152.077188421773;6158.938410615926;6238.500919926395;5066.771995260222;5092.567131793765;5100.183970564692;5102.08162530748;5118.513741194655;4568.908621827545;4569.314602809605;4569.337446070301;4581.221192397301;4608.976955115203;5057.317262169634;5910.911336329958;5979.551533634908;5985.551083668655;6053.515718742578;6366.331535188831;6369.872602547923;6375.011873159668;6380.425761681471;6392.520560957853;6059.424354686298;6065.96967015171;6084.756609735561;6089.786857459968;6117.990531562331;5423.945760542344;5483.972580137074;5496.780128794803;5583;5644.85887852807;6398.968005160037;6453.419192272718;6473.255575608865;6554.8361290968105;6559.409653131051;6319.115323854756;6320.778772742932;6320.841978950563;6341.619502829845;6345.555811093179;6490.156279683611;6498.967505162444;6513.055606937062;6548.345165483413;6551.181102362205;6107.446930123121;6107.643995706967;6155;6160.353162918008;6189.288231853395;6342.651154186564;6344.143540622142;6346.397092276226;6347.96826015867;6367.554271200971;6068.302145253352;6079.483243924316;6117.510599151969;6158.507319414526;6172.722227499684;5117.641765076409;6106.82471942484;6109.222480666452;6152.16945712341;6163.7842675506145;6161.291451482957;6175.62946223228;6187.876242475215;6198.1012753149635;6204.255489341308;5999.40005999414;6154;6166.660833654192;6178.567500274938;6180.227471566054;6022.668753218615;6089.695515224133;6110.326162663493;6124.8775024500155;6174.567780255518 17:26:33 INFO - PROCESS | 1923 | |1;ext.html;474.7934648427934;486.2560282767365;495.707532555792;498.8377081400338;536.7745546870314;30562.54156187659;32020.839895800516;33182.502262466085;33225.00324990248;39527.60472395283;39410.01474963127;42300.788496057554;42324.36513452293;42335.78832105835;42343;10096.343737657047;10161.898381016206;10165.390076595391;10172.847407288897;10317.638882639108;9305.720828375126;9499.572519236617;9527.475988820612;10022.248331375176;10145.797084058315;9479.099485548863;9540.236781057498;12184.268943863352;12435.502579896793;12458.688532786662;12422.440990155465;12481.126321157522;12508.687282817957;12509.749805003848;12549.498020079185;12242.571509997108;12334.259944403364;12337.69155771104;12348.753024939451;12365.443555040045;40297.395539066645;40562.79718601418;40595;40694.38958415626;40735.592644073775;3397.1167496450853;3458.706009989154;3623.2391197848483;3872.4384964180317;3893.610638936084;31541.52687709686;31667.36665266705;31836.36327273465;31838.044858654277;32426;3410.931781364384;3453.9654603453896;3454.101933497284;3465.6707612776745;3475.7045651119683;510706.44646776526;520483;521808;521838.7816121828;524054;34133.82933085319;59850.70074649599;60208;60226.397736022955;60409.69795151084;35108.12229694278;36272;36272.4559131608;36340.81829590835;36367;15629.531114066596;15807.36770529166;15807.446739364066;15831.575158235813;15849.445269415746;13299.468021279234;13450.192988420726;13458.327083645778;13475.326233688473;13496;7448.85102297951;7592;7780.3386712130105;7946.9602651987525;8025.678972841138;2966.5995090662914;3265.706086452231;3326.667333266654;3375.3586818504405;3379.814110223912;869.9347548933855;932.6922115701802;1088.4176965323513;1091.8089334366455;1160.2864238493266;29554.852225738734;30237.092887213417;30417.087487375415;30644;31003.689963100533;1044.4725413666201;1050.7688308572256;1077.272840832435;1155.6995181252935;1209.3469526455792;15560.533184004498;15911.363545458284;15984.920075399548;16344.918275408785;16361.83638163603;699596;707465;711574;712170;714095;51819.48180518222;51862.48137518652;58724.706376467846;58762;59005.40994589999;1400.285854214358;1405.7188562287379;1444.400573761877;1444.7832825076323;1447.117258472331;29941.47986510665;31361.52957705682;31527.369452611278;31987.360252794348;32191.03426897197;49926.750366247936;50332.24501632405;50382.7404314895;50400.49599503958;50484.49515504798;604665;608026;608130.9593452004;608274;609263;26614.600780987912;26851.328716781456;27247.591286130326;27256.046038388562;27281.863590681918;47766;48159.277610836565;48363;48879.75560122177;49116.50883491119;34149.146271343416;38430.231395372495;39827.40258896177;40285.798571006955;40949;35784.284314314085;39073.609263907;39232.80383598178;39514.62912225276;40600;36503.45244821383;38466.615333846305;39541.2091758169;39631;39726;33159.336813263115;34201.486977694854;34233.82883085569;35040.64959350374;35124.77063302772;26052.218433447026;26074.915391498474;26192.476150477265;26362.209133726017;26708 17:26:33 INFO - PROCESS | 1923 | |2;jquery.html;295.5994627280036;384.44063887044337;386.06572095528816;401.2656837986485;415.22974881594644;19937;21171.894140529315;22316.330510084703;22335.553288934232;22526.54946901061;12123.272603643787;12353.62939111828;12355.50577976882;12611.43248553815;12643.304618246017;5475.808346707866;5771.076627739562;5777.335606405254;5787.623804452697;5791.305043394798;5567.693776842272;5636.323641163066;6244.344343843899;6288.371162883721;6319.936800632004;6248.250209974786;6251.3123556408755;6258.405451482102;6261.624302541862;6269.62382257066;5640.605157638967;5677.574181936371;5688.061469857468;5694.174344719992;5710.543156547466;5293.602979776532;5517.062099443064;5529.557635389159;5535.612507124503;5541.5843811714285;13904.930475347659;13981.720365592631;21970.571912825617;22354;22751.54496910069;2239.4065572623267;2298.5747636687265;2324.360800779799;2373.6320870265135;2878.7265209805037;10403.53184106717;10507.422091784949;10614.257002009863;11444.484998175101;16607.674925510437;1887.160213704902;1958.7747409048;1963.2147141143514;1976.081122278133;2004.5489764802803;102687;127757.08364374541;134256;137178;139430.3028484861;11444.14168937333;11734.413279335999;11815;11825.763484730429;11842.730440291525;15453.227338633023;15455.845441545665;15478.690426191413;15495.457658982106;15514.689706205812;8949.821003579891;9052.81894362109;9093;9094.27245820346;9233.261339092856;9109.362344635812;9127.543622818832;9130.726078217664;9299.070092990647;9301.209397201314;4627.421572303462;4629.421322334708;4631.444226692751;4695.81216751333;4767.69010014348;1666.31681010785;1680.899146051241;1942.5823447958758;1953.2089503751004;1980.8613397062068;671.2649648634737;873.8732883731823;947.2374738335568;974.780674348266;980.2011360740973;19077.713834292495;21448.892755536122;21479.570408591742;23298.65052024221;23414;961.2694352292308;963.816874793787;968.8595153702673;977.9217662587118;996.2030375699411;11550.88449115498;11752.23610465317;11942.940285298519;11958.222715523463;11980.940095299467;605916.9408305949;613115;619977;625038;626000;75877.24122758812;83073.33853322899;90765;133087;140125;990.1830989433746;997.4464172384252;1031.1493018259966;1033.8190816607064;1037.6523864505325;19512.512187195432;19800.306989255307;19959.301424450074;20018.399448016582;20059.59880802405;52614.736926316655;53237.7338113307;55648;56147.315580532646;56348.15477767755;72236.27763722505;73914.63042684752;74640.25359746334;74701;77046.2215333841;6917.619530925847;8504.574771261536;8537.786555335917;8777.078406767198;8801.295896328407;9515.857262140935;12897.742045158857;13495.055346125677;13832.654183645489;13956.302184890512;11313.547458101584;11411.372374519482;11536.82694759596;12079.75840483203;12104.636860894187;11305.039071678999;11463.369514676773;11692.88307116952;11840.585579504675;11889.405529723652;11417.885821141683;11665;11932.22440541362;11958.58144964922;12141.39293035327;8447.91552084496;8567.4002819802;8673.436226645501;8731.69439069655;8737.606807693543;9888.357256778287;11450.37022963745;11686.474108664961;11749.004003978931;11816.113791465503 17:26:33 INFO - PROCESS | 1923 | |3;mootools.html;1557.3459147158196;1594.92822822973;1786.8123846996066;1899.5441094137411;1929.9903500482496;8818.20636142747;9380.249580033598;9382.390144640594;9386.953065234673;9390.765230869232;8258.628361723722;8500.447470914387;8519.318454523638;8969.013408525074;9137.406068605536;2449.7182823975204;2487.5273697997413;2495.5508008558454;2499.700035995674;2500.349909023658;2425.2360506440414;2455.0302630460956;2466.2724496273554;2481.900723971039;2486.29140694902;2433.914812981546;2464.6056630938965;2464.8028157747335;2473.530029294437;2486.4529803443215;2426.8179886508583;2444.2667199840066;2453.325335532725;2453.386653336666;2453.852768833876;2428.5021570577987;2436.878156092206;2438.9390265243333;2439.5852705040184;2441.0967941861445;9126.26989840811;9333.346665733401;9336.159745622926;9339.579718912666;9346.953265233698;5523.199136125279;5678.659280443146;5695.03184458643;5697.03150464422;5702.059160238556;3528.153243221634;3615.8192090395637;3740.8503659853573;3742.850285988557;3744.8876533704033;1106.634810512529;1125.2629527659396;1844.6771814932467;1894.8199921007483;1928.3829174664113;12071.577494787729;12423.254604723656;12435.875641243652;12464.501419943192;12579.433925473375;4742.383490146328;4746.406699162605;4794.381861551547;4855.5387238212315;4883.4628190898975;9675.758106047406;9676.806463870684;9681.467519286365;9684;9686.903130968742;5535.446455354513;5542.251796007568;5549.500544950974;5551;5560.499555040065;5020.49795020495;5186.4035635902355;5213.374395072616;5226.634135610547;5242.292290540729;3806.71449641278;3828.368319227352;3841.9039524011564;3882.417637354363;3911.530616326059;1176.564671071709;1182.5742732616252;1188.3701638131804;1197.868234494205;1203.8856308650838;786.1470304719444;876.9166929141721;907.8955920069144;919.2829592917535;930.292977337215;5881.911771323434;6012.068129439944;6086.9391306087255;6132.50939924805;6413.0059840723825;906;929.4609126706493;940.4968341937031;957.7461972577272;971.504532688334;3746.269477451871;4007.1785284016705;4044.2315959967514;4049.8582549610624;4104.19808823677;10912.345259284468;11354.602588909349;11355.26190797612;11374.488148033359;11376.488058037408;10849.294795838245;11267.26762760418;11271.549138034386;11285.830712539318;11536.76926461466;8548.27339676122;8759.605817738217;8760.693375731818;8775.078616745277;8782;4969.552740253394;5528.281323427928;5923.49650279731;5941.643501389931;6322.430981211713;9834.459104749307;10320.48397580133;10655;10713.250072494851;10718.928107189218;10973.396463194282;10976.396298203676;10979.780404392028;10991;10994.780104398027;7208.207097219197;7444.255574442513;7460;7518.210587888193;7752.3798096153305;8559.57202139878;8816.691415800417;8866;8973.416727912665;8979.281657467256;7905.881411778943;7915.802104947423;7951.761447156595;7979.9601001994615;8005.119436862057;7657.578833164007;7670.309672129535;7751.341136003277;7864.72473463426;7878.921210787818;7091.680874360563;7281.927180728125;7306.634668266672;7358.227386124594;7379.409647228102;4841.733704646278;4911.361523001987;4999.0501804657;5110.514501122388;5233.319668443078;5041.193409054534;5047.091523525801;5098.515641014098;5198.532132108128;5313.707746074003 17:26:33 INFO - PROCESS | 1923 | |4;prototype.html;311.40055393367766;312.82638135834605;317.9729722973547;326.7630967548526;328.371169210961;4712.905741885164;4971.2046072628345;5443.1835224716315;5454.209139674755;5459.945400545993;4439.089986552757;5209.400918894328;5216.26972223889;5325.7869685212645;5399.244105825188;4119.2997190477545;4142.109446469001;4197.027397123347;4204.285271503852;4212.915741685165;3930.430087637291;4168.729032612886;4187.246295666779;4191.979040104795;4215.641670458015;3619.94570081449;4007.5391329997133;4123.567025462313;4175.373693945902;4187;3837.9637497875697;3990.8603198888045;4142.2543942090415;4155.833766649331;4155.877912963483;3043.3522835133576;3463;3639.2175682228185;3641.9453708194396;3673.522442082512;5057.393112826484;5275.314209152824;5300.92048619271;5332.626716129873;5341.65279256847;4582;4898.877528061791;4925.655204135712;4948.802047918079;4967.850964471036;5154.38147422308;5158.297761738617;5816.574939139896;5879.118132280149;5902.911456328158;3870.181014922982;4047.615476529725;4149.7095203335775;4154.979225103855;4167.249895018896;4813.614910807127;5836.474717275466;5935.812837432531;6130.846728831771;6208.099825525319;3822.9235415291537;4074.9608849743126;4192.538820729717;4210.663146948237;4222.514410842792;4098.426220329156;4259.190753756776;4288.699791014599;4308.74147551148;4308.944308644403;3931;4230.238557059759;4480.76778885809;4569.520200378913;4731.69243999139;4730.645201609893;5853.975554277984;5869.266341707286;5878.353381128072;5961.642301461926;1196.9880301197052;1283.9037072219621;1324.8675132486674;1425.7880801319004;1428.0788891165348;858.2533196119416;881.9867701984475;925.9490728010024;962.7881865989472;977.4282045003611;5163.14808056674;5174.793008279702;5219.765110570033;5495.972520137374;5506;5356.491133342326;5642.633228840113;5894.941050589525;5956.85107872298;6033;5231.869203269873;5592.077307244259;5605.477535109136;5606.159076138611;5629.933060245811;2842.1899758568707;2860.5137126688514;2871.7559007484597;2955.896543620963;3152.7004934531183;5901.58688891782;6185.721642526007;6188.81433556985;6235.781747638811;6254.718537665816;5083.974580127149;6163.982942814475;6182.723156726942;6188.60608967629;6216.222972128484;5141.640085194001;5405.810796622178;5425.755840987165;5722.341930677942;6141.324454310023;5039.840836607674;5484.7933454639915;5570.749316280858;5948.553858460719;5958.76164953397;5683.374828768915;5838.299404071538;5869.882602348014;5929.792457263975;5989.670568118621;5451.318585176853;6147.969260153671;6148.200733904564;6210.782622608187;6311.274203466476;3932.3708206686792;3979.960200397959;3979.960200397959;3980.109448012287;3987.4218238354697;5638.633488823213;5971.910421343597;5972.761089556543;6004.789832355847;6061.484773794277;5004.721907150822;5503.77141715364;5662.915056274242;5768.826935191951;5825.475707186373;5209.707728599404;5740.598158128891;5775;5776.7111644418455;5778.566607504538;5287.312649355713;5406.78372865081;5611;5663.9716801415725;5716;4805.063012712488;4993.675411098267;5698.572607054571;5781.364049954585;5803.564732644984;4848.95151048485;4931.876703082452;5463.644863083887;5665.49010589049;5709.572606848288 17:26:33 INFO - PROCESS | 1923 | |5;yui.html;640.903864420337;731.2504682700231;734.3134169551469;815.8286759780445;820.4543978254461;15480.767788483181;16576;16578.253978570963;16588.336466541354;16590;14928.925355373209;14978.400863965455;15000.474983375583;15058.698826023472;15114.999999999973;719.8560287942406;740.914794798597;747.4468893019153;860.2988564320091;903.6746771162409;894.8165626046678;908.8318661047695;911.8768966189546;912.8630705394178;913.1507697841005;964.3779762053472;966;966.830804609194;967.8644989701447;973.4159504297436;954.4654993203828;954.9952250238774;957.1146689312428;957.6121670723368;957.9941061884992;715.6564848872571;716.9390601798854;716.9784906452815;718.0736849464184;720.783764870542;15017.624559385993;15032.022918510262;15045.548633541011;15051.473198438001;15054.473093441677;13296.73406531864;14729.337179826933;14801.851981480155;14821.92589037048;14919;13064.608061758163;13268.071235013553;13452.1256118352;13469.326533673277;13538.323083845868;3968.9801550992347;4564.771761411949;4658.487566367697;4729;4842.4189097308545;114741;117941;118320.40839795832;119673.20490192741;120066.59866802616;10543.736406589744;11050.33697978124;11053.834192487118;11076.667699969013;11297.774044519063;21326.573468530543;21348.039338229817;21421.357359279245;21449.57100857974;21472.892635536722;6768.560043597249;7936.16670249627;7964.362850971908;7970.123286438487;8146.063202731643;4458.866234012985;4460.7323560586465;4537.954620453819;4538.228501154812;4628.907421851544;3472.8089955052715;3591.245838373971;3602.693771029492;3603.207294395229;3603.8017909015257;628.3998781163978;661.6427129350193;669.825845280221;674.2010717300016;679.49038221334;577.3908526504495;577.3995045153077;626.4612433307352;639.6993413095837;650.54786923088;7956.562389068541;8741.125887411208;9050.86423703645;9082.772930676654;9147.131022552847;612.1138830414528;621.0559948877681;629.4397985792648;652.1424327009967;658.8996376052005;4198.4961804583645;4341.37050127736;4382.956170438255;4385.122975404932;4423.388555485619;99926.50110248353;122668;166237;167406;171862;130951;133582.33208833894;135573;136965.3151734235;137253;99735;102009;106942.3958640621;107410;109901.45049274703;8363.25911738903;8387.916120838714;8428.45215061019;8445;8581.528015958933;49557.752211238716;61082;65396.34603654093;66639.3336066633;68060.6596967012;61851.38148618456;65573.34426655673;69025;88995;90164.0983590182;11499;13121.343932803513;13590.660233494242;13658.521951731642;14169.079009864327;12278.75442491163;13889.166650001032;14591.92704036473;15195.468158614396;15715.135667537937;13313.600591982256;13917.373718182504;14466.132032078109;14585.197814119902;14779;13549.119307244997;13811.79282310746;14202.715945680822;14293.999420040913;14888.62778430548;13204.801927970895;13325.666858328232;13554.59336219915;13604.795928060888;13766.724665506834;10720.303180293256;11435;11439.828402574134;11746.941265293619;11931.463084161407;11462.94268528652;11468.885311146782;11513.481893314653;11650;11711.648650540497 17:26:33 INFO - PROCESS | 1923 | __end_tp_report 17:26:33 INFO - PROCESS | 1923 | __start_cc_report 17:26:33 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,1201 17:26:33 INFO - PROCESS | 1923 | __end_cc_report 17:26:33 INFO - PROCESS | 1923 | __startTimestamp1483665993218__endTimestamp 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | ------- Summary: start ------- 17:26:33 INFO - PROCESS | 1923 | Number of tests: 6 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | [#0] dojo.html Cycles:165 Average:5853.32 Median:6107.64 stddev:631.04 (10.3%) stddev-sans-first:603.87 17:26:33 INFO - PROCESS | 1923 | Values: 3438.3 3442.6 3475.7 3479.9 3525.3 4837.5 5792.3 5889.7 5910.1 5960.8 5861.1 5946.7 5954.1 5961.6 5972.9 5262.1 5286.7 5362.2 5363.9 5368.2 5240.2 5269.2 5410.1 5412.9 5419.0 5334.8 5369.2 5377.4 5385.2 5396.9 5256.8 5314.6 5332.4 5332.7 5346.8 5232.6 5251.8 5269.3 5337.3 5386.4 5740.1 5972.9 6031.8 6039.2 6056.9 6134.0 6138.2 6141.8 6160.6 6171.5 6241.6 6286.3 6316.9 6373.2 6375.3 6077.4 6078.9 6083.1 6088.9 6096.8 6253.0 6295.5 6325.2 6363.2 6391.4 6161.2 6166.8 6177.2 6180.2 6185.1 6280.1 6304.0 6304.7 6307.5 6311.3 6111.1 6144.1 6166.5 6168.5 6191.7 6111.2 6143.8 6152.1 6158.9 6238.5 5066.8 5092.6 5100.2 5102.1 5118.5 4568.9 4569.3 4569.3 4581.2 4609.0 5057.3 5910.9 5979.6 5985.6 6053.5 6366.3 6369.9 6375.0 6380.4 6392.5 6059.4 6066.0 6084.8 6089.8 6118.0 5423.9 5484.0 5496.8 5583.0 5644.9 6399.0 6453.4 6473.3 6554.8 6559.4 6319.1 6320.8 6320.8 6341.6 6345.6 6490.2 6499.0 6513.1 6548.3 6551.2 6107.4 6107.6 6155.0 6160.4 6189.3 6342.7 6344.1 6346.4 6348.0 6367.6 6068.3 6079.5 6117.5 6158.5 6172.7 5117.6 6106.8 6109.2 6152.2 6163.8 6161.3 6175.6 6187.9 6198.1 6204.3 5999.4 6154.0 6166.7 6178.6 6180.2 6022.7 6089.7 6110.3 6124.9 6174.6 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | [#1] ext.html Cycles:180 Average:72758.57 Median:3456.40 stddev:165454.27 (4786.9%) stddev-sans-first:165829.40 17:26:33 INFO - PROCESS | 1923 | Values: 474.8 486.3 495.7 498.8 536.8 30562.5 32020.8 33182.5 33225.0 39527.6 39410.0 42300.8 42324.4 42335.8 42343.0 10096.3 10161.9 10165.4 10172.8 10317.6 9305.7 9499.6 9527.5 10022.2 10145.8 9479.1 9540.2 12184.3 12435.5 12458.7 12422.4 12481.1 12508.7 12509.7 12549.5 12242.6 12334.3 12337.7 12348.8 12365.4 40297.4 40562.8 40595.0 40694.4 40735.6 3397.1 3458.7 3623.2 3872.4 3893.6 31541.5 31667.4 31836.4 31838.0 32426.0 3410.9 3454.0 3454.1 3465.7 3475.7 510706.4 520483.0 521808.0 521838.8 524054.0 34133.8 59850.7 60208.0 60226.4 60409.7 35108.1 36272.0 36272.5 36340.8 36367.0 15629.5 15807.4 15807.4 15831.6 15849.4 13299.5 13450.2 13458.3 13475.3 13496.0 7448.9 7592.0 7780.3 7947.0 8025.7 2966.6 3265.7 3326.7 3375.4 3379.8 869.9 932.7 1088.4 1091.8 1160.3 29554.9 30237.1 30417.1 30644.0 31003.7 1044.5 1050.8 1077.3 1155.7 1209.3 15560.5 15911.4 15984.9 16344.9 16361.8 699596.0 707465.0 711574.0 712170.0 714095.0 51819.5 51862.5 58724.7 58762.0 59005.4 1400.3 1405.7 1444.4 1444.8 1447.1 29941.5 31361.5 31527.4 31987.4 32191.0 49926.8 50332.2 50382.7 50400.5 50484.5 604665.0 608026.0 608131.0 608274.0 609263.0 26614.6 26851.3 27247.6 27256.0 27281.9 47766.0 48159.3 48363.0 48879.8 49116.5 34149.1 38430.2 39827.4 40285.8 40949.0 35784.3 39073.6 39232.8 39514.6 40600.0 36503.5 38466.6 39541.2 39631.0 39726.0 33159.3 34201.5 34233.8 35040.6 35124.8 26052.2 26074.9 26192.5 26362.2 26708.0 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | [#2] jquery.html Cycles:180 Average:35098.44 Median:12893.82 stddev:102788.64 (797.2%) stddev-sans-first:103043.77 17:26:33 INFO - PROCESS | 1923 | Values: 295.6 384.4 386.1 401.3 415.2 19937.0 21171.9 22316.3 22335.6 22526.5 12123.3 12353.6 12355.5 12611.4 12643.3 5475.8 5771.1 5777.3 5787.6 5791.3 5567.7 5636.3 6244.3 6288.4 6319.9 6248.3 6251.3 6258.4 6261.6 6269.6 5640.6 5677.6 5688.1 5694.2 5710.5 5293.6 5517.1 5529.6 5535.6 5541.6 13904.9 13981.7 21970.6 22354.0 22751.5 2239.4 2298.6 2324.4 2373.6 2878.7 10403.5 10507.4 10614.3 11444.5 16607.7 1887.2 1958.8 1963.2 1976.1 2004.5 102687.0 127757.1 134256.0 137178.0 139430.3 11444.1 11734.4 11815.0 11825.8 11842.7 15453.2 15455.8 15478.7 15495.5 15514.7 8949.8 9052.8 9093.0 9094.3 9233.3 9109.4 9127.5 9130.7 9299.1 9301.2 4627.4 4629.4 4631.4 4695.8 4767.7 1666.3 1680.9 1942.6 1953.2 1980.9 671.3 873.9 947.2 974.8 980.2 19077.7 21448.9 21479.6 23298.7 23414.0 961.3 963.8 968.9 977.9 996.2 11550.9 11752.2 11942.9 11958.2 11980.9 605916.9 613115.0 619977.0 625038.0 626000.0 75877.2 83073.3 90765.0 133087.0 140125.0 990.2 997.4 1031.1 1033.8 1037.7 19512.5 19800.3 19959.3 20018.4 20059.6 52614.7 53237.7 55648.0 56147.3 56348.2 72236.3 73914.6 74640.3 74701.0 77046.2 6917.6 8504.6 8537.8 8777.1 8801.3 9515.9 12897.7 13495.1 13832.7 13956.3 11313.5 11411.4 11536.8 12079.8 12104.6 11305.0 11463.4 11692.9 11840.6 11889.4 11417.9 11665.0 11932.2 11958.6 12141.4 8447.9 8567.4 8673.4 8731.7 8737.6 9888.4 11450.4 11686.5 11749.0 11816.1 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | [#3] mootools.html Cycles:180 Average:5962.94 Median:5072.80 stddev:3357.87 (66.2%) stddev-sans-first:3350.96 17:26:33 INFO - PROCESS | 1923 | Values: 1557.3 1594.9 1786.8 1899.5 1930.0 8818.2 9380.2 9382.4 9387.0 9390.8 8258.6 8500.4 8519.3 8969.0 9137.4 2449.7 2487.5 2495.6 2499.7 2500.3 2425.2 2455.0 2466.3 2481.9 2486.3 2433.9 2464.6 2464.8 2473.5 2486.5 2426.8 2444.3 2453.3 2453.4 2453.9 2428.5 2436.9 2438.9 2439.6 2441.1 9126.3 9333.3 9336.2 9339.6 9347.0 5523.2 5678.7 5695.0 5697.0 5702.1 3528.2 3615.8 3740.9 3742.9 3744.9 1106.6 1125.3 1844.7 1894.8 1928.4 12071.6 12423.3 12435.9 12464.5 12579.4 4742.4 4746.4 4794.4 4855.5 4883.5 9675.8 9676.8 9681.5 9684.0 9686.9 5535.4 5542.3 5549.5 5551.0 5560.5 5020.5 5186.4 5213.4 5226.6 5242.3 3806.7 3828.4 3841.9 3882.4 3911.5 1176.6 1182.6 1188.4 1197.9 1203.9 786.1 876.9 907.9 919.3 930.3 5881.9 6012.1 6086.9 6132.5 6413.0 906.0 929.5 940.5 957.7 971.5 3746.3 4007.2 4044.2 4049.9 4104.2 10912.3 11354.6 11355.3 11374.5 11376.5 10849.3 11267.3 11271.5 11285.8 11536.8 8548.3 8759.6 8760.7 8775.1 8782.0 4969.6 5528.3 5923.5 5941.6 6322.4 9834.5 10320.5 10655.0 10713.3 10718.9 10973.4 10976.4 10979.8 10991.0 10994.8 7208.2 7444.3 7460.0 7518.2 7752.4 8559.6 8816.7 8866.0 8973.4 8979.3 7905.9 7915.8 7951.8 7980.0 8005.1 7657.6 7670.3 7751.3 7864.7 7878.9 7091.7 7281.9 7306.6 7358.2 7379.4 4841.7 4911.4 4999.1 5110.5 5233.3 5041.2 5047.1 5098.5 5198.5 5313.7 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | [#4] prototype.html Cycles:180 Average:4692.00 Median:5218.02 stddev:1435.59 (27.5%) stddev-sans-first:1401.46 17:26:33 INFO - PROCESS | 1923 | Values: 311.4 312.8 318.0 326.8 328.4 4712.9 4971.2 5443.2 5454.2 5459.9 4439.1 5209.4 5216.3 5325.8 5399.2 4119.3 4142.1 4197.0 4204.3 4212.9 3930.4 4168.7 4187.2 4192.0 4215.6 3619.9 4007.5 4123.6 4175.4 4187.0 3838.0 3990.9 4142.3 4155.8 4155.9 3043.4 3463.0 3639.2 3641.9 3673.5 5057.4 5275.3 5300.9 5332.6 5341.7 4582.0 4898.9 4925.7 4948.8 4967.9 5154.4 5158.3 5816.6 5879.1 5902.9 3870.2 4047.6 4149.7 4155.0 4167.2 4813.6 5836.5 5935.8 6130.8 6208.1 3822.9 4075.0 4192.5 4210.7 4222.5 4098.4 4259.2 4288.7 4308.7 4308.9 3931.0 4230.2 4480.8 4569.5 4731.7 4730.6 5854.0 5869.3 5878.4 5961.6 1197.0 1283.9 1324.9 1425.8 1428.1 858.3 882.0 925.9 962.8 977.4 5163.1 5174.8 5219.8 5496.0 5506.0 5356.5 5642.6 5894.9 5956.9 6033.0 5231.9 5592.1 5605.5 5606.2 5629.9 2842.2 2860.5 2871.8 2955.9 3152.7 5901.6 6185.7 6188.8 6235.8 6254.7 5084.0 6164.0 6182.7 6188.6 6216.2 5141.6 5405.8 5425.8 5722.3 6141.3 5039.8 5484.8 5570.7 5948.6 5958.8 5683.4 5838.3 5869.9 5929.8 5989.7 5451.3 6148.0 6148.2 6210.8 6311.3 3932.4 3980.0 3980.0 3980.1 3987.4 5638.6 5971.9 5972.8 6004.8 6061.5 5004.7 5503.8 5662.9 5768.8 5825.5 5209.7 5740.6 5775.0 5776.7 5778.6 5287.3 5406.8 5611.0 5664.0 5716.0 4805.1 4993.7 5698.6 5781.4 5803.6 4849.0 4931.9 5463.6 5665.5 5709.6 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - PROCESS | 1923 | [#5] yui.html Cycles:180 Average:24700.27 Median:3602.95 stddev:39629.27 (1099.9%) stddev-sans-first:39699.27 17:26:33 INFO - PROCESS | 1923 | Values: 640.9 731.3 734.3 815.8 820.5 15480.8 16576.0 16578.3 16588.3 16590.0 14928.9 14978.4 15000.5 15058.7 15115.0 719.9 740.9 747.4 860.3 903.7 894.8 908.8 911.9 912.9 913.2 964.4 966.0 966.8 967.9 973.4 954.5 955.0 957.1 957.6 958.0 715.7 716.9 717.0 718.1 720.8 15017.6 15032.0 15045.5 15051.5 15054.5 13296.7 14729.3 14801.9 14821.9 14919.0 13064.6 13268.1 13452.1 13469.3 13538.3 3969.0 4564.8 4658.5 4729.0 4842.4 114741.0 117941.0 118320.4 119673.2 120066.6 10543.7 11050.3 11053.8 11076.7 11297.8 21326.6 21348.0 21421.4 21449.6 21472.9 6768.6 7936.2 7964.4 7970.1 8146.1 4458.9 4460.7 4538.0 4538.2 4628.9 3472.8 3591.2 3602.7 3603.2 3603.8 628.4 661.6 669.8 674.2 679.5 577.4 577.4 626.5 639.7 650.5 7956.6 8741.1 9050.9 9082.8 9147.1 612.1 621.1 629.4 652.1 658.9 4198.5 4341.4 4383.0 4385.1 4423.4 99926.5 122668.0 166237.0 167406.0 171862.0 130951.0 133582.3 135573.0 136965.3 137253.0 99735.0 102009.0 106942.4 107410.0 109901.5 8363.3 8387.9 8428.5 8445.0 8581.5 49557.8 61082.0 65396.3 66639.3 68060.7 61851.4 65573.3 69025.0 88995.0 90164.1 11499.0 13121.3 13590.7 13658.5 14169.1 12278.8 13889.2 14591.9 15195.5 15715.1 13313.6 13917.4 14466.1 14585.2 14779.0 13549.1 13811.8 14202.7 14294.0 14888.6 13204.8 13325.7 13554.6 13604.8 13766.7 10720.3 11435.0 11439.8 11746.9 11931.5 11462.9 11468.9 11513.5 11650.0 11711.6 17:26:33 INFO - PROCESS | 1923 | -------- Summary: end -------- 17:26:33 INFO - PROCESS | 1923 | 17:26:33 INFO - TEST-INFO | 1923: exit 0 17:26:33 INFO - TEST-OK | dromaeo_css | took 1115060ms 17:26:33 INFO - TEST-START | kraken 17:26:33 INFO - operating with platform_type : mac_ 17:26:33 INFO - Initialising browser for kraken test... 17:26:33 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpCAKadb/profile http://localhost:51985/getInfo.html) 17:26:36 INFO - PROCESS | 1926 | __metrics Screen width/height:1600/1200 17:26:36 INFO - PROCESS | 1926 | colorDepth:24 17:26:36 INFO - PROCESS | 1926 | Browser inner width/height: 1024/689 17:26:36 INFO - PROCESS | 1926 | __metrics 17:26:36 INFO - PROCESS | 1926 | 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" 17:26:36 INFO - PROCESS | 1926 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:36 INFO - TEST-INFO | 1926: exit 0 17:26:36 INFO - Browser initialized. 17:26:36 INFO - Running cycle 1/1 for kraken test... 17:26:36 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpCAKadb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:48 INFO - PROCESS | 1928 | RSS: Main: 169156608 17:26:48 INFO - PROCESS | 1928 | 17:26:51 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51985/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:52 INFO - PROCESS | 1928 | RSS: Main: 219774976 17:26:52 INFO - PROCESS | 1928 | 17:26:55 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51985/tests/kraken/driver.html?testName=audio-dft) 17:26:55 INFO - PROCESS | 1928 | RSS: Main: 233844736 17:26:55 INFO - PROCESS | 1928 | 17:26:58 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51985/tests/kraken/driver.html?testName=audio-fft) 17:26:59 INFO - PROCESS | 1928 | RSS: Main: 329207808 17:26:59 INFO - PROCESS | 1928 | 17:27:01 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51985/tests/kraken/driver.html?testName=audio-oscillator) 17:27:02 INFO - PROCESS | 1928 | RSS: Main: 229076992 17:27:02 INFO - PROCESS | 1928 | 17:27:03 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51985/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:27:04 INFO - PROCESS | 1928 | RSS: Main: 230109184 17:27:04 INFO - PROCESS | 1928 | 17:27:07 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51985/tests/kraken/driver.html?testName=imaging-darkroom) 17:27:07 INFO - PROCESS | 1928 | RSS: Main: 266420224 17:27:07 INFO - PROCESS | 1928 | 17:27:10 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51985/tests/kraken/driver.html?testName=imaging-desaturate) 17:27:11 INFO - PROCESS | 1928 | RSS: Main: 268869632 17:27:11 INFO - PROCESS | 1928 | 17:27:13 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51985/tests/kraken/driver.html?testName=json-parse-financial) 17:27:14 INFO - PROCESS | 1928 | RSS: Main: 267059200 17:27:14 INFO - PROCESS | 1928 | 17:27:16 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51985/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:27:16 INFO - PROCESS | 1928 | RSS: Main: 240361472 17:27:16 INFO - PROCESS | 1928 | 17:27:18 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:27:19 INFO - PROCESS | 1928 | RSS: Main: 245051392 17:27:19 INFO - PROCESS | 1928 | 17:27:21 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:27:21 INFO - PROCESS | 1928 | RSS: Main: 253157376 17:27:21 INFO - PROCESS | 1928 | 17:27:24 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:27:25 INFO - PROCESS | 1928 | RSS: Main: 266674176 17:27:25 INFO - PROCESS | 1928 | 17:27:28 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:27:28 INFO - PROCESS | 1928 | RSS: Main: 261070848 17:27:28 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:51985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51985/tests/kraken/driver.html?testName=ai-astar) 17:27:30 INFO - PROCESS | 1928 | RSS: Main: 305172480 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | __start_tp_report 17:27:30 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 17:27:30 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 17:27:30 INFO - PROCESS | 1928 | |i|pagename|runs| 17:27:30 INFO - PROCESS | 1928 | |0;ai-astar;114;113;113;113;113;112;113;114;115;164 17:27:30 INFO - PROCESS | 1928 | |1;audio-beat-detection;146;107;109;142;109;109;115;89;157;138 17:27:30 INFO - PROCESS | 1928 | |2;audio-dft;186;183;183;184;180;182;181;181;182;184 17:27:30 INFO - PROCESS | 1928 | |3;audio-fft;80;58;59;87;60;74;83;69;81;58 17:27:30 INFO - PROCESS | 1928 | |4;audio-oscillator;88;71;92;70;68;69;92;68;69;89 17:27:30 INFO - PROCESS | 1928 | |5;imaging-gaussian-blur;89;87;87;84;86;84;86;83;86;83 17:27:30 INFO - PROCESS | 1928 | |6;imaging-darkroom;91;92;92;100;97;91;92;91;92;92 17:27:30 INFO - PROCESS | 1928 | |7;imaging-desaturate;82;84;84;83;84;90;84;86;85;83 17:27:30 INFO - PROCESS | 1928 | |8;json-parse-financial;56;55;50;52;55;56;56;56;57;57 17:27:30 INFO - PROCESS | 1928 | |9;json-stringify-tinderbox;64;75;79;71;71;69;68;68;70;70 17:27:30 INFO - PROCESS | 1928 | |10;stanford-crypto-aes;84;83;82;83;82;81;90;98;87;89 17:27:30 INFO - PROCESS | 1928 | |11;stanford-crypto-ccm;139;137;145;147;135;134;138;140;192;147 17:27:30 INFO - PROCESS | 1928 | |12;stanford-crypto-pbkdf2;163;162;162;164;160;161;162;159;160;216 17:27:30 INFO - PROCESS | 1928 | |13;stanford-crypto-sha256-iterative;66;67;66;66;66;65;64;63;66;65 17:27:30 INFO - PROCESS | 1928 | __end_tp_report 17:27:30 INFO - PROCESS | 1928 | __start_cc_report 17:27:30 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,1857 17:27:30 INFO - PROCESS | 1928 | __end_cc_report 17:27:30 INFO - PROCESS | 1928 | __startTimestamp1483666050804__endTimestamp 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | ------- Summary: start ------- 17:27:30 INFO - PROCESS | 1928 | Number of tests: 14 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#0] ai-astar Cycles:10 Average:118.40 Median:113.50 stddev:16.04 (14.1%) stddev-sans-first:16.94 17:27:30 INFO - PROCESS | 1928 | Values: 114.0 113.0 113.0 113.0 113.0 112.0 113.0 114.0 115.0 164.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:140.00 stddev:21.93 (15.7%) stddev-sans-first:21.48 17:27:30 INFO - PROCESS | 1928 | Values: 146.0 107.0 109.0 142.0 109.0 109.0 115.0 89.0 157.0 138.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.78 (1.0%) stddev-sans-first:1.39 17:27:30 INFO - PROCESS | 1928 | Values: 186.0 183.0 183.0 184.0 180.0 182.0 181.0 181.0 182.0 184.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#3] audio-fft Cycles:10 Average:70.90 Median:77.00 stddev:11.53 (15.0%) stddev-sans-first:11.75 17:27:30 INFO - PROCESS | 1928 | Values: 80.0 58.0 59.0 87.0 60.0 74.0 83.0 69.0 81.0 58.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.50 stddev:10.99 (13.8%) stddev-sans-first:10.99 17:27:30 INFO - PROCESS | 1928 | Values: 88.0 71.0 92.0 70.0 68.0 69.0 92.0 68.0 69.0 89.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.00 stddev:1.96 (2.3%) stddev-sans-first:1.62 17:27:30 INFO - PROCESS | 1928 | Values: 89.0 87.0 87.0 84.0 86.0 84.0 86.0 83.0 86.0 83.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:92.00 stddev:3.02 (3.3%) stddev-sans-first:3.11 17:27:30 INFO - PROCESS | 1928 | Values: 91.0 92.0 92.0 100.0 97.0 91.0 92.0 91.0 92.0 92.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.00 stddev:2.22 (2.6%) stddev-sans-first:2.17 17:27:30 INFO - PROCESS | 1928 | Values: 82.0 84.0 84.0 83.0 84.0 90.0 84.0 86.0 85.0 83.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:2.26 (4.0%) stddev-sans-first:2.37 17:27:30 INFO - PROCESS | 1928 | Values: 56.0 55.0 50.0 52.0 55.0 56.0 56.0 56.0 57.0 57.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.50 stddev:4.09 (5.8%) stddev-sans-first:3.60 17:27:30 INFO - PROCESS | 1928 | Values: 64.0 75.0 79.0 71.0 71.0 69.0 68.0 68.0 70.0 70.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:5.26 (6.2%) stddev-sans-first:5.53 17:27:30 INFO - PROCESS | 1928 | Values: 84.0 83.0 82.0 83.0 82.0 81.0 90.0 98.0 87.0 89.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:142.50 stddev:17.03 (12.0%) stddev-sans-first:17.91 17:27:30 INFO - PROCESS | 1928 | Values: 139.0 137.0 145.0 147.0 135.0 134.0 138.0 140.0 192.0 147.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:162.00 stddev:17.32 (10.7%) stddev-sans-first:18.31 17:27:30 INFO - PROCESS | 1928 | Values: 163.0 162.0 162.0 164.0 160.0 161.0 162.0 159.0 160.0 216.0 17:27:30 INFO - PROCESS | 1928 | 17:27:30 INFO - PROCESS | 1928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.22 17:27:30 INFO - PROCESS | 1928 | Values: 66.0 67.0 66.0 66.0 66.0 65.0 64.0 63.0 66.0 65.0 17:27:30 INFO - PROCESS | 1928 | -------- Summary: end -------- 17:27:30 INFO - PROCESS | 1928 | 17:27:31 INFO - TEST-INFO | 1928: exit 0 17:27:31 INFO - TEST-OK | kraken | took 57839ms 17:27:31 INFO - SUITE-END | took 1172s 17:27:31 INFO - Completed test suite (00:19:33) 17:27:31 INFO - javascript benchmark 17:27:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3438.346714124317, 3442.6385229550897, 3475.669811367919, 3479.8608055677773, 3525.312564050011, 4837.540433658801, 5792.304923409186, 5889.676067816279, 5910.113482977556, 5960.82117536474, 5861.062230043194, 5946.702664866761, 5954.13665018572, 5961.552883533731, 5972.850678733033, 5262.105442074847, 5286.735663216843, 5362.249285100089, 5363.9463605363835, 5368.1679339702405, 5240.240165176047, 5269.156934890419, 5410.134378499441, 5412.91880621791, 5418.972905135469, 5334.839954801362, 5369.167778994242, 5377.435369286227, 5385.192221166837, 5396.865078373053, 5256.842294731164, 5314.62797604164, 5332.440093790155, 5332.68003919766, 5346.786128554853, 5232.607554433433, 5251.842444726664, 5269.262303277545, 5337.332833395825, 5386.3536375634785, 5740.052891272935, 5972.850678733023, 6031.849203769897, 6039.214902062704, 6056.878862422727, 6134.00801433197, 6138.24286178211, 6141.7543298268465, 6160.599561028519, 6171.537134714869, 6241.594296370721, 6286.308506064329, 6316.873662526769, 6373.203349581302, 6375.266844312917, 6077.4226448487325, 6078.908816367758, 6083.057126145454, 6088.939110608926, 6096.786612468542, 6252.968735156386, 6295.464885484785, 6325.240971083499, 6363.236411630634, 6391.42477177047, 6161.168242287234, 6166.81499555014, 6177.166082578794, 6180.196574445294, 6185.072239164161, 6280.089387038854, 6304.0, 6304.65324407162, 6307.4954003679595, 6311.274203466568, 6111.07520520229, 6144.109104179869, 6166.537509686791, 6168.537359698041, 6191.721372538246, 6111.191249546102, 6143.818944274807, 6152.077188421773, 6158.938410615926, 6238.500919926395, 5066.771995260222, 5092.567131793765, 5100.183970564692, 5102.08162530748, 5118.513741194655, 4568.908621827545, 4569.314602809605, 4569.337446070301, 4581.221192397301, 4608.976955115203, 5057.317262169634, 5910.911336329958, 5979.551533634908, 5985.551083668655, 6053.515718742578, 6366.331535188831, 6369.872602547923, 6375.011873159668, 6380.425761681471, 6392.520560957853, 6059.424354686298, 6065.96967015171, 6084.756609735561, 6089.786857459968, 6117.990531562331, 5423.945760542344, 5483.972580137074, 5496.780128794803, 5583.0, 5644.85887852807, 6398.968005160037, 6453.419192272718, 6473.255575608865, 6554.8361290968105, 6559.409653131051, 6319.115323854756, 6320.778772742932, 6320.841978950563, 6341.619502829845, 6345.555811093179, 6490.156279683611, 6498.967505162444, 6513.055606937062, 6548.345165483413, 6551.181102362205, 6107.446930123121, 6107.643995706967, 6155.0, 6160.353162918008, 6189.288231853395, 6342.651154186564, 6344.143540622142, 6346.397092276226, 6347.96826015867, 6367.554271200971, 6068.302145253352, 6079.483243924316, 6117.510599151969, 6158.507319414526, 6172.722227499684, 5117.641765076409, 6106.82471942484, 6109.222480666452, 6152.16945712341, 6163.7842675506145, 6161.291451482957, 6175.62946223228, 6187.876242475215, 6198.1012753149635, 6204.255489341308, 5999.40005999414, 6154.0, 6166.660833654192, 6178.567500274938, 6180.227471566054, 6022.668753218615, 6089.695515224133, 6110.326162663493, 6124.8775024500155, 6174.567780255518], "value": 5814.557059553951, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.7934648427934, 486.2560282767365, 495.707532555792, 498.8377081400338, 536.7745546870314, 30562.54156187659, 32020.839895800516, 33182.502262466085, 33225.00324990248, 39527.60472395283, 39410.01474963127, 42300.788496057554, 42324.36513452293, 42335.78832105835, 42343.0, 10096.343737657047, 10161.898381016206, 10165.390076595391, 10172.847407288897, 10317.638882639108, 9305.720828375126, 9499.572519236617, 9527.475988820612, 10022.248331375176, 10145.797084058315, 9479.099485548863, 9540.236781057498, 12184.268943863352, 12435.502579896793, 12458.688532786662, 12422.440990155465, 12481.126321157522, 12508.687282817957, 12509.749805003848, 12549.498020079185, 12242.571509997108, 12334.259944403364, 12337.69155771104, 12348.753024939451, 12365.443555040045, 40297.395539066645, 40562.79718601418, 40595.0, 40694.38958415626, 40735.592644073775, 3397.1167496450853, 3458.706009989154, 3623.2391197848483, 3872.4384964180317, 3893.610638936084, 31541.52687709686, 31667.36665266705, 31836.36327273465, 31838.044858654277, 32426.0, 3410.931781364384, 3453.9654603453896, 3454.101933497284, 3465.6707612776745, 3475.7045651119683, 510706.44646776526, 520483.0, 521808.0, 521838.7816121828, 524054.0, 34133.82933085319, 59850.70074649599, 60208.0, 60226.397736022955, 60409.69795151084, 35108.12229694278, 36272.0, 36272.4559131608, 36340.81829590835, 36367.0, 15629.531114066596, 15807.36770529166, 15807.446739364066, 15831.575158235813, 15849.445269415746, 13299.468021279234, 13450.192988420726, 13458.327083645778, 13475.326233688473, 13496.0, 7448.85102297951, 7592.0, 7780.3386712130105, 7946.9602651987525, 8025.678972841138, 2966.5995090662914, 3265.706086452231, 3326.667333266654, 3375.3586818504405, 3379.814110223912, 869.9347548933855, 932.6922115701802, 1088.4176965323513, 1091.8089334366455, 1160.2864238493266, 29554.852225738734, 30237.092887213417, 30417.087487375415, 30644.0, 31003.689963100533, 1044.4725413666201, 1050.7688308572256, 1077.272840832435, 1155.6995181252935, 1209.3469526455792, 15560.533184004498, 15911.363545458284, 15984.920075399548, 16344.918275408785, 16361.83638163603, 699596.0, 707465.0, 711574.0, 712170.0, 714095.0, 51819.48180518222, 51862.48137518652, 58724.706376467846, 58762.0, 59005.40994589999, 1400.285854214358, 1405.7188562287379, 1444.400573761877, 1444.7832825076323, 1447.117258472331, 29941.47986510665, 31361.52957705682, 31527.369452611278, 31987.360252794348, 32191.03426897197, 49926.750366247936, 50332.24501632405, 50382.7404314895, 50400.49599503958, 50484.49515504798, 604665.0, 608026.0, 608130.9593452004, 608274.0, 609263.0, 26614.600780987912, 26851.328716781456, 27247.591286130326, 27256.046038388562, 27281.863590681918, 47766.0, 48159.277610836565, 48363.0, 48879.75560122177, 49116.50883491119, 34149.146271343416, 38430.231395372495, 39827.40258896177, 40285.798571006955, 40949.0, 35784.284314314085, 39073.609263907, 39232.80383598178, 39514.62912225276, 40600.0, 36503.45244821383, 38466.615333846305, 39541.2091758169, 39631.0, 39726.0, 33159.336813263115, 34201.486977694854, 34233.82883085569, 35040.64959350374, 35124.77063302772, 26052.218433447026, 26074.915391498474, 26192.476150477265, 26362.209133726017, 26708.0], "value": 19391.663326034966, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5994627280036, 384.44063887044337, 386.06572095528816, 401.2656837986485, 415.22974881594644, 19937.0, 21171.894140529315, 22316.330510084703, 22335.553288934232, 22526.54946901061, 12123.272603643787, 12353.62939111828, 12355.50577976882, 12611.43248553815, 12643.304618246017, 5475.808346707866, 5771.076627739562, 5777.335606405254, 5787.623804452697, 5791.305043394798, 5567.693776842272, 5636.323641163066, 6244.344343843899, 6288.371162883721, 6319.936800632004, 6248.250209974786, 6251.3123556408755, 6258.405451482102, 6261.624302541862, 6269.62382257066, 5640.605157638967, 5677.574181936371, 5688.061469857468, 5694.174344719992, 5710.543156547466, 5293.602979776532, 5517.062099443064, 5529.557635389159, 5535.612507124503, 5541.5843811714285, 13904.930475347659, 13981.720365592631, 21970.571912825617, 22354.0, 22751.54496910069, 2239.4065572623267, 2298.5747636687265, 2324.360800779799, 2373.6320870265135, 2878.7265209805037, 10403.53184106717, 10507.422091784949, 10614.257002009863, 11444.484998175101, 16607.674925510437, 1887.160213704902, 1958.7747409048, 1963.2147141143514, 1976.081122278133, 2004.5489764802803, 102687.0, 127757.08364374541, 134256.0, 137178.0, 139430.3028484861, 11444.14168937333, 11734.413279335999, 11815.0, 11825.763484730429, 11842.730440291525, 15453.227338633023, 15455.845441545665, 15478.690426191413, 15495.457658982106, 15514.689706205812, 8949.821003579891, 9052.81894362109, 9093.0, 9094.27245820346, 9233.261339092856, 9109.362344635812, 9127.543622818832, 9130.726078217664, 9299.070092990647, 9301.209397201314, 4627.421572303462, 4629.421322334708, 4631.444226692751, 4695.81216751333, 4767.69010014348, 1666.31681010785, 1680.899146051241, 1942.5823447958758, 1953.2089503751004, 1980.8613397062068, 671.2649648634737, 873.8732883731823, 947.2374738335568, 974.780674348266, 980.2011360740973, 19077.713834292495, 21448.892755536122, 21479.570408591742, 23298.65052024221, 23414.0, 961.2694352292308, 963.816874793787, 968.8595153702673, 977.9217662587118, 996.2030375699411, 11550.88449115498, 11752.23610465317, 11942.940285298519, 11958.222715523463, 11980.940095299467, 605916.9408305949, 613115.0, 619977.0, 625038.0, 626000.0, 75877.24122758812, 83073.33853322899, 90765.0, 133087.0, 140125.0, 990.1830989433746, 997.4464172384252, 1031.1493018259966, 1033.8190816607064, 1037.6523864505325, 19512.512187195432, 19800.306989255307, 19959.301424450074, 20018.399448016582, 20059.59880802405, 52614.736926316655, 53237.7338113307, 55648.0, 56147.315580532646, 56348.15477767755, 72236.27763722505, 73914.63042684752, 74640.25359746334, 74701.0, 77046.2215333841, 6917.619530925847, 8504.574771261536, 8537.786555335917, 8777.078406767198, 8801.295896328407, 9515.857262140935, 12897.742045158857, 13495.055346125677, 13832.654183645489, 13956.302184890512, 11313.547458101584, 11411.372374519482, 11536.82694759596, 12079.75840483203, 12104.636860894187, 11305.039071678999, 11463.369514676773, 11692.88307116952, 11840.585579504675, 11889.405529723652, 11417.885821141683, 11665.0, 11932.22440541362, 11958.58144964922, 12141.39293035327, 8447.91552084496, 8567.4002819802, 8673.436226645501, 8731.69439069655, 8737.606807693543, 9888.357256778287, 11450.37022963745, 11686.474108664961, 11749.004003978931, 11816.113791465503], "value": 9614.93160601713, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.3459147158196, 1594.92822822973, 1786.8123846996066, 1899.5441094137411, 1929.9903500482496, 8818.20636142747, 9380.249580033598, 9382.390144640594, 9386.953065234673, 9390.765230869232, 8258.628361723722, 8500.447470914387, 8519.318454523638, 8969.013408525074, 9137.406068605536, 2449.7182823975204, 2487.5273697997413, 2495.5508008558454, 2499.700035995674, 2500.349909023658, 2425.2360506440414, 2455.0302630460956, 2466.2724496273554, 2481.900723971039, 2486.29140694902, 2433.914812981546, 2464.6056630938965, 2464.8028157747335, 2473.530029294437, 2486.4529803443215, 2426.8179886508583, 2444.2667199840066, 2453.325335532725, 2453.386653336666, 2453.852768833876, 2428.5021570577987, 2436.878156092206, 2438.9390265243333, 2439.5852705040184, 2441.0967941861445, 9126.26989840811, 9333.346665733401, 9336.159745622926, 9339.579718912666, 9346.953265233698, 5523.199136125279, 5678.659280443146, 5695.03184458643, 5697.03150464422, 5702.059160238556, 3528.153243221634, 3615.8192090395637, 3740.8503659853573, 3742.850285988557, 3744.8876533704033, 1106.634810512529, 1125.2629527659396, 1844.6771814932467, 1894.8199921007483, 1928.3829174664113, 12071.577494787729, 12423.254604723656, 12435.875641243652, 12464.501419943192, 12579.433925473375, 4742.383490146328, 4746.406699162605, 4794.381861551547, 4855.5387238212315, 4883.4628190898975, 9675.758106047406, 9676.806463870684, 9681.467519286365, 9684.0, 9686.903130968742, 5535.446455354513, 5542.251796007568, 5549.500544950974, 5551.0, 5560.499555040065, 5020.49795020495, 5186.4035635902355, 5213.374395072616, 5226.634135610547, 5242.292290540729, 3806.71449641278, 3828.368319227352, 3841.9039524011564, 3882.417637354363, 3911.530616326059, 1176.564671071709, 1182.5742732616252, 1188.3701638131804, 1197.868234494205, 1203.8856308650838, 786.1470304719444, 876.9166929141721, 907.8955920069144, 919.2829592917535, 930.292977337215, 5881.911771323434, 6012.068129439944, 6086.9391306087255, 6132.50939924805, 6413.0059840723825, 906.0, 929.4609126706493, 940.4968341937031, 957.7461972577272, 971.504532688334, 3746.269477451871, 4007.1785284016705, 4044.2315959967514, 4049.8582549610624, 4104.19808823677, 10912.345259284468, 11354.602588909349, 11355.26190797612, 11374.488148033359, 11376.488058037408, 10849.294795838245, 11267.26762760418, 11271.549138034386, 11285.830712539318, 11536.76926461466, 8548.27339676122, 8759.605817738217, 8760.693375731818, 8775.078616745277, 8782.0, 4969.552740253394, 5528.281323427928, 5923.49650279731, 5941.643501389931, 6322.430981211713, 9834.459104749307, 10320.48397580133, 10655.0, 10713.250072494851, 10718.928107189218, 10973.396463194282, 10976.396298203676, 10979.780404392028, 10991.0, 10994.780104398027, 7208.207097219197, 7444.255574442513, 7460.0, 7518.210587888193, 7752.3798096153305, 8559.57202139878, 8816.691415800417, 8866.0, 8973.416727912665, 8979.281657467256, 7905.881411778943, 7915.802104947423, 7951.761447156595, 7979.9601001994615, 8005.119436862057, 7657.578833164007, 7670.309672129535, 7751.341136003277, 7864.72473463426, 7878.921210787818, 7091.680874360563, 7281.927180728125, 7306.634668266672, 7358.227386124594, 7379.409647228102, 4841.733704646278, 4911.361523001987, 4999.0501804657, 5110.514501122388, 5233.319668443078, 5041.193409054534, 5047.091523525801, 5098.515641014098, 5198.532132108128, 5313.707746074003], "value": 4799.752249503682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.40055393367766, 312.82638135834605, 317.9729722973547, 326.7630967548526, 328.371169210961, 4712.905741885164, 4971.2046072628345, 5443.1835224716315, 5454.209139674755, 5459.945400545993, 4439.089986552757, 5209.400918894328, 5216.26972223889, 5325.7869685212645, 5399.244105825188, 4119.2997190477545, 4142.109446469001, 4197.027397123347, 4204.285271503852, 4212.915741685165, 3930.430087637291, 4168.729032612886, 4187.246295666779, 4191.979040104795, 4215.641670458015, 3619.94570081449, 4007.5391329997133, 4123.567025462313, 4175.373693945902, 4187.0, 3837.9637497875697, 3990.8603198888045, 4142.2543942090415, 4155.833766649331, 4155.877912963483, 3043.3522835133576, 3463.0, 3639.2175682228185, 3641.9453708194396, 3673.522442082512, 5057.393112826484, 5275.314209152824, 5300.92048619271, 5332.626716129873, 5341.65279256847, 4582.0, 4898.877528061791, 4925.655204135712, 4948.802047918079, 4967.850964471036, 5154.38147422308, 5158.297761738617, 5816.574939139896, 5879.118132280149, 5902.911456328158, 3870.181014922982, 4047.615476529725, 4149.7095203335775, 4154.979225103855, 4167.249895018896, 4813.614910807127, 5836.474717275466, 5935.812837432531, 6130.846728831771, 6208.099825525319, 3822.9235415291537, 4074.9608849743126, 4192.538820729717, 4210.663146948237, 4222.514410842792, 4098.426220329156, 4259.190753756776, 4288.699791014599, 4308.74147551148, 4308.944308644403, 3931.0, 4230.238557059759, 4480.76778885809, 4569.520200378913, 4731.69243999139, 4730.645201609893, 5853.975554277984, 5869.266341707286, 5878.353381128072, 5961.642301461926, 1196.9880301197052, 1283.9037072219621, 1324.8675132486674, 1425.7880801319004, 1428.0788891165348, 858.2533196119416, 881.9867701984475, 925.9490728010024, 962.7881865989472, 977.4282045003611, 5163.14808056674, 5174.793008279702, 5219.765110570033, 5495.972520137374, 5506.0, 5356.491133342326, 5642.633228840113, 5894.941050589525, 5956.85107872298, 6033.0, 5231.869203269873, 5592.077307244259, 5605.477535109136, 5606.159076138611, 5629.933060245811, 2842.1899758568707, 2860.5137126688514, 2871.7559007484597, 2955.896543620963, 3152.7004934531183, 5901.58688891782, 6185.721642526007, 6188.81433556985, 6235.781747638811, 6254.718537665816, 5083.974580127149, 6163.982942814475, 6182.723156726942, 6188.60608967629, 6216.222972128484, 5141.640085194001, 5405.810796622178, 5425.755840987165, 5722.341930677942, 6141.324454310023, 5039.840836607674, 5484.7933454639915, 5570.749316280858, 5948.553858460719, 5958.76164953397, 5683.374828768915, 5838.299404071538, 5869.882602348014, 5929.792457263975, 5989.670568118621, 5451.318585176853, 6147.969260153671, 6148.200733904564, 6210.782622608187, 6311.274203466476, 3932.3708206686792, 3979.960200397959, 3979.960200397959, 3980.109448012287, 3987.4218238354697, 5638.633488823213, 5971.910421343597, 5972.761089556543, 6004.789832355847, 6061.484773794277, 5004.721907150822, 5503.77141715364, 5662.915056274242, 5768.826935191951, 5825.475707186373, 5209.707728599404, 5740.598158128891, 5775.0, 5776.7111644418455, 5778.566607504538, 5287.312649355713, 5406.78372865081, 5611.0, 5663.9716801415725, 5716.0, 4805.063012712488, 4993.675411098267, 5698.572607054571, 5781.364049954585, 5803.564732644984, 4848.95151048485, 4931.876703082452, 5463.644863083887, 5665.49010589049, 5709.572606848288], "value": 4232.495155061048, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.903864420337, 731.2504682700231, 734.3134169551469, 815.8286759780445, 820.4543978254461, 15480.767788483181, 16576.0, 16578.253978570963, 16588.336466541354, 16590.0, 14928.925355373209, 14978.400863965455, 15000.474983375583, 15058.698826023472, 15114.999999999973, 719.8560287942406, 740.914794798597, 747.4468893019153, 860.2988564320091, 903.6746771162409, 894.8165626046678, 908.8318661047695, 911.8768966189546, 912.8630705394178, 913.1507697841005, 964.3779762053472, 966.0, 966.830804609194, 967.8644989701447, 973.4159504297436, 954.4654993203828, 954.9952250238774, 957.1146689312428, 957.6121670723368, 957.9941061884992, 715.6564848872571, 716.9390601798854, 716.9784906452815, 718.0736849464184, 720.783764870542, 15017.624559385993, 15032.022918510262, 15045.548633541011, 15051.473198438001, 15054.473093441677, 13296.73406531864, 14729.337179826933, 14801.851981480155, 14821.92589037048, 14919.0, 13064.608061758163, 13268.071235013553, 13452.1256118352, 13469.326533673277, 13538.323083845868, 3968.9801550992347, 4564.771761411949, 4658.487566367697, 4729.0, 4842.4189097308545, 114741.0, 117941.0, 118320.40839795832, 119673.20490192741, 120066.59866802616, 10543.736406589744, 11050.33697978124, 11053.834192487118, 11076.667699969013, 11297.774044519063, 21326.573468530543, 21348.039338229817, 21421.357359279245, 21449.57100857974, 21472.892635536722, 6768.560043597249, 7936.16670249627, 7964.362850971908, 7970.123286438487, 8146.063202731643, 4458.866234012985, 4460.7323560586465, 4537.954620453819, 4538.228501154812, 4628.907421851544, 3472.8089955052715, 3591.245838373971, 3602.693771029492, 3603.207294395229, 3603.8017909015257, 628.3998781163978, 661.6427129350193, 669.825845280221, 674.2010717300016, 679.49038221334, 577.3908526504495, 577.3995045153077, 626.4612433307352, 639.6993413095837, 650.54786923088, 7956.562389068541, 8741.125887411208, 9050.86423703645, 9082.772930676654, 9147.131022552847, 612.1138830414528, 621.0559948877681, 629.4397985792648, 652.1424327009967, 658.8996376052005, 4198.4961804583645, 4341.37050127736, 4382.956170438255, 4385.122975404932, 4423.388555485619, 99926.50110248353, 122668.0, 166237.0, 167406.0, 171862.0, 130951.0, 133582.33208833894, 135573.0, 136965.3151734235, 137253.0, 99735.0, 102009.0, 106942.3958640621, 107410.0, 109901.45049274703, 8363.25911738903, 8387.916120838714, 8428.45215061019, 8445.0, 8581.528015958933, 49557.752211238716, 61082.0, 65396.34603654093, 66639.3336066633, 68060.6596967012, 61851.38148618456, 65573.34426655673, 69025.0, 88995.0, 90164.0983590182, 11499.0, 13121.343932803513, 13590.660233494242, 13658.521951731642, 14169.079009864327, 12278.75442491163, 13889.166650001032, 14591.92704036473, 15195.468158614396, 15715.135667537937, 13313.600591982256, 13917.373718182504, 14466.132032078109, 14585.197814119902, 14779.0, 13549.119307244997, 13811.79282310746, 14202.715945680822, 14293.999420040913, 14888.62778430548, 13204.801927970895, 13325.666858328232, 13554.59336219915, 13604.795928060888, 13766.724665506834, 10720.303180293256, 11435.0, 11439.828402574134, 11746.941265293619, 11931.463084161407, 11462.94268528652, 11468.885311146782, 11513.481893314653, 11650.0, 11711.648650540497], "value": 7919.761020031457, "unit": "score"}], "name": "dromaeo_css", "value": 7474.941643932593, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 114.0, 115.0, 164.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 107.0, 109.0, 142.0, 109.0, 109.0, 115.0, 89.0, 157.0, 138.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 183.0, 184.0, 180.0, 182.0, 181.0, 181.0, 182.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 87.0, 60.0, 74.0, 83.0, 69.0, 81.0, 58.0], "value": 70.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 92.0, 70.0, 68.0, 69.0, 92.0, 68.0, 69.0, 89.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 84.0, 86.0, 84.0, 86.0, 83.0, 86.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 100.0, 97.0, 91.0, 92.0, 91.0, 92.0, 92.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 83.0, 84.0, 90.0, 84.0, 86.0, 85.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 50.0, 52.0, 55.0, 56.0, 56.0, 56.0, 57.0, 57.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 79.0, 71.0, 71.0, 69.0, 68.0, 68.0, 70.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 83.0, 82.0, 81.0, 90.0, 98.0, 87.0, 89.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 145.0, 147.0, 135.0, 134.0, 138.0, 140.0, 192.0, 147.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 160.0, 161.0, 162.0, 159.0, 160.0, 216.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 64.0, 63.0, 66.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1423.7000000000003, "alertThreshold": 2.0}]} 17:27:32 INFO - Return code: 0 17:27:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:27:32 INFO - # TBPL SUCCESS # 17:27:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:27:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:27:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:27:32 INFO - 2017-01-05 17:27:32.115 screenresolution[1932:15900] starting screenresolution argv=screenresolution get 17:27:32 INFO - 2017-01-05 17:27:32.117 screenresolution[1932:15900] Display 0: 1600x1200x32@50 17:27:32 INFO - 2017-01-05 17:27:32.123 screenresolution[1933:15903] starting screenresolution argv=screenresolution list 17:27:32 INFO - Available Modes on Display 0 17:27:32 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 17:27:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:27:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:27:32 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 17:27:32 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 17:27:32 INFO - Graphics/Displays: 17:27:32 INFO - Intel Iris: 17:27:32 INFO - Chipset Model: Intel Iris 17:27:32 INFO - Type: GPU 17:27:32 INFO - Bus: Built-In 17:27:32 INFO - VRAM (Dynamic, Max): 1536 MB 17:27:32 INFO - Vendor: Intel (0x8086) 17:27:32 INFO - Device ID: 0x0a2e 17:27:32 INFO - Revision ID: 0x0009 17:27:32 INFO - Displays: 17:27:32 INFO - Display: 17:27:32 INFO - Resolution: 1600 x 1200 @ 50 Hz 17:27:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:27:32 INFO - Display Serial Number: 1600x1200 50 17:27:32 INFO - Main Display: Yes 17:27:32 INFO - Mirror: Off 17:27:32 INFO - Online: Yes 17:27:32 INFO - Rotation: Supported 17:27:32 INFO - Return code: 0 17:27:32 INFO - Running post-action listener: _resource_record_post_action 17:27:32 INFO - [mozharness: 2017-01-06 01:27:32.362886Z] Finished run-tests step (success) 17:27:32 INFO - Running post-run listener: _resource_record_post_run 17:27:32 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 815104; Write bytes: 495600640; Read time: 10; Write time: 1907 17:27:32 INFO - TinderboxPrint: CPU usage
53.2% 17:27:32 INFO - TinderboxPrint: I/O read bytes / time
815,104 / 10 17:27:32 INFO - TinderboxPrint: I/O write bytes / time
495,600,640 / 1,907 17:27:32 INFO - TinderboxPrint: CPU idle
2,236.5 (46.8%) 17:27:32 INFO - TinderboxPrint: CPU system
952.5 (19.9%) 17:27:32 INFO - TinderboxPrint: CPU user
1,592.6 (33.3%) 17:27:32 INFO - TinderboxPrint: Swap in / out
195,538,944 / 0 17:27:32 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186253824; Write bytes: 188212736; Read time: 16710; Write time: 418 17:27:32 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 815104; Write bytes: 297262592; Read time: 10; Write time: 1454 17:27:32 INFO - Running post-run listener: _upload_blobber_files 17:27:32 INFO - Blob upload gear active. 17:27:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:27:32 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 17:27:32 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'] 17:27:32 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 17:27:33 INFO - (blobuploader) - INFO - Open directory for files ... 17:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:27:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:34 INFO - (blobuploader) - INFO - Done attempting. 17:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:35 INFO - (blobuploader) - INFO - Done attempting. 17:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:27:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:37 INFO - (blobuploader) - INFO - Done attempting. 17:27:37 INFO - (blobuploader) - INFO - Iteration through files over. 17:27:37 INFO - Return code: 0 17:27:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:27:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:27:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9060bb1156e0c01c79ea4953e77e8b248a1155d9d4eaa3a670b0e7d60cb728da7f7e0006ff33b9f45fa776a6c795cf11d39962b961eaf57a350e2df447803356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e55b3dd98f47afd160bcfe55f72de6d26795eea32aa18bd88bdd56ad4150f6d9669e28d315cf63f804ee12fcb3a3b3f8ed603e92a2754c1ceb287e9aec69a2a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0cc9e11efc24f892dbc0bb277f86f56016898dd377666b6f63925a5be81bb7aa20a5c421e70ec9024a141167c8c320943a7acb2d985fb7d0a434623ead226fe"} 17:27:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:27:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:27:37 INFO - Contents: 17:27:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9060bb1156e0c01c79ea4953e77e8b248a1155d9d4eaa3a670b0e7d60cb728da7f7e0006ff33b9f45fa776a6c795cf11d39962b961eaf57a350e2df447803356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e55b3dd98f47afd160bcfe55f72de6d26795eea32aa18bd88bdd56ad4150f6d9669e28d315cf63f804ee12fcb3a3b3f8ed603e92a2754c1ceb287e9aec69a2a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0cc9e11efc24f892dbc0bb277f86f56016898dd377666b6f63925a5be81bb7aa20a5c421e70ec9024a141167c8c320943a7acb2d985fb7d0a434623ead226fe"} 17:27:37 INFO - Running post-run listener: copy_logs_to_upload_dir 17:27:37 INFO - Copying logs to upload dir... 17:27:37 INFO - mkdir: /builds/slave/test/build/upload/logs 17:27:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.718189 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-05 17:27:37.697769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 17:27:37.700917) ========= 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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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/9060bb1156e0c01c79ea4953e77e8b248a1155d9d4eaa3a670b0e7d60cb728da7f7e0006ff33b9f45fa776a6c795cf11d39962b961eaf57a350e2df447803356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e55b3dd98f47afd160bcfe55f72de6d26795eea32aa18bd88bdd56ad4150f6d9669e28d315cf63f804ee12fcb3a3b3f8ed603e92a2754c1ceb287e9aec69a2a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0cc9e11efc24f892dbc0bb277f86f56016898dd377666b6f63925a5be81bb7aa20a5c421e70ec9024a141167c8c320943a7acb2d985fb7d0a434623ead226fe"} build_url:https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/XNxUdkALQFqJJ2wvZt2zxw/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/9060bb1156e0c01c79ea4953e77e8b248a1155d9d4eaa3a670b0e7d60cb728da7f7e0006ff33b9f45fa776a6c795cf11d39962b961eaf57a350e2df447803356", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e55b3dd98f47afd160bcfe55f72de6d26795eea32aa18bd88bdd56ad4150f6d9669e28d315cf63f804ee12fcb3a3b3f8ed603e92a2754c1ceb287e9aec69a2a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0cc9e11efc24f892dbc0bb277f86f56016898dd377666b6f63925a5be81bb7aa20a5c421e70ec9024a141167c8c320943a7acb2d985fb7d0a434623ead226fe"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 17:27:37.738979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:27:37.739681) ========= 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.d86sucNZGZ/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.QbEsgK2YCZ/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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.005403 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:27:37.792514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 17:27:37.793231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 17:27:37.794007) ========= ========= Total master_lag: 4.03 =========