builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0360 starttime: 1481496646.51 results: success (0) buildid: 20161211134851 builduid: 6e8482c0a7d64b6a9ef783c4b9c3a8e9 revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.508332) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.508828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.509148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.607411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.608070) ========= 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.80SQFKyiqX/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.balSSZ2fIv/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-11 14:50:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.1M=0.001s 2016-12-11 14:50:46 (17.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110279 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.757862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.758264) ========= 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.80SQFKyiqX/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.balSSZ2fIv/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.026640 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.833794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 14:50:46.834146) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.80SQFKyiqX/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.balSSZ2fIv/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-11 14:50:46,932 truncating revision to first 12 chars 2016-12-11 14:50:46,932 Setting DEBUG logging. 2016-12-11 14:50:46,932 attempt 1/10 2016-12-11 14:50:46,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42086c06f756?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-11 14:50:48,005 unpacking tar archive at: mozilla-central-42086c06f756/testing/mozharness/ program finished with exit code 0 elapsedTime=1.340728 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 14:50:48.232076) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.232470) ========= script_repo_revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.232923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.233225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.400047) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-12-11 14:50:48.400304) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.80SQFKyiqX/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.balSSZ2fIv/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:50:48 INFO - MultiFileLogger online at 20161211 14:50:48 in /builds/slave/test 14:50:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:50:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:50:48 INFO - {'append_to_log': False, 14:50:48 INFO - 'base_work_dir': '/builds/slave/test', 14:50:48 INFO - 'blob_upload_branch': 'Firefox', 14:50:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:50:48 INFO - 'branch': 'Firefox', 14:50:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:48 INFO - 'config_files': ('talos/mac_config.py',), 14:50:48 INFO - 'default_actions': ('clobber', 14:50:48 INFO - 'read-buildbot-config', 14:50:48 INFO - 'download-and-extract', 14:50:48 INFO - 'populate-webroot', 14:50:48 INFO - 'create-virtualenv', 14:50:48 INFO - 'install', 14:50:48 INFO - 'run-tests'), 14:50:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:48 INFO - 'download_minidump_stackwalk': True, 14:50:48 INFO - 'download_symbols': 'ondemand', 14:50:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:48 INFO - 'installer_path': 'installer.exe', 14:50:48 INFO - 'log_level': 'info', 14:50:48 INFO - 'log_name': 'talos', 14:50:48 INFO - 'log_to_console': True, 14:50:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:50:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:50:48 INFO - 'opt_config_files': (), 14:50:48 INFO - 'pip_index': False, 14:50:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:48 INFO - 'cmd': ('bash', 14:50:48 INFO - '-c', 14:50:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:48 INFO - 'enabled': True, 14:50:48 INFO - 'halt_on_failure': False, 14:50:48 INFO - 'name': 'check_screen_resolution'},), 14:50:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:48 INFO - 'cmd': ('bash', 14:50:48 INFO - '-c', 14:50:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:48 INFO - 'enabled': True, 14:50:48 INFO - 'halt_on_failure': False, 14:50:48 INFO - 'name': 'check_screen_resolution'},), 14:50:48 INFO - 'run_cmd_checks_enabled': True, 14:50:48 INFO - 'sps_profile': False, 14:50:48 INFO - 'sps_profile_interval': 0, 14:50:48 INFO - 'suite': 'dromaeojs', 14:50:48 INFO - 'system_bits': '32', 14:50:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:48 INFO - 'title': 't-yosemite-r7-0360', 14:50:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:48 INFO - 'use_talos_json': True, 14:50:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:50:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:48 INFO - 'work_dir': 'build'} 14:50:48 INFO - [mozharness: 2016-12-11 22:50:48.611788Z] Running clobber step. 14:50:48 INFO - Running pre-action listener: _resource_record_pre_action 14:50:48 INFO - Running main action method: clobber 14:50:48 INFO - rmtree: /builds/slave/test/build 14:50:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:50:50 INFO - Running post-action listener: _resource_record_post_action 14:50:50 INFO - [mozharness: 2016-12-11 22:50:50.909149Z] Finished clobber step (success) 14:50:50 INFO - [mozharness: 2016-12-11 22:50:50.909286Z] Running read-buildbot-config step. 14:50:50 INFO - Running pre-action listener: _resource_record_pre_action 14:50:50 INFO - Running main action method: read_buildbot_config 14:50:50 INFO - Using buildbot properties: 14:50:50 INFO - { 14:50:50 INFO - "project": "", 14:50:50 INFO - "product": "firefox", 14:50:50 INFO - "script_repo_revision": "production", 14:50:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:50:50 INFO - "repository": "", 14:50:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:50:50 INFO - "buildid": "20161211134851", 14:50:50 INFO - "pgo_build": "False", 14:50:50 INFO - "basedir": "/builds/slave/test", 14:50:50 INFO - "buildnumber": 39, 14:50:50 INFO - "slavename": "t-yosemite-r7-0360", 14:50:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:50:50 INFO - "platform": "yosemite_r7", 14:50:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:50:50 INFO - "branch": "mozilla-central", 14:50:50 INFO - "repo_path": "mozilla-central", 14:50:50 INFO - "revision": "42086c06f756cda7fbc25a2e7c20a5711f7e5f26", 14:50:50 INFO - "stage_platform": "macosx64", 14:50:50 INFO - "builduid": "6e8482c0a7d64b6a9ef783c4b9c3a8e9", 14:50:50 INFO - "slavebuilddir": "test" 14:50:50 INFO - } 14:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 14:50:50 INFO - Running post-action listener: _resource_record_post_action 14:50:50 INFO - [mozharness: 2016-12-11 22:50:50.912572Z] Finished read-buildbot-config step (success) 14:50:50 INFO - [mozharness: 2016-12-11 22:50:50.912708Z] Running download-and-extract step. 14:50:50 INFO - Running pre-action listener: _resource_record_pre_action 14:50:50 INFO - Running main action method: download_and_extract 14:50:50 INFO - mkdir: /builds/slave/test/build/tests 14:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:50 INFO - trying https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:50:50 INFO - Downloading https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 14:50:52 INFO - Downloaded 1235 bytes. 14:50:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:50:52 INFO - Using the following test package requirements: 14:50:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 14:50:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 14:50:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 14:50:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'jsshell-mac64.zip'], 14:50:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 14:50:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 14:50:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 14:50:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 14:50:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 14:50:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 14:50:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 14:50:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 14:50:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 14:50:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 14:50:53 INFO - Expected file size: 16289294 14:50:53 INFO - Obtained file size: 16289294 14:50:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 14:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 14:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 14:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 14:51:00 INFO - Expected file size: 16289294 14:51:00 INFO - Obtained file size: 16289294 14:51:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 14:51:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 14:51:06 INFO - Fetch https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 14:51:08 INFO - Expected file size: 14409734 14:51:08 INFO - Obtained file size: 14409734 14:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:09 INFO - trying https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 14:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 14:51:11 INFO - Downloaded 69675736 bytes. 14:51:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:51:11 INFO - mkdir: /builds/slave/test/properties 14:51:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:51:11 INFO - Writing to file /builds/slave/test/properties/build_url 14:51:11 INFO - Contents: 14:51:11 INFO - build_url:https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:51:13 INFO - Running post-action listener: _resource_record_post_action 14:51:13 INFO - Running post-action listener: set_extra_try_arguments 14:51:13 INFO - [mozharness: 2016-12-11 22:51:13.690920Z] Finished download-and-extract step (success) 14:51:13 INFO - [mozharness: 2016-12-11 22:51:13.691076Z] Running populate-webroot step. 14:51:13 INFO - Running pre-action listener: _resource_record_pre_action 14:51:13 INFO - Running main action method: populate_webroot 14:51:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:13 INFO - '--tppagecycles', 14:51:13 INFO - '7'], 14:51:13 INFO - 'tests': ['tsvgm']}}, 14:51:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:51:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:51:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:51:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:51:13 INFO - 'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:51:13 INFO - 'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['damp', 'tps']}, 14:51:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:51:13 INFO - 'tests': ['damp', 'tps']}, 14:51:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['dromaeo_dom']}, 14:51:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['basic_compositor_video']}, 14:51:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:51:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['a11yr', 14:51:13 INFO - 'ts_paint', 14:51:13 INFO - 'tpaint', 14:51:13 INFO - 'sessionrestore', 14:51:13 INFO - 'sessionrestore_no_auto_restore', 14:51:13 INFO - 'tabpaint']}, 14:51:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:51:13 INFO - 'ts_paint', 14:51:13 INFO - 'tpaint', 14:51:13 INFO - 'sessionrestore', 14:51:13 INFO - 'sessionrestore_no_auto_restore', 14:51:13 INFO - 'tabpaint']}, 14:51:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:51:13 INFO - 'ts_paint', 14:51:13 INFO - 'tpaint', 14:51:13 INFO - 'sessionrestore', 14:51:13 INFO - 'sessionrestore_no_auto_restore', 14:51:13 INFO - 'tabpaint']}, 14:51:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:51:13 INFO - 'ts_paint', 14:51:13 INFO - 'tpaint', 14:51:13 INFO - 'sessionrestore', 14:51:13 INFO - 'sessionrestore_no_auto_restore', 14:51:13 INFO - 'tabpaint']}, 14:51:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['a11yr', 14:51:13 INFO - 'ts_paint', 14:51:13 INFO - 'tpaint', 14:51:13 INFO - 'sessionrestore', 14:51:13 INFO - 'sessionrestore_no_auto_restore', 14:51:13 INFO - 'tabpaint']}, 14:51:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['a11yr', 14:51:13 INFO - 'ts_paint', 14:51:13 INFO - 'tpaint', 14:51:13 INFO - 'sessionrestore', 14:51:13 INFO - 'sessionrestore_no_auto_restore', 14:51:13 INFO - 'tabpaint']}, 14:51:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['tsvgx', 14:51:13 INFO - 'tsvgr_opacity', 14:51:13 INFO - 'tart', 14:51:13 INFO - 'tscrollx', 14:51:13 INFO - 'cart', 14:51:13 INFO - 'tsvg_static']}, 14:51:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:51:13 INFO - 'tsvgr_opacity', 14:51:13 INFO - 'tart', 14:51:13 INFO - 'tscrollx', 14:51:13 INFO - 'cart', 14:51:13 INFO - 'tsvg_static']}, 14:51:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:51:13 INFO - 'talos_options': ['--disable-e10s'], 14:51:13 INFO - 'tests': ['tp5o']}, 14:51:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:51:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:51:13 INFO - 'talos_options': ['--disable-e10s', 14:51:13 INFO - '--xperf_path', 14:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:13 INFO - 'tests': ['tp5n']}, 14:51:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:51:13 INFO - 'talos_options': ['--xperf_path', 14:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:13 INFO - 'tests': ['tp5n']}}, 14:51:13 INFO - 'talos.zip': {'path': '', 14:51:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:13 INFO - Running post-action listener: _resource_record_post_action 14:51:13 INFO - [mozharness: 2016-12-11 22:51:13.709600Z] Finished populate-webroot step (success) 14:51:13 INFO - [mozharness: 2016-12-11 22:51:13.709738Z] Running create-virtualenv step. 14:51:13 INFO - Running pre-action listener: _resource_record_pre_action 14:51:13 INFO - Running main action method: create_virtualenv 14:51:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:51:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:51:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:51:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:13 INFO - Using real prefix '/tools/python27' 14:51:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:51:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:17 INFO - Installing pip.................done. 14:51:17 INFO - Return code: 0 14:51:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:51:17 INFO - Reading from file tmpfile_stdout 14:51:17 INFO - Output received: 14:51:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:51:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:17 INFO - 'HOME': '/Users/cltbld', 14:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:17 INFO - 'LOGNAME': 'cltbld', 14:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:17 INFO - 'MOZ_NO_REMOTE': '1', 14:51:17 INFO - 'NO_EM_RESTART': '1', 14:51:17 INFO - 'PAGER': '/bin/cat', 14:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:17 INFO - 'PWD': '/builds/slave/test', 14:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:17 INFO - 'SHELL': '/bin/bash', 14:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:17 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:17 INFO - 'USER': 'cltbld', 14:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:17 INFO - 'XPC_FLAGS': '0x0', 14:51:17 INFO - 'XPC_SERVICE_NAME': '0', 14:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:51:17 INFO - Cleaning up... 14:51:17 INFO - Return code: 0 14:51:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:17 INFO - 'HOME': '/Users/cltbld', 14:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:17 INFO - 'LOGNAME': 'cltbld', 14:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:17 INFO - 'MOZ_NO_REMOTE': '1', 14:51:17 INFO - 'NO_EM_RESTART': '1', 14:51:17 INFO - 'PAGER': '/bin/cat', 14:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:17 INFO - 'PWD': '/builds/slave/test', 14:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:17 INFO - 'SHELL': '/bin/bash', 14:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:17 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:17 INFO - 'USER': 'cltbld', 14:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:17 INFO - 'XPC_FLAGS': '0x0', 14:51:17 INFO - 'XPC_SERVICE_NAME': '0', 14:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:18 INFO - Downloading/unpacking psutil>=3.1.1 14:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:21 INFO - Installing collected packages: psutil 14:51:21 INFO - Running setup.py install for psutil 14:51:21 INFO - building 'psutil._psutil_osx' extension 14:51:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:51:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:51:22 INFO - building 'psutil._psutil_posix' extension 14:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:51:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:51:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:51:22 INFO - ^ 14:51:22 INFO - 1 warning generated. 14:51:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:22 INFO - Successfully installed psutil 14:51:22 INFO - Cleaning up... 14:51:22 INFO - Return code: 0 14:51:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:22 INFO - 'HOME': '/Users/cltbld', 14:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:22 INFO - 'LOGNAME': 'cltbld', 14:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:22 INFO - 'MOZ_NO_REMOTE': '1', 14:51:22 INFO - 'NO_EM_RESTART': '1', 14:51:22 INFO - 'PAGER': '/bin/cat', 14:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:22 INFO - 'PWD': '/builds/slave/test', 14:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:22 INFO - 'SHELL': '/bin/bash', 14:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:22 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:22 INFO - 'USER': 'cltbld', 14:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:22 INFO - 'XPC_FLAGS': '0x0', 14:51:22 INFO - 'XPC_SERVICE_NAME': '0', 14:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:51:25 INFO - Installing collected packages: mozsystemmonitor 14:51:25 INFO - Running setup.py install for mozsystemmonitor 14:51:25 INFO - Successfully installed mozsystemmonitor 14:51:25 INFO - Cleaning up... 14:51:25 INFO - Return code: 0 14:51:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:26 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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:26 INFO - 'HOME': '/Users/cltbld', 14:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:26 INFO - 'LOGNAME': 'cltbld', 14:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:26 INFO - 'MOZ_NO_REMOTE': '1', 14:51:26 INFO - 'NO_EM_RESTART': '1', 14:51:26 INFO - 'PAGER': '/bin/cat', 14:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:26 INFO - 'PWD': '/builds/slave/test', 14:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:26 INFO - 'SHELL': '/bin/bash', 14:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:26 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:26 INFO - 'USER': 'cltbld', 14:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:26 INFO - 'XPC_FLAGS': '0x0', 14:51:26 INFO - 'XPC_SERVICE_NAME': '0', 14:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:26 INFO - Downloading/unpacking jsonschema==2.5.1 14:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:51:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:29 INFO - Downloading functools32-3.2.3-2.tar.gz 14:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:51:29 INFO - warning: no files found matching '*.txt' 14:51:29 INFO - no previously-included directories found matching 'build' 14:51:29 INFO - no previously-included directories found matching 'dist' 14:51:29 INFO - no previously-included directories found matching '.git*' 14:51:29 INFO - Installing collected packages: jsonschema, functools32 14:51:29 INFO - Running setup.py install for functools32 14:51:29 INFO - warning: no files found matching '*.txt' 14:51:29 INFO - no previously-included directories found matching 'build' 14:51:29 INFO - no previously-included directories found matching 'dist' 14:51:29 INFO - no previously-included directories found matching '.git*' 14:51:29 INFO - Successfully installed jsonschema functools32 14:51:29 INFO - Cleaning up... 14:51:29 INFO - Return code: 0 14:51:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:29 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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:29 INFO - 'HOME': '/Users/cltbld', 14:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:29 INFO - 'LOGNAME': 'cltbld', 14:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:29 INFO - 'MOZ_NO_REMOTE': '1', 14:51:29 INFO - 'NO_EM_RESTART': '1', 14:51:29 INFO - 'PAGER': '/bin/cat', 14:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:29 INFO - 'PWD': '/builds/slave/test', 14:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:29 INFO - 'SHELL': '/bin/bash', 14:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:29 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:29 INFO - 'USER': 'cltbld', 14:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:29 INFO - 'XPC_FLAGS': '0x0', 14:51:29 INFO - 'XPC_SERVICE_NAME': '0', 14:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:51:29 INFO - Cleaning up... 14:51:29 INFO - Return code: 0 14:51:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:29 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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:29 INFO - 'HOME': '/Users/cltbld', 14:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:29 INFO - 'LOGNAME': 'cltbld', 14:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:29 INFO - 'MOZ_NO_REMOTE': '1', 14:51:29 INFO - 'NO_EM_RESTART': '1', 14:51:29 INFO - 'PAGER': '/bin/cat', 14:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:29 INFO - 'PWD': '/builds/slave/test', 14:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:29 INFO - 'SHELL': '/bin/bash', 14:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:29 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:29 INFO - 'USER': 'cltbld', 14:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:29 INFO - 'XPC_FLAGS': '0x0', 14:51:29 INFO - 'XPC_SERVICE_NAME': '0', 14:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:51:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:33 INFO - Downloading docopt-0.6.1.tar.gz 14:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:34 INFO - Running setup.py install for blobuploader 14:51:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:51:34 INFO - Running setup.py install for requests 14:51:34 INFO - Running setup.py install for docopt 14:51:34 INFO - Successfully installed blobuploader requests docopt 14:51:34 INFO - Cleaning up... 14:51:34 INFO - Return code: 0 14:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:35 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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:35 INFO - 'HOME': '/Users/cltbld', 14:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:35 INFO - 'LOGNAME': 'cltbld', 14:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:35 INFO - 'MOZ_NO_REMOTE': '1', 14:51:35 INFO - 'NO_EM_RESTART': '1', 14:51:35 INFO - 'PAGER': '/bin/cat', 14:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:35 INFO - 'PWD': '/builds/slave/test', 14:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:35 INFO - 'SHELL': '/bin/bash', 14:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:35 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:35 INFO - 'USER': 'cltbld', 14:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:35 INFO - 'XPC_FLAGS': '0x0', 14:51:35 INFO - 'XPC_SERVICE_NAME': '0', 14:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:35 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-IFYMAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-MQ27VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-XTNPOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-v0v0xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-PhWDsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-MbJuFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-CEVjq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-CNuFBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-XRFrB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-5lKxBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:36 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-pnrS8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:37 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-iEJnV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:37 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-PJrbx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:37 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-XIjwy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:37 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-yVvbxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:37 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-3xUq_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:37 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-8Ywks1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:37 INFO - Running setup.py install for manifestparser 14:51:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Running setup.py install for mozcrash 14:51:37 INFO - Running setup.py install for mozdebug 14:51:38 INFO - Running setup.py install for mozdevice 14:51:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Running setup.py install for mozfile 14:51:38 INFO - Running setup.py install for mozhttpd 14:51:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Running setup.py install for mozinfo 14:51:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Running setup.py install for mozInstall 14:51:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Running setup.py install for mozleak 14:51:38 INFO - Running setup.py install for mozlog 14:51:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:51:39 INFO - Running setup.py install for moznetwork 14:51:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:51:39 INFO - Running setup.py install for mozprocess 14:51:39 INFO - Running setup.py install for mozprofile 14:51:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:51:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:51:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:51:39 INFO - Running setup.py install for mozrunner 14:51:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:51:39 INFO - Running setup.py install for mozscreenshot 14:51:39 INFO - Running setup.py install for moztest 14:51:40 INFO - Running setup.py install for mozversion 14:51:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:51:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:51:40 INFO - Cleaning up... 14:51:40 INFO - Return code: 0 14:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:40 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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:40 INFO - 'HOME': '/Users/cltbld', 14:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:40 INFO - 'LOGNAME': 'cltbld', 14:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:40 INFO - 'MOZ_NO_REMOTE': '1', 14:51:40 INFO - 'NO_EM_RESTART': '1', 14:51:40 INFO - 'PAGER': '/bin/cat', 14:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:40 INFO - 'PWD': '/builds/slave/test', 14:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:40 INFO - 'SHELL': '/bin/bash', 14:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:40 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:40 INFO - 'USER': 'cltbld', 14:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:40 INFO - 'XPC_FLAGS': '0x0', 14:51:40 INFO - 'XPC_SERVICE_NAME': '0', 14:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:40 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-mbaVfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:40 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-D9glqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-1LqVnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-qZGZrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-YtiYku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-IeTxlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-zVW9nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-RuXLW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-5iOtVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-PvSX7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:41 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-SHepIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:42 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-2hOJcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:42 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)) 14:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:42 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-DNdiLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:42 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-a3NmFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:42 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-dVndhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:42 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-3GDUph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:42 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)) 14:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:42 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-YdnycL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:51:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:45 INFO - Downloading blessings-1.6.tar.gz 14:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:45 INFO - Installing collected packages: blessings 14:51:45 INFO - Running setup.py install for blessings 14:51:45 INFO - Successfully installed blessings 14:51:45 INFO - Cleaning up... 14:51:45 INFO - Return code: 0 14:51:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:45 INFO - Reading from file tmpfile_stdout 14:51:45 INFO - Current package versions: 14:51:45 INFO - blessings == 1.6 14:51:45 INFO - blobuploader == 1.2.4 14:51:45 INFO - docopt == 0.6.1 14:51:45 INFO - functools32 == 3.2.3-2 14:51:45 INFO - jsonschema == 2.5.1 14:51:45 INFO - manifestparser == 1.1 14:51:45 INFO - mozInstall == 1.12 14:51:45 INFO - mozcrash == 1.0 14:51:45 INFO - mozdebug == 0.1 14:51:45 INFO - mozdevice == 0.49 14:51:45 INFO - mozfile == 1.2 14:51:45 INFO - mozhttpd == 0.7 14:51:45 INFO - mozinfo == 0.9 14:51:45 INFO - mozleak == 0.1 14:51:45 INFO - mozlog == 3.4 14:51:45 INFO - moznetwork == 0.27 14:51:45 INFO - mozprocess == 0.23 14:51:45 INFO - mozprofile == 0.28 14:51:45 INFO - mozrunner == 6.13 14:51:45 INFO - mozscreenshot == 0.1 14:51:45 INFO - mozsystemmonitor == 0.3 14:51:45 INFO - moztest == 0.7 14:51:45 INFO - mozversion == 1.4 14:51:45 INFO - psutil == 3.1.1 14:51:45 INFO - requests == 1.2.3 14:51:45 INFO - wsgiref == 0.1.2 14:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:45 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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:45 INFO - 'HOME': '/Users/cltbld', 14:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:45 INFO - 'LOGNAME': 'cltbld', 14:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:45 INFO - 'MOZ_NO_REMOTE': '1', 14:51:45 INFO - 'NO_EM_RESTART': '1', 14:51:45 INFO - 'PAGER': '/bin/cat', 14:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:45 INFO - 'PWD': '/builds/slave/test', 14:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:45 INFO - 'SHELL': '/bin/bash', 14:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:45 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:45 INFO - 'USER': 'cltbld', 14:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:45 INFO - 'XPC_FLAGS': '0x0', 14:51:45 INFO - 'XPC_SERVICE_NAME': '0', 14:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:51:46 INFO - Cleaning up... 14:51:46 INFO - Return code: 0 14:51:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:46 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 0x103a463f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe11a494630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, '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.80SQFKyiqX/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.balSSZ2fIv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:46 INFO - 'HOME': '/Users/cltbld', 14:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:46 INFO - 'LOGNAME': 'cltbld', 14:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:46 INFO - 'MOZ_NO_REMOTE': '1', 14:51:46 INFO - 'NO_EM_RESTART': '1', 14:51:46 INFO - 'PAGER': '/bin/cat', 14:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:46 INFO - 'PWD': '/builds/slave/test', 14:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:46 INFO - 'SHELL': '/bin/bash', 14:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:51:46 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:46 INFO - 'USER': 'cltbld', 14:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:46 INFO - 'XPC_FLAGS': '0x0', 14:51:46 INFO - 'XPC_SERVICE_NAME': '0', 14:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:51:46 INFO - Cleaning up... 14:51:46 INFO - Return code: 0 14:51:46 INFO - Running post-action listener: _resource_record_post_action 14:51:46 INFO - Running post-action listener: _start_resource_monitoring 14:51:46 INFO - Starting resource monitoring. 14:51:46 INFO - [mozharness: 2016-12-11 22:51:46.459308Z] Finished create-virtualenv step (success) 14:51:46 INFO - [mozharness: 2016-12-11 22:51:46.460347Z] Running install step. 14:51:46 INFO - Running pre-action listener: _resource_record_pre_action 14:51:46 INFO - Running main action method: install 14:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:46 INFO - Reading from file tmpfile_stdout 14:51:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:51:46 INFO - Reading from file tmpfile_stdout 14:51:46 INFO - Output received: 14:51:46 INFO - Usage: mozinstall [options] installer 14:51:46 INFO - Options: 14:51:46 INFO - -h, --help show this help message and exit 14:51:46 INFO - -d DEST, --destination=DEST 14:51:46 INFO - Directory to install application into. [default: 14:51:46 INFO - "/builds/slave/test"] 14:51:46 INFO - --app=APP Application being installed. [default: firefox] 14:51:46 INFO - mkdir: /builds/slave/test/build/application 14:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 14:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 14:52:08 INFO - Reading from file tmpfile_stdout 14:52:08 INFO - Output received: 14:52:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:52:08 INFO - Running post-action listener: _resource_record_post_action 14:52:08 INFO - [mozharness: 2016-12-11 22:52:08.796826Z] Finished install step (success) 14:52:08 INFO - [mozharness: 2016-12-11 22:52:08.796953Z] Running run-tests step. 14:52:08 INFO - Running pre-action listener: _resource_record_pre_action 14:52:08 INFO - Running main action method: run_tests 14:52:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:52:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:52:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:52:08 INFO - 2016-12-11 14:52:08.810 screenresolution[1632:7381] starting screenresolution argv=screenresolution get 14:52:08 INFO - 2016-12-11 14:52:08.812 screenresolution[1632:7381] Display 0: 1600x1200x32@60 14:52:08 INFO - 2016-12-11 14:52:08.817 screenresolution[1633:7383] starting screenresolution argv=screenresolution list 14:52:08 INFO - Available Modes on Display 0 14:52:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:52:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:52:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:52:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:52:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:52:09 INFO - Intel Iris: 14:52:09 INFO - Chipset Model: Intel Iris 14:52:09 INFO - Type: GPU 14:52:09 INFO - Bus: Built-In 14:52:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:52:09 INFO - Vendor: Intel (0x8086) 14:52:09 INFO - Device ID: 0x0a2e 14:52:09 INFO - Revision ID: 0x0009 14:52:09 INFO - Displays: 14:52:09 INFO - Display: 14:52:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:52:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:52:09 INFO - Display Serial Number: 1600x1200 60 14:52:09 INFO - Main Display: Yes 14:52:09 INFO - Mirror: Off 14:52:09 INFO - Online: Yes 14:52:09 INFO - Rotation: Supported 14:52:09 INFO - Return code: 0 14:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:09 INFO - Python 2.7.3 14:52:09 INFO - Return code: 0 14:52:09 INFO - grabbing minidump binary from tooltool 14:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:09 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 0x10385bd30>, '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 0x1036c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103853b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:52:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:52:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:52:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:09 INFO - Return code: 0 14:52:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:52:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0360 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:52:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.80SQFKyiqX/Render', 14:52:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:09 INFO - 'HOME': '/Users/cltbld', 14:52:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:09 INFO - 'LOGNAME': 'cltbld', 14:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:09 INFO - 'MOZ_NO_REMOTE': '1', 14:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:09 INFO - 'NO_EM_RESTART': '1', 14:52:09 INFO - 'PAGER': '/bin/cat', 14:52:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:09 INFO - 'PWD': '/builds/slave/test', 14:52:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:09 INFO - 'SHELL': '/bin/bash', 14:52:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.balSSZ2fIv/Listeners', 14:52:09 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:52:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:09 INFO - 'USER': 'cltbld', 14:52:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:09 INFO - 'XPC_FLAGS': '0x0', 14:52:09 INFO - 'XPC_SERVICE_NAME': '0', 14:52:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:52:09 INFO - mozversion application_buildid: 20161211134851 14:52:09 INFO - mozversion application_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 14:52:09 INFO - mozversion application_display_name: Nightly 14:52:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:09 INFO - mozversion application_name: Firefox 14:52:09 INFO - mozversion application_remotingname: firefox 14:52:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:52:09 INFO - mozversion application_vendor: Mozilla 14:52:09 INFO - mozversion application_version: 53.0a1 14:52:09 INFO - mozversion platform_buildid: 20161211134851 14:52:09 INFO - mozversion platform_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 14:52:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:52:09 INFO - mozversion platform_version: 53.0a1 14:52:09 INFO - using testdate: 1481496729 14:52:09 INFO - actual date: 1481496729 14:52:09 INFO - starting webserver on 'localhost:49251' 14:52:09 INFO - SUITE-START | Running 2 tests 14:52:09 INFO - TEST-START | dromaeo_css 14:52:09 INFO - operating with platform_type : mac_ 14:52:09 INFO - Initialising browser for dromaeo_css test... 14:52:09 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpAA0x2H/profile http://localhost:49251/getInfo.html) 14:52:11 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 14:52:11 INFO - PROCESS | 1643 | colorDepth:24 14:52:11 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 14:52:11 INFO - PROCESS | 1643 | __metrics 14:52:11 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:52:11 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:52:12 INFO - TEST-INFO | 1643: exit 0 14:52:12 INFO - Browser initialized. 14:52:12 INFO - Running cycle 1/1 for dromaeo_css test... 14:52:12 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpAA0x2H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:24 INFO - PROCESS | 1645 | RSS: Main: 237019136 14:52:24 INFO - PROCESS | 1645 | 14:53:15 INFO - PROCESS | 1645 | 1481496795608 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] 14:55:27 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 14:55:30 INFO - PROCESS | 1645 | RSS: Main: 490655744 14:55:30 INFO - PROCESS | 1645 | 14:58:33 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 14:58:34 INFO - PROCESS | 1645 | RSS: Main: 374112256 14:58:34 INFO - PROCESS | 1645 | 15:01:36 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 15:01:37 INFO - PROCESS | 1645 | RSS: Main: 356130816 15:01:37 INFO - PROCESS | 1645 | 15:04:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 15:04:40 INFO - PROCESS | 1645 | RSS: Main: 347582464 15:04:40 INFO - PROCESS | 1645 | 15:07:43 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 15:07:44 INFO - PROCESS | 1645 | RSS: Main: 337776640 15:07:44 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 15:10:48 INFO - PROCESS | 1645 | RSS: Main: 512258048 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | __start_tp_report 15:10:48 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 15:10:48 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 15:10:48 INFO - PROCESS | 1645 | |i|pagename|runs| 15:10:48 INFO - PROCESS | 1645 | |0;dojo.html;3312.685294896984;3317.187289114167;3338.582677165354;3362.361151381239;3383.340248651514;5519.089350257203;5601.07582248929;5624.21261023456;5633.8309850704445;5669.688167150805;5611.831645050655;5640.351359593648;5717.6283541569765;5720.170575266584;5738.081906894908;5022.974885125569;5054.898902021957;5094.847154585368;5147.22791581262;5162.432132465426;5225.686458812484;5259.8422047338645;5267.499587539178;5278.2082687596785;5311.123664595337;5069.77186026626;5169.819056333048;5181.0674078665825;5184.637075404723;5269;4184.456020717318;5143.177091665316;5163.277141200235;5167.767450464738;5169.276301317781;5099.974500127476;5148.459411761749;5153.9742301288625;5167.689938603696;5177.326947496839;5627.54979601635;5637.8590535236535;5640.0693885508845;5652.180433837112;5704.572157088193;6037.0642550404755;6093.421124993119;6105.938940610581;6120.660465672121;6192.28788689302;6224;6232.3144454110015;6282.654454005028;6282.874342513124;6289.937100628981;5755.1367294906095;5756.619018023617;5766.163906233656;5771;5803.622764520335;4954.3311652926395;6213.689315534296;6237.220347456568;6322.936770632326;6337.9683101585115;5993.550483713739;6027.7890273841085;6027.8794424111275;6041.154238406627;6068.453839154409;6115.179495343508;6160.260768707783;6161.784337548164;6162.876742465126;6165.506759459233;6099.99401472374;6151;6152.107944348045;6170.413810687977;6208.81373558794;6141.84645383869;6191.876162476725;6212.47193988507;6216.689165541705;6233.34549872266;4762.261849413347;4814.5907597853875;4894.657373983858;4895.216765317532;4907.435644900882;3664.358737221029;4313.180495705806;4366.083122544238;4381.16757816014;4423.270160423558;5691.203231547586;5707.74315155819;5708.885822283614;5722.399148089391;5729.5702822288495;6204.720787564571;6205.100260462208;6207.937920620736;6219.626822390671;6223.3465486123305;5527.53015993645;5569.637973531708;5582.637128586629;5677.37548869624;5706.029974904276;5334.413214546396;5341.359036915595;5347.598930080259;5355.946440535623;5389.946100538945;6298.370162983848;6298.590591611531;6313.989761638116;6314.147590075281;6319.304876463677;5555.611107222618;6086.269647642134;6119.571629985859;6136.059583474621;6247.656378899204;6241.531885108726;6247.406496382836;6270.2475702915945;6286.339934306832;6328;6154.846128846814;6171.413715697002;6173.783917563043;6175.59858609189;6188.226471691039;6169.136320915165;6226.937730622817;6231.065340198825;6249.406306400884;6249.78125765596;5807.680577568105;5912.733926973383;5925.081612350093;5981.312149102909;5995.040793473024;5796.478316951495;5978.940210597838;5979.551533634908;5989.071693887455;5993.190919225849;5799.681017544076;5841.50347220491;5847.473727364558;5856.092305692625;5861.853453663693;5985.132155837292;5994.0109881869;5996.820095397145;5999.730012149551;6008.909866351921;5819.127130930395;5822.446867547576;5828;5828.854278643068;5832.912506312324 15:10:48 INFO - PROCESS | 1645 | |1;ext.html;440.79503031090536;478.9521047895211;490.0835437731443;495.01739047989736;544.382126286665;30596.38807223857;39524.802375988154;39773.80113099434;42219.15561688764;42343.36484952721;39923.60267390642;40561.901667208265;41170.7941460293;41196;41239.587604123946;8222.547759873205;8300.12848650892;9380.437173769562;9380.812383752322;9380.8592871107;8360.414770966036;11057.944710276437;11295.152863535268;11306.660800175967;11318;11203.66389008327;11269.54921803131;11286.322820630747;11289.379084150369;11299.378534180616;8397.832043359098;8610.225079742853;11143.944280278587;11243.943780281088;11263.26788758728;8408.075111737704;8473.449225800303;8476.83046339076;10899.237053406265;11213.990740833364;38862.41706374407;39118.02204944871;39170.60829391698;39181;39277.607223927684;2918.2996080940634;3360.983195084009;3363.5795525559306;3582.6417358264225;3625.981870090659;29280;29454.82180712769;29559;30261.848690756626;30885.38229235425;3109.113902537766;3110.6111736032994;3142.245860993345;3148.968510314913;3260.2827377976805;361243;363115;364599;364950;365211.17394413124;61239;61656;61659.075113873325;61781;61796;64986;65017.67491162608;65061.67469162624;65075.02387464192;65186.67406663031;15526.534203973899;15937.521874343789;15948.043117412992;15951.840481595267;15987.36050557988;11024.559017639365;11295.604653837241;11299.717507062225;12237.877621223852;12325.260484370787;15862.286197121157;15997.360105595879;16003.27985240667;18037.639247215244;18575.81424185768;7006.229314775371;7061.682224299816;7090.574565526085;7136.0723105995885;7138.714451421989;896.9372143949861;926.420986883198;975.843625304017;987.0770829274651;1012.9290949633455;26486;26524.336891577866;28316.71683283182;29096.7090329094;29946;1030.1346868630387;1036.486938965217;1119.1774046076127;1142.1490989212923;1146.931184128955;15126.016808907385;15356.692866142615;15379.538613841603;15680.529584112495;15826.89211755166;508519;512009;513999;514575;515136;57821;57955.13067303994;58077.838443230896;58106.70946645324;58186.709066454394;1227.1226073357413;1285.0426432308177;1354.4243696429176;1383.3429121167364;1383.7785954247474;28448.715512845436;28811.42377152487;30388.784448622693;30777.186100048515;31111.377772444877;48734.512654873;49152.77118072077;49220;49368;49433;454069;457385;457820.63972963614;458112;459973;23923.76076239285;24823.882925268044;38337.4249386265;38746.806265969615;38901.805490972365;34528.44621992067;40054.1989160221;40396.596034040456;40727;40789;29857.25356866096;32478.512822307213;33819.64721411116;34137.146571334924;35163.945081647595;33612.327753444304;33837.32325353529;34332;34708;34761;33105.66894331122;33135.67457301681;33237.667623323454;33558.832205838815;33818.3236335267;29079.85460072686;30756.538651920688;30917;31256;31334.116294759806;22063.33809985703;22959.88520057389;23626.52746945086;24066.75933240645;24926.252212433657 15:10:48 INFO - PROCESS | 1645 | |2;jquery.html;325.6548059057399;352.7918528068439;366.98715544955934;373.6301061948671;398.298993770963;13235.338233088356;13339.666508337297;14054.859451405495;15787.684246315066;20309.289174878846;18966.62066758664;19027.238910443564;19136.521586960334;19315.710264346046;19352.806471935277;5500.944990550093;5874.853128671774;5877.794277200299;5878.823635290927;5886.264216972879;4101.5488296287385;5694.402087780785;5696.857578560528;5703.065732518191;5757.568182386338;5572.749226284827;5620.297462817148;5699.487046165844;5710.743016564244;5719.056355701305;5426.240326354294;5623.353314368859;5692.260006199209;5694.800681976131;5705.515031222351;4956.801727930879;4979.90040199194;4987.351644286256;4990.451050384455;4994.026164897847;23351.76648233513;24595.63106553403;24607.753922460903;24757.87621061901;24844.875775621185;2235.8993845277;2389.0802041214083;2420.0803694596116;2547.961780573274;2680.370113023438;13885.722285554333;14885.479008234659;15005.774913376308;15080.54758357251;15134.167620780852;1810.339226182434;1839.2275244397251;1843.502254391307;1952.7851936286997;1994.9202031918705;108021;112284.43857780659;112364.75270494627;112636.97808350624;112763.43618281938;7549.773506794695;10921.890781092246;10994.120470362512;11091.22361434708;11155.944220278847;13759.931200343934;13768.862311376959;13777.035607507378;13787.51743688966;13799.379027943767;8057.758267251875;8159.714409995621;8187.5087494750505;8312.25189732927;8317.41778075529;8043.758687239392;8072.798180045545;8080.55556944362;8196.959015204886;8209;3513.3851575974104;4375.562443755599;4420.933685994648;4445.755483448442;4559.042601053816;1848.279171123263;1899.534614019574;1915.2147619475948;1923.0961448119363;1942.9417117486498;847.8304339132198;887.1016025704996;905.7282815155427;918.1461241045891;1038.5015192707392;19732.506687332643;20487.8975605124;20489;20506;20774.792252077586;896.8027034052498;947.8436058050345;951.6621599332276;983.3136171465827;986.7089208683312;10379.584816607252;10639.776425711143;10692.213225236304;10725.90887442455;10742.731431714114;515559;516659;519848;528301;529803;83671;106987;118306.90158590511;125211;127494;921.6543796076471;929.9721008369895;976.1751320134475;976.8681228034267;977.022977022977;18230.72653910166;18252.634947301245;18434.078296085412;18464.076796160407;18465.90767046156;38593;50041.24938125858;50499;50718.49281507285;51541.226881596056;69891.30108698847;72791.27208728057;74298;74467;75874.24125758672;7362.595057271901;7593.658285377061;7724.382049436144;7785.416093792875;7928.0576258816955;11851.111166662362;12062.879371206176;12152.453139608562;12452.190607610477;12462.750744985231;10615.787684246117;10621.415822129547;10739.695933294868;10865.293755905841;10906.418569307247;10106.39361638304;10340.37957722539;10633.521491532745;10763.946180269362;10780.029797318279;10520.263581549218;10610.363378197333;10766.084882785051;10833.079188269085;11006.394648294421;7665.616719163908;7715.305622494003;7773.9505166801755;7793.844123117619;8000.159983201913;10030.749231269278;10455.268131230741;10649.307794993301;10674.14606831467;10863.945680271549 15:10:48 INFO - PROCESS | 1645 | |3;mootools.html;1440.6758479342145;1472.5287907869479;1640.4340502526632;1813.084392381847;1832.1022698877555;7003.26465721099;7931;8170.509769413839;8314.251717345438;8351.582420878947;7390.445716571252;7576.318131368176;7584.976028236187;7912.564808935506;8061.113277539466;2251.144565065277;2300.7584203658625;2309.872956987365;2310.549442858643;2315.0392587076344;2315.444293369596;2321.1527792355755;2335.6293362237343;2343.5195784864145;2353.7293211280667;2282.3038973113194;2288.187693368855;2311.064947516653;2318.281332786833;2327.7323107842562;1970.546774241918;2026.0680087159924;2275.3856458756127;2300.194931773866;2307.457747429353;2304.884755762222;2331.9883400583058;2336.2523992322463;2336.9649455258186;2342.004648024583;8044.074931382849;8264;8265.876011859827;8276.544790036605;8340.624671889718;4973.850784476472;5151.4333423323405;5154.53609175176;5157.664751791159;5167.250748641463;3156.0847354267235;3156.842157892096;3188.489841625352;3195.7443404527817;3215.4212241796467;869.2567854484388;995.3579940938126;1049.0977759127145;1066.3921564708119;1068.433730123036;10723;10728.570857165703;10746.838797418044;10753.56985720578;10780.5687772489;4403.251447253974;4511.368408422823;4616.699914505546;4672.159011377917;4672.602828759594;9208.907910920805;9215.354925155174;9216.861747073799;9218.769530761785;9220.308476864262;4306.698531102793;4999.225120106389;5129.230615407719;5136.640435169502;5142.1772516397195;3991.501062367204;4478.462584489882;4568.657350698644;4685.0629874025335;4701.576858082789;3524.3127590120193;3579.7673151245085;3582.408902531053;3651.014226158922;3656.104254457675;962.3263715399248;1123.6797512708838;1130.1298000539539;1133.841262223273;1140.6178930058522;735.3712575747766;872.925801306896;888.6312180445173;935.9719208423758;963.8361478548524;5355.30381050461;5373.570114390839;5634.915476267859;5641;5671;407.13077579368263;414.0394285258232;420.27922113575363;423.05025218384924;431.7517427479212;3117.7973431726864;3558.8077993872344;3756.380197267475;3763.6236376362144;3877.418387241936;9560.521973901277;9828.557714902847;9939.602415903428;9956.402615843073;9977.401355918668;9905.851412228822;9910.20718342531;9913.256505761952;9931.50342482873;9942.95598962113;7308.415326773846;7604;7689.923100769032;7704.8844267336035;7783.299503044753;5282.679330167458;5330.62685612019;5666.941179406586;5790.623609465371;5812.94187058124;8973.820523589622;9131.0412406699;9205.76985575366;9221.354505184572;9320.813583728152;7197.532160409557;8010.599470026592;9023.233025192669;9206.907930920604;9384.108509691569;6902.896456553055;7173.0675012248075;7177.784666460015;7181.138263408425;7184.066071410683;7678;7682.539047657158;7687.923120768721;7762.5342479449155;7776.183500732568;5866.325372582037;5915.290165180206;6948.478864085113;7021.1574611047;7092.574445533284;6743.494237932273;6965.33829286217;6968.233494315723;7003.124609423822;7016.19313778922;6008.939910601013;6219.346968568235;6445.548811583144;6475.643839588868;6559.0817285581015;4685.8594242172785;4785.019071090349;4822.662413631012;4829.154897892925;4834.371531700997;4700.153972284885;4772.284157376422;4794.866284503362;4818.156822555969;4850.878728031827 15:10:48 INFO - PROCESS | 1645 | |4;prototype.html;335.92609625882295;347.7461453139208;348.2495222794878;353.57570914902107;357.75136280285204;5111.948880511199;5136.382039657506;5177.818776342829;5191.273221748954;5230.973845130769;4838.274258861173;4988.850334489971;5009.595394210781;5026.547610715035;5040.949590504094;3519.964800352002;3898.902527436808;3961.810742352405;3972.36442169253;3979.343408337621;4029.1538776856896;4052.2098190852794;4073.3279008963486;4075.4090656854737;4134.193832202722;3124.140861263148;3562.9311206637904;3916.5104361954754;4019.4975628046495;4056.452378928851;4034;4044.1911617676287;4064.9837540614844;4074.5314288856866;4075.7962101894936;3031.7726170537076;3579;3616;3618.782873027627;3625.5105560749225;4169.728967617126;4466.8883277917985;4865.832200271944;5051.848444546669;5075;4508.909821803545;4597.60920321773;4600.815967361302;4617.330487079388;4682.367880336145;5431.864203394907;5442.401335853053;5444.060207487992;5445.319335083114;5446.91829622556;3362.7646064775477;3363.394588973984;3956.8417263309434;3973.8609148679657;3990.8004599770184;4714.457837348748;5233.245566098679;5579.7489112990015;5603.551715862721;5670.234518340054;3591.317649646559;3698.1863989922176;4016.297147999147;4037.799399327315;4040;3438.621751607321;3491.6033586565068;4028.697847661437;4088.202800453883;4139.275626765304;3903.4144878268485;4018.3570628699854;4398.318260669601;4413.404190434315;4611.2852507861335;4414.602685758297;5106.336176297058;5118.718470484159;5350.892982140335;5432.6468779529205;1243.440451796695;1260.3635164241998;1320.9762434113447;1323.6889331007205;1342.6305168727843;786.7915002524336;853.5319250888462;880.7533890510667;893.1738142218422;946.9110522898721;4172.645325147397;4208.831646734157;4437.73524545503;4786.569208771228;4897.853064408074;5075.467075957045;5251.081060814342;5279.630425870152;5286.3920649125075;5296.590051526546;4383.3618096979435;4476.776161191928;4828.975855120702;4862.513748625109;4869.295746488771;2564.910228142006;2750.2849259192353;2763.623283975779;2784.2482529716863;2802.6547257316192;5398.325209348832;5422.674639521641;5441.333746464204;5441.483059109379;5483.341998960151;4706.88232794176;5093.796248150106;5124.92312615311;5277.656952298088;5795.478406943311;5262;5538.78448620555;5561.610687251854;5799.652020878761;5828.504577110993;4962.932969411594;5265.4997775211295;5553.500184983371;5604.663720176803;5615.382307946041;5224.425313215619;5545.750441230073;5584;5584.748686309207;5590.273264475755;4909.901801963869;5252.816151434681;5800.622959507618;5800.883982320414;5822.912656310074;3340.2985373070956;3413.2149605590357;3556.0576447240983;3618.222082252328;3695.8521659133335;4673.112108699336;5551.555875529867;5566.359868615161;5578.386377498553;5651.57613179005;4914.967856750122;4978.800847966041;5430.642339415146;5500.614956952975;5523.861903452445;5140.46025167352;5157.381114266312;5215.634905556574;5336.946630533645;5446.918296225639;4217;5013.273075404119;5243.370795504564;5313.920291195558;5358.892822143614;5298.602604804578;5337.359516858002;5435.483629055233;5436.9126174764415;5492.890142197213;4519.502854686048;4985.825496107619;5345.54562862161;5361.410244873139;5404.43253458397 15:10:48 INFO - PROCESS | 1645 | |5;yui.html;725.166059032113;728.6720975560997;739.1389031777979;762.2872614105811;786.7325109462781;15199.924000379997;15805.84194158058;15839.604009899758;15876.444324448647;15911.84088159118;14221.786673199884;14380.424783008668;14398.640033999156;14402.423903043891;14435.63910902228;687.381356778898;712.1667648850857;715.2454160860291;847.8897743293363;860.6299291304737;846.2130218896424;875.3828550871652;882.5851849630695;899.5771987166022;904.7466709321401;953.5851904421564;954.4416516337951;956.8134213828306;957.3059531839396;959.0074273127315;717.7595505505661;743.0674503498129;943.6791490893095;943.9852158929144;944.8346539355585;677.2550194785746;696.053367420308;696.5472442912147;701.4003027411541;703.3810246982623;14274.214918179496;14284.642883927881;14513.984021118526;14722.969392142555;14783.778243326358;13252.602421927357;13312.733745325038;13317.533886313933;13368.197908125543;13375.99680024002;12140.271583705005;12239.082068844784;12290.20113692607;12364.814527782091;12481.251124932442;3771.3777226757825;4339.457567804025;4339.823501905262;4381.715188512769;4528.162289976365;108501;110246;110428;111021.44489277582;112576.87423125746;10433.426161561187;10543.736406589896;10594.417307048187;10884.292520986111;10974;17944.461666150037;21251.8937405312;21289.148434062772;21296;21370.893145534174;7084.4686648501565;7343.88984165238;7391.223921488274;7435.330820226206;7710.922890771133;4026.4362989181536;4107.979460102681;4270.188664153801;4296.699231053859;4384.69307148503;3260.83695815213;3307.9007629771145;3385.5937287525653;3389.864405423755;3393.5418718473184;527.7729279425351;602.9598941825316;607.1105829959131;615.6921539230385;622.8536293970914;595.675356930474;610.6031079798166;625.0499241153512;629.175779728557;651.3453978751324;8535.274501667427;8837.734867953972;8873;8960.283177345797;9023.233025192932;545.4627192215744;579.0474669169278;606.6936197220375;615.5321955313904;624.2290770897937;3543.9013905689317;4066.898327541835;4169.419947832567;4385.29280063686;4478.350639157304;97666.51166744121;100006.49990250153;104647.47676261723;105238;106879.93120068856;86275.56862215648;87542.56228718943;87977;87999;88200;79103.20896791073;79104.20895791083;81056;82437.58781206295;83281.58359208165;8522.147785221676;8557.187067228604;8561.91438085636;8672.78318042054;8742.152066705148;48856.77858053577;50080.248796267355;51238.48761512337;52510;53331.73334133304;69679;75076.62461687656;75401.24598754161;75609.62195188989;77479;10488.842667360148;10644.520996555328;10816.783664326827;10859.34843909368;11089.556417743523;11995.460204291003;12065.638030859089;12155.453004614637;12527.749445011232;12561.246325220516;11167.441627918734;11261.324320540794;11509.53961841517;11648;11662;10719.624813131502;11143.164262680493;11229;11349;11587.246828956091;10915.781684366428;11353.091752659933;11592.768144637228;11612.129090318429;11662.591809286634;9265;9513.619455221713;9523.761905952406;9573.138417542455;9973.750656233653;8099.87850182236;8888.292692621037;9667.226621870373;9914.553845076845;9922.454265015493 15:10:48 INFO - PROCESS | 1645 | __end_tp_report 15:10:48 INFO - PROCESS | 1645 | __start_cc_report 15:10:48 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,3153 15:10:48 INFO - PROCESS | 1645 | __end_cc_report 15:10:48 INFO - PROCESS | 1645 | __startTimestamp1481497848298__endTimestamp 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | ------- Summary: start ------- 15:10:48 INFO - PROCESS | 1645 | Number of tests: 6 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5671.63 Median:5828.00 stddev:653.27 (11.2%) stddev-sans-first:628.52 15:10:48 INFO - PROCESS | 1645 | Values: 3312.7 3317.2 3338.6 3362.4 3383.3 5519.1 5601.1 5624.2 5633.8 5669.7 5611.8 5640.4 5717.6 5720.2 5738.1 5023.0 5054.9 5094.8 5147.2 5162.4 5225.7 5259.8 5267.5 5278.2 5311.1 5069.8 5169.8 5181.1 5184.6 5269.0 4184.5 5143.2 5163.3 5167.8 5169.3 5100.0 5148.5 5154.0 5167.7 5177.3 5627.5 5637.9 5640.1 5652.2 5704.6 6037.1 6093.4 6105.9 6120.7 6192.3 6224.0 6232.3 6282.7 6282.9 6289.9 5755.1 5756.6 5766.2 5771.0 5803.6 4954.3 6213.7 6237.2 6322.9 6338.0 5993.6 6027.8 6027.9 6041.2 6068.5 6115.2 6160.3 6161.8 6162.9 6165.5 6100.0 6151.0 6152.1 6170.4 6208.8 6141.8 6191.9 6212.5 6216.7 6233.3 4762.3 4814.6 4894.7 4895.2 4907.4 3664.4 4313.2 4366.1 4381.2 4423.3 5691.2 5707.7 5708.9 5722.4 5729.6 6204.7 6205.1 6207.9 6219.6 6223.3 5527.5 5569.6 5582.6 5677.4 5706.0 5334.4 5341.4 5347.6 5355.9 5389.9 6298.4 6298.6 6314.0 6314.1 6319.3 5555.6 6086.3 6119.6 6136.1 6247.7 6241.5 6247.4 6270.2 6286.3 6328.0 6154.8 6171.4 6173.8 6175.6 6188.2 6169.1 6226.9 6231.1 6249.4 6249.8 5807.7 5912.7 5925.1 5981.3 5995.0 5796.5 5978.9 5979.6 5989.1 5993.2 5799.7 5841.5 5847.5 5856.1 5861.9 5985.1 5994.0 5996.8 5999.7 6008.9 5819.1 5822.4 5828.0 5828.9 5832.9 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:59159.95 Median:33987.23 stddev:119224.13 (350.8%) stddev-sans-first:119477.07 15:10:48 INFO - PROCESS | 1645 | Values: 440.8 479.0 490.1 495.0 544.4 30596.4 39524.8 39773.8 42219.2 42343.4 39923.6 40561.9 41170.8 41196.0 41239.6 8222.5 8300.1 9380.4 9380.8 9380.9 8360.4 11057.9 11295.2 11306.7 11318.0 11203.7 11269.5 11286.3 11289.4 11299.4 8397.8 8610.2 11143.9 11243.9 11263.3 8408.1 8473.4 8476.8 10899.2 11214.0 38862.4 39118.0 39170.6 39181.0 39277.6 2918.3 3361.0 3363.6 3582.6 3626.0 29280.0 29454.8 29559.0 30261.8 30885.4 3109.1 3110.6 3142.2 3149.0 3260.3 361243.0 363115.0 364599.0 364950.0 365211.2 61239.0 61656.0 61659.1 61781.0 61796.0 64986.0 65017.7 65061.7 65075.0 65186.7 15526.5 15937.5 15948.0 15951.8 15987.4 11024.6 11295.6 11299.7 12237.9 12325.3 15862.3 15997.4 16003.3 18037.6 18575.8 7006.2 7061.7 7090.6 7136.1 7138.7 896.9 926.4 975.8 987.1 1012.9 26486.0 26524.3 28316.7 29096.7 29946.0 1030.1 1036.5 1119.2 1142.1 1146.9 15126.0 15356.7 15379.5 15680.5 15826.9 508519.0 512009.0 513999.0 514575.0 515136.0 57821.0 57955.1 58077.8 58106.7 58186.7 1227.1 1285.0 1354.4 1383.3 1383.8 28448.7 28811.4 30388.8 30777.2 31111.4 48734.5 49152.8 49220.0 49368.0 49433.0 454069.0 457385.0 457820.6 458112.0 459973.0 23923.8 24823.9 38337.4 38746.8 38901.8 34528.4 40054.2 40396.6 40727.0 40789.0 29857.3 32478.5 33819.6 34137.1 35163.9 33612.3 33837.3 34332.0 34708.0 34761.0 33105.7 33135.7 33237.7 33558.8 33818.3 29079.9 30756.5 30917.0 31256.0 31334.1 22063.3 22959.9 23626.5 24066.8 24926.3 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:31741.86 Median:24801.38 stddev:87326.41 (352.1%) stddev-sans-first:87539.53 15:10:48 INFO - PROCESS | 1645 | Values: 325.7 352.8 367.0 373.6 398.3 13235.3 13339.7 14054.9 15787.7 20309.3 18966.6 19027.2 19136.5 19315.7 19352.8 5500.9 5874.9 5877.8 5878.8 5886.3 4101.5 5694.4 5696.9 5703.1 5757.6 5572.7 5620.3 5699.5 5710.7 5719.1 5426.2 5623.4 5692.3 5694.8 5705.5 4956.8 4979.9 4987.4 4990.5 4994.0 23351.8 24595.6 24607.8 24757.9 24844.9 2235.9 2389.1 2420.1 2548.0 2680.4 13885.7 14885.5 15005.8 15080.5 15134.2 1810.3 1839.2 1843.5 1952.8 1994.9 108021.0 112284.4 112364.8 112637.0 112763.4 7549.8 10921.9 10994.1 11091.2 11155.9 13759.9 13768.9 13777.0 13787.5 13799.4 8057.8 8159.7 8187.5 8312.3 8317.4 8043.8 8072.8 8080.6 8197.0 8209.0 3513.4 4375.6 4420.9 4445.8 4559.0 1848.3 1899.5 1915.2 1923.1 1942.9 847.8 887.1 905.7 918.1 1038.5 19732.5 20487.9 20489.0 20506.0 20774.8 896.8 947.8 951.7 983.3 986.7 10379.6 10639.8 10692.2 10725.9 10742.7 515559.0 516659.0 519848.0 528301.0 529803.0 83671.0 106987.0 118306.9 125211.0 127494.0 921.7 930.0 976.2 976.9 977.0 18230.7 18252.6 18434.1 18464.1 18465.9 38593.0 50041.2 50499.0 50718.5 51541.2 69891.3 72791.3 74298.0 74467.0 75874.2 7362.6 7593.7 7724.4 7785.4 7928.1 11851.1 12062.9 12152.5 12452.2 12462.8 10615.8 10621.4 10739.7 10865.3 10906.4 10106.4 10340.4 10633.5 10763.9 10780.0 10520.3 10610.4 10766.1 10833.1 11006.4 7665.6 7715.3 7774.0 7793.8 8000.2 10030.7 10455.3 10649.3 10674.1 10863.9 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5288.26 Median:5162.46 stddev:2925.31 (56.7%) stddev-sans-first:2919.22 15:10:48 INFO - PROCESS | 1645 | Values: 1440.7 1472.5 1640.4 1813.1 1832.1 7003.3 7931.0 8170.5 8314.3 8351.6 7390.4 7576.3 7585.0 7912.6 8061.1 2251.1 2300.8 2309.9 2310.5 2315.0 2315.4 2321.2 2335.6 2343.5 2353.7 2282.3 2288.2 2311.1 2318.3 2327.7 1970.5 2026.1 2275.4 2300.2 2307.5 2304.9 2332.0 2336.3 2337.0 2342.0 8044.1 8264.0 8265.9 8276.5 8340.6 4973.9 5151.4 5154.5 5157.7 5167.3 3156.1 3156.8 3188.5 3195.7 3215.4 869.3 995.4 1049.1 1066.4 1068.4 10723.0 10728.6 10746.8 10753.6 10780.6 4403.3 4511.4 4616.7 4672.2 4672.6 9208.9 9215.4 9216.9 9218.8 9220.3 4306.7 4999.2 5129.2 5136.6 5142.2 3991.5 4478.5 4568.7 4685.1 4701.6 3524.3 3579.8 3582.4 3651.0 3656.1 962.3 1123.7 1130.1 1133.8 1140.6 735.4 872.9 888.6 936.0 963.8 5355.3 5373.6 5634.9 5641.0 5671.0 407.1 414.0 420.3 423.1 431.8 3117.8 3558.8 3756.4 3763.6 3877.4 9560.5 9828.6 9939.6 9956.4 9977.4 9905.9 9910.2 9913.3 9931.5 9943.0 7308.4 7604.0 7689.9 7704.9 7783.3 5282.7 5330.6 5666.9 5790.6 5812.9 8973.8 9131.0 9205.8 9221.4 9320.8 7197.5 8010.6 9023.2 9206.9 9384.1 6902.9 7173.1 7177.8 7181.1 7184.1 7678.0 7682.5 7687.9 7762.5 7776.2 5866.3 5915.3 6948.5 7021.2 7092.6 6743.5 6965.3 6968.2 7003.1 7016.2 6008.9 6219.3 6445.5 6475.6 6559.1 4685.9 4785.0 4822.7 4829.2 4834.4 4700.2 4772.3 4794.9 4818.2 4850.9 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4379.18 Median:4912.43 stddev:1318.06 (26.8%) stddev-sans-first:1286.34 15:10:48 INFO - PROCESS | 1645 | Values: 335.9 347.7 348.2 353.6 357.8 5111.9 5136.4 5177.8 5191.3 5231.0 4838.3 4988.9 5009.6 5026.5 5040.9 3520.0 3898.9 3961.8 3972.4 3979.3 4029.2 4052.2 4073.3 4075.4 4134.2 3124.1 3562.9 3916.5 4019.5 4056.5 4034.0 4044.2 4065.0 4074.5 4075.8 3031.8 3579.0 3616.0 3618.8 3625.5 4169.7 4466.9 4865.8 5051.8 5075.0 4508.9 4597.6 4600.8 4617.3 4682.4 5431.9 5442.4 5444.1 5445.3 5446.9 3362.8 3363.4 3956.8 3973.9 3990.8 4714.5 5233.2 5579.7 5603.6 5670.2 3591.3 3698.2 4016.3 4037.8 4040.0 3438.6 3491.6 4028.7 4088.2 4139.3 3903.4 4018.4 4398.3 4413.4 4611.3 4414.6 5106.3 5118.7 5350.9 5432.6 1243.4 1260.4 1321.0 1323.7 1342.6 786.8 853.5 880.8 893.2 946.9 4172.6 4208.8 4437.7 4786.6 4897.9 5075.5 5251.1 5279.6 5286.4 5296.6 4383.4 4476.8 4829.0 4862.5 4869.3 2564.9 2750.3 2763.6 2784.2 2802.7 5398.3 5422.7 5441.3 5441.5 5483.3 4706.9 5093.8 5124.9 5277.7 5795.5 5262.0 5538.8 5561.6 5799.7 5828.5 4962.9 5265.5 5553.5 5604.7 5615.4 5224.4 5545.8 5584.0 5584.7 5590.3 4909.9 5252.8 5800.6 5800.9 5822.9 3340.3 3413.2 3556.1 3618.2 3695.9 4673.1 5551.6 5566.4 5578.4 5651.6 4915.0 4978.8 5430.6 5500.6 5523.9 5140.5 5157.4 5215.6 5336.9 5446.9 4217.0 5013.3 5243.4 5313.9 5358.9 5298.6 5337.4 5435.5 5436.9 5492.9 4519.5 4985.8 5345.5 5361.4 5404.4 15:10:48 INFO - PROCESS | 1645 | 15:10:48 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20360.27 Median:50659.37 stddev:30353.73 (59.9%) stddev-sans-first:30403.07 15:10:48 INFO - PROCESS | 1645 | Values: 725.2 728.7 739.1 762.3 786.7 15199.9 15805.8 15839.6 15876.4 15911.8 14221.8 14380.4 14398.6 14402.4 14435.6 687.4 712.2 715.2 847.9 860.6 846.2 875.4 882.6 899.6 904.7 953.6 954.4 956.8 957.3 959.0 717.8 743.1 943.7 944.0 944.8 677.3 696.1 696.5 701.4 703.4 14274.2 14284.6 14514.0 14723.0 14783.8 13252.6 13312.7 13317.5 13368.2 13376.0 12140.3 12239.1 12290.2 12364.8 12481.3 3771.4 4339.5 4339.8 4381.7 4528.2 108501.0 110246.0 110428.0 111021.4 112576.9 10433.4 10543.7 10594.4 10884.3 10974.0 17944.5 21251.9 21289.1 21296.0 21370.9 7084.5 7343.9 7391.2 7435.3 7710.9 4026.4 4108.0 4270.2 4296.7 4384.7 3260.8 3307.9 3385.6 3389.9 3393.5 527.8 603.0 607.1 615.7 622.9 595.7 610.6 625.0 629.2 651.3 8535.3 8837.7 8873.0 8960.3 9023.2 545.5 579.0 606.7 615.5 624.2 3543.9 4066.9 4169.4 4385.3 4478.4 97666.5 100006.5 104647.5 105238.0 106879.9 86275.6 87542.6 87977.0 87999.0 88200.0 79103.2 79104.2 81056.0 82437.6 83281.6 8522.1 8557.2 8561.9 8672.8 8742.2 48856.8 50080.2 51238.5 52510.0 53331.7 69679.0 75076.6 75401.2 75609.6 77479.0 10488.8 10644.5 10816.8 10859.3 11089.6 11995.5 12065.6 12155.5 12527.7 12561.2 11167.4 11261.3 11509.5 11648.0 11662.0 10719.6 11143.2 11229.0 11349.0 11587.2 10915.8 11353.1 11592.8 11612.1 11662.6 9265.0 9513.6 9523.8 9573.1 9973.8 8099.9 8888.3 9667.2 9914.6 9922.5 15:10:48 INFO - PROCESS | 1645 | -------- Summary: end -------- 15:10:48 INFO - PROCESS | 1645 | 15:10:49 INFO - TEST-INFO | 1645: exit 0 15:10:49 INFO - TEST-OK | dromaeo_css | took 1119672ms 15:10:49 INFO - TEST-START | kraken 15:10:49 INFO - operating with platform_type : mac_ 15:10:49 INFO - Initialising browser for kraken test... 15:10:49 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpvPuSvp/profile http://localhost:49251/getInfo.html) 15:10:51 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 15:10:51 INFO - PROCESS | 1655 | colorDepth:24 15:10:51 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 15:10:51 INFO - PROCESS | 1655 | __metrics 15:10:51 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:10:51 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:10:52 INFO - TEST-INFO | 1655: exit 0 15:10:52 INFO - Browser initialized. 15:10:52 INFO - Running cycle 1/1 for kraken test... 15:10:52 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpvPuSvp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:04 INFO - PROCESS | 1656 | RSS: Main: 228593664 15:11:04 INFO - PROCESS | 1656 | 15:11:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:08 INFO - PROCESS | 1656 | RSS: Main: 289271808 15:11:08 INFO - PROCESS | 1656 | 15:11:10 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 15:11:11 INFO - PROCESS | 1656 | RSS: Main: 291438592 15:11:11 INFO - PROCESS | 1656 | 15:11:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 15:11:15 INFO - PROCESS | 1656 | RSS: Main: 382050304 15:11:15 INFO - PROCESS | 1656 | 15:11:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 15:11:18 INFO - PROCESS | 1656 | RSS: Main: 285704192 15:11:18 INFO - PROCESS | 1656 | 15:11:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:11:20 INFO - PROCESS | 1656 | RSS: Main: 289288192 15:11:20 INFO - PROCESS | 1656 | 15:11:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:24 INFO - PROCESS | 1656 | RSS: Main: 331587584 15:11:24 INFO - PROCESS | 1656 | 15:11:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:28 INFO - PROCESS | 1656 | RSS: Main: 334073856 15:11:28 INFO - PROCESS | 1656 | 15:11:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 15:11:31 INFO - PROCESS | 1656 | RSS: Main: 332902400 15:11:31 INFO - PROCESS | 1656 | 15:11:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:33 INFO - PROCESS | 1656 | RSS: Main: 306569216 15:11:33 INFO - PROCESS | 1656 | 15:11:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:36 INFO - PROCESS | 1656 | RSS: Main: 309682176 15:11:36 INFO - PROCESS | 1656 | 15:11:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:39 INFO - PROCESS | 1656 | RSS: Main: 311123968 15:11:39 INFO - PROCESS | 1656 | 15:11:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:42 INFO - PROCESS | 1656 | RSS: Main: 329756672 15:11:42 INFO - PROCESS | 1656 | 15:11:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:46 INFO - PROCESS | 1656 | RSS: Main: 322998272 15:11:46 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 15:11:48 INFO - PROCESS | 1656 | RSS: Main: 367022080 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | __start_tp_report 15:11:48 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 15:11:48 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 15:11:48 INFO - PROCESS | 1656 | |i|pagename|runs| 15:11:48 INFO - PROCESS | 1656 | |0;ai-astar;112;116;115;114;114;114;113;113;115;113 15:11:48 INFO - PROCESS | 1656 | |1;audio-beat-detection;154;103;122;189;98;146;145;145;130;115 15:11:48 INFO - PROCESS | 1656 | |2;audio-dft;183;182;202;269;182;183;182;184;183;182 15:11:48 INFO - PROCESS | 1656 | |3;audio-fft;79;60;59;87;63;75;83;84;87;58 15:11:48 INFO - PROCESS | 1656 | |4;audio-oscillator;94;71;86;68;68;69;84;68;70;84 15:11:48 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;111;112;110;113;109;113;111;114;109;111 15:11:48 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;95;95;94;94;98;96;95;95;96 15:11:48 INFO - PROCESS | 1656 | |7;imaging-desaturate;85;92;88;85;87;87;87;87;87;85 15:11:48 INFO - PROCESS | 1656 | |8;json-parse-financial;55;55;55;55;56;55;55;57;55;55 15:11:48 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;65;73;78;76;73;70;71;72;72;72 15:11:48 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;99;110;88;89;90;88;95;91;95;88 15:11:48 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;150;147;148;150;147;149;145;140;229;154 15:11:48 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;177;178;178;176;179;178;175;176;188;152 15:11:48 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;69;67;68;68;68;67;66;67;66;67 15:11:48 INFO - PROCESS | 1656 | __end_tp_report 15:11:48 INFO - PROCESS | 1656 | __start_cc_report 15:11:48 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2134 15:11:48 INFO - PROCESS | 1656 | __end_cc_report 15:11:48 INFO - PROCESS | 1656 | __startTimestamp1481497908598__endTimestamp 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | ------- Summary: start ------- 15:11:48 INFO - PROCESS | 1656 | Number of tests: 14 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:1.05 15:11:48 INFO - PROCESS | 1656 | Values: 112.0 116.0 115.0 114.0 114.0 114.0 113.0 113.0 115.0 113.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:145.50 stddev:27.05 (18.6%) stddev-sans-first:27.77 15:11:48 INFO - PROCESS | 1656 | Values: 154.0 103.0 122.0 189.0 98.0 146.0 145.0 145.0 130.0 115.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:193.20 Median:183.00 stddev:27.33 (14.9%) stddev-sans-first:28.74 15:11:48 INFO - PROCESS | 1656 | Values: 183.0 182.0 202.0 269.0 182.0 183.0 182.0 184.0 183.0 182.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:73.50 Median:81.00 stddev:12.20 (15.1%) stddev-sans-first:12.78 15:11:48 INFO - PROCESS | 1656 | Values: 79.0 60.0 59.0 87.0 63.0 75.0 83.0 84.0 87.0 58.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.50 stddev:9.74 (12.6%) stddev-sans-first:7.92 15:11:48 INFO - PROCESS | 1656 | Values: 94.0 71.0 86.0 68.0 68.0 69.0 84.0 68.0 70.0 84.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:111.30 Median:111.50 stddev:1.70 (1.5%) stddev-sans-first:1.80 15:11:48 INFO - PROCESS | 1656 | Values: 111.0 112.0 110.0 113.0 109.0 113.0 111.0 114.0 109.0 111.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:1.22 15:11:48 INFO - PROCESS | 1656 | Values: 94.0 95.0 95.0 94.0 94.0 98.0 96.0 95.0 95.0 96.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:87.00 stddev:2.05 (2.4%) stddev-sans-first:2.05 15:11:48 INFO - PROCESS | 1656 | Values: 85.0 92.0 88.0 85.0 87.0 87.0 87.0 87.0 87.0 85.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 15:11:48 INFO - PROCESS | 1656 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 55.0 57.0 55.0 55.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.50 stddev:3.46 (4.8%) stddev-sans-first:2.50 15:11:48 INFO - PROCESS | 1656 | Values: 65.0 73.0 78.0 76.0 73.0 70.0 71.0 72.0 72.0 72.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:90.50 stddev:6.96 (7.7%) stddev-sans-first:7.07 15:11:48 INFO - PROCESS | 1656 | Values: 99.0 110.0 88.0 89.0 90.0 88.0 95.0 91.0 95.0 88.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:149.50 stddev:25.94 (17.4%) stddev-sans-first:27.43 15:11:48 INFO - PROCESS | 1656 | Values: 150.0 147.0 148.0 150.0 147.0 149.0 145.0 140.0 229.0 154.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:178.00 stddev:9.08 (5.1%) stddev-sans-first:9.62 15:11:48 INFO - PROCESS | 1656 | Values: 177.0 178.0 178.0 176.0 179.0 178.0 175.0 176.0 188.0 152.0 15:11:48 INFO - PROCESS | 1656 | 15:11:48 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:0.78 15:11:48 INFO - PROCESS | 1656 | Values: 69.0 67.0 68.0 68.0 68.0 67.0 66.0 67.0 66.0 67.0 15:11:48 INFO - PROCESS | 1656 | -------- Summary: end -------- 15:11:48 INFO - PROCESS | 1656 | 15:11:49 INFO - TEST-INFO | 1656: exit 0 15:11:49 INFO - TEST-OK | kraken | took 60380ms 15:11:49 INFO - SUITE-END | took 1180s 15:11:49 INFO - Completed test suite (00:19:40) 15:11:49 INFO - javascript benchmark 15:11:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.685294896984, 3317.187289114167, 3338.582677165354, 3362.361151381239, 3383.340248651514, 5519.089350257203, 5601.07582248929, 5624.21261023456, 5633.8309850704445, 5669.688167150805, 5611.831645050655, 5640.351359593648, 5717.6283541569765, 5720.170575266584, 5738.081906894908, 5022.974885125569, 5054.898902021957, 5094.847154585368, 5147.22791581262, 5162.432132465426, 5225.686458812484, 5259.8422047338645, 5267.499587539178, 5278.2082687596785, 5311.123664595337, 5069.77186026626, 5169.819056333048, 5181.0674078665825, 5184.637075404723, 5269.0, 4184.456020717318, 5143.177091665316, 5163.277141200235, 5167.767450464738, 5169.276301317781, 5099.974500127476, 5148.459411761749, 5153.9742301288625, 5167.689938603696, 5177.326947496839, 5627.54979601635, 5637.8590535236535, 5640.0693885508845, 5652.180433837112, 5704.572157088193, 6037.0642550404755, 6093.421124993119, 6105.938940610581, 6120.660465672121, 6192.28788689302, 6224.0, 6232.3144454110015, 6282.654454005028, 6282.874342513124, 6289.937100628981, 5755.1367294906095, 5756.619018023617, 5766.163906233656, 5771.0, 5803.622764520335, 4954.3311652926395, 6213.689315534296, 6237.220347456568, 6322.936770632326, 6337.9683101585115, 5993.550483713739, 6027.7890273841085, 6027.8794424111275, 6041.154238406627, 6068.453839154409, 6115.179495343508, 6160.260768707783, 6161.784337548164, 6162.876742465126, 6165.506759459233, 6099.99401472374, 6151.0, 6152.107944348045, 6170.413810687977, 6208.81373558794, 6141.84645383869, 6191.876162476725, 6212.47193988507, 6216.689165541705, 6233.34549872266, 4762.261849413347, 4814.5907597853875, 4894.657373983858, 4895.216765317532, 4907.435644900882, 3664.358737221029, 4313.180495705806, 4366.083122544238, 4381.16757816014, 4423.270160423558, 5691.203231547586, 5707.74315155819, 5708.885822283614, 5722.399148089391, 5729.5702822288495, 6204.720787564571, 6205.100260462208, 6207.937920620736, 6219.626822390671, 6223.3465486123305, 5527.53015993645, 5569.637973531708, 5582.637128586629, 5677.37548869624, 5706.029974904276, 5334.413214546396, 5341.359036915595, 5347.598930080259, 5355.946440535623, 5389.946100538945, 6298.370162983848, 6298.590591611531, 6313.989761638116, 6314.147590075281, 6319.304876463677, 5555.611107222618, 6086.269647642134, 6119.571629985859, 6136.059583474621, 6247.656378899204, 6241.531885108726, 6247.406496382836, 6270.2475702915945, 6286.339934306832, 6328.0, 6154.846128846814, 6171.413715697002, 6173.783917563043, 6175.59858609189, 6188.226471691039, 6169.136320915165, 6226.937730622817, 6231.065340198825, 6249.406306400884, 6249.78125765596, 5807.680577568105, 5912.733926973383, 5925.081612350093, 5981.312149102909, 5995.040793473024, 5796.478316951495, 5978.940210597838, 5979.551533634908, 5989.071693887455, 5993.190919225849, 5799.681017544076, 5841.50347220491, 5847.473727364558, 5856.092305692625, 5861.853453663693, 5985.132155837292, 5994.0109881869, 5996.820095397145, 5999.730012149551, 6008.909866351921, 5819.127130930395, 5822.446867547576, 5828.0, 5828.854278643068, 5832.912506312324], "value": 5629.121891299378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.79503031090536, 478.9521047895211, 490.0835437731443, 495.01739047989736, 544.382126286665, 30596.38807223857, 39524.802375988154, 39773.80113099434, 42219.15561688764, 42343.36484952721, 39923.60267390642, 40561.901667208265, 41170.7941460293, 41196.0, 41239.587604123946, 8222.547759873205, 8300.12848650892, 9380.437173769562, 9380.812383752322, 9380.8592871107, 8360.414770966036, 11057.944710276437, 11295.152863535268, 11306.660800175967, 11318.0, 11203.66389008327, 11269.54921803131, 11286.322820630747, 11289.379084150369, 11299.378534180616, 8397.832043359098, 8610.225079742853, 11143.944280278587, 11243.943780281088, 11263.26788758728, 8408.075111737704, 8473.449225800303, 8476.83046339076, 10899.237053406265, 11213.990740833364, 38862.41706374407, 39118.02204944871, 39170.60829391698, 39181.0, 39277.607223927684, 2918.2996080940634, 3360.983195084009, 3363.5795525559306, 3582.6417358264225, 3625.981870090659, 29280.0, 29454.82180712769, 29559.0, 30261.848690756626, 30885.38229235425, 3109.113902537766, 3110.6111736032994, 3142.245860993345, 3148.968510314913, 3260.2827377976805, 361243.0, 363115.0, 364599.0, 364950.0, 365211.17394413124, 61239.0, 61656.0, 61659.075113873325, 61781.0, 61796.0, 64986.0, 65017.67491162608, 65061.67469162624, 65075.02387464192, 65186.67406663031, 15526.534203973899, 15937.521874343789, 15948.043117412992, 15951.840481595267, 15987.36050557988, 11024.559017639365, 11295.604653837241, 11299.717507062225, 12237.877621223852, 12325.260484370787, 15862.286197121157, 15997.360105595879, 16003.27985240667, 18037.639247215244, 18575.81424185768, 7006.229314775371, 7061.682224299816, 7090.574565526085, 7136.0723105995885, 7138.714451421989, 896.9372143949861, 926.420986883198, 975.843625304017, 987.0770829274651, 1012.9290949633455, 26486.0, 26524.336891577866, 28316.71683283182, 29096.7090329094, 29946.0, 1030.1346868630387, 1036.486938965217, 1119.1774046076127, 1142.1490989212923, 1146.931184128955, 15126.016808907385, 15356.692866142615, 15379.538613841603, 15680.529584112495, 15826.89211755166, 508519.0, 512009.0, 513999.0, 514575.0, 515136.0, 57821.0, 57955.13067303994, 58077.838443230896, 58106.70946645324, 58186.709066454394, 1227.1226073357413, 1285.0426432308177, 1354.4243696429176, 1383.3429121167364, 1383.7785954247474, 28448.715512845436, 28811.42377152487, 30388.784448622693, 30777.186100048515, 31111.377772444877, 48734.512654873, 49152.77118072077, 49220.0, 49368.0, 49433.0, 454069.0, 457385.0, 457820.63972963614, 458112.0, 459973.0, 23923.76076239285, 24823.882925268044, 38337.4249386265, 38746.806265969615, 38901.805490972365, 34528.44621992067, 40054.1989160221, 40396.596034040456, 40727.0, 40789.0, 29857.25356866096, 32478.512822307213, 33819.64721411116, 34137.146571334924, 35163.945081647595, 33612.327753444304, 33837.32325353529, 34332.0, 34708.0, 34761.0, 33105.66894331122, 33135.67457301681, 33237.667623323454, 33558.832205838815, 33818.3236335267, 29079.85460072686, 30756.538651920688, 30917.0, 31256.0, 31334.116294759806, 22063.33809985703, 22959.88520057389, 23626.52746945086, 24066.75933240645, 24926.252212433657], "value": 19130.600456938675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.6548059057399, 352.7918528068439, 366.98715544955934, 373.6301061948671, 398.298993770963, 13235.338233088356, 13339.666508337297, 14054.859451405495, 15787.684246315066, 20309.289174878846, 18966.62066758664, 19027.238910443564, 19136.521586960334, 19315.710264346046, 19352.806471935277, 5500.944990550093, 5874.853128671774, 5877.794277200299, 5878.823635290927, 5886.264216972879, 4101.5488296287385, 5694.402087780785, 5696.857578560528, 5703.065732518191, 5757.568182386338, 5572.749226284827, 5620.297462817148, 5699.487046165844, 5710.743016564244, 5719.056355701305, 5426.240326354294, 5623.353314368859, 5692.260006199209, 5694.800681976131, 5705.515031222351, 4956.801727930879, 4979.90040199194, 4987.351644286256, 4990.451050384455, 4994.026164897847, 23351.76648233513, 24595.63106553403, 24607.753922460903, 24757.87621061901, 24844.875775621185, 2235.8993845277, 2389.0802041214083, 2420.0803694596116, 2547.961780573274, 2680.370113023438, 13885.722285554333, 14885.479008234659, 15005.774913376308, 15080.54758357251, 15134.167620780852, 1810.339226182434, 1839.2275244397251, 1843.502254391307, 1952.7851936286997, 1994.9202031918705, 108021.0, 112284.43857780659, 112364.75270494627, 112636.97808350624, 112763.43618281938, 7549.773506794695, 10921.890781092246, 10994.120470362512, 11091.22361434708, 11155.944220278847, 13759.931200343934, 13768.862311376959, 13777.035607507378, 13787.51743688966, 13799.379027943767, 8057.758267251875, 8159.714409995621, 8187.5087494750505, 8312.25189732927, 8317.41778075529, 8043.758687239392, 8072.798180045545, 8080.55556944362, 8196.959015204886, 8209.0, 3513.3851575974104, 4375.562443755599, 4420.933685994648, 4445.755483448442, 4559.042601053816, 1848.279171123263, 1899.534614019574, 1915.2147619475948, 1923.0961448119363, 1942.9417117486498, 847.8304339132198, 887.1016025704996, 905.7282815155427, 918.1461241045891, 1038.5015192707392, 19732.506687332643, 20487.8975605124, 20489.0, 20506.0, 20774.792252077586, 896.8027034052498, 947.8436058050345, 951.6621599332276, 983.3136171465827, 986.7089208683312, 10379.584816607252, 10639.776425711143, 10692.213225236304, 10725.90887442455, 10742.731431714114, 515559.0, 516659.0, 519848.0, 528301.0, 529803.0, 83671.0, 106987.0, 118306.90158590511, 125211.0, 127494.0, 921.6543796076471, 929.9721008369895, 976.1751320134475, 976.8681228034267, 977.022977022977, 18230.72653910166, 18252.634947301245, 18434.078296085412, 18464.076796160407, 18465.90767046156, 38593.0, 50041.24938125858, 50499.0, 50718.49281507285, 51541.226881596056, 69891.30108698847, 72791.27208728057, 74298.0, 74467.0, 75874.24125758672, 7362.595057271901, 7593.658285377061, 7724.382049436144, 7785.416093792875, 7928.0576258816955, 11851.111166662362, 12062.879371206176, 12152.453139608562, 12452.190607610477, 12462.750744985231, 10615.787684246117, 10621.415822129547, 10739.695933294868, 10865.293755905841, 10906.418569307247, 10106.39361638304, 10340.37957722539, 10633.521491532745, 10763.946180269362, 10780.029797318279, 10520.263581549218, 10610.363378197333, 10766.084882785051, 10833.079188269085, 11006.394648294421, 7665.616719163908, 7715.305622494003, 7773.9505166801755, 7793.844123117619, 8000.159983201913, 10030.749231269278, 10455.268131230741, 10649.307794993301, 10674.14606831467, 10863.945680271549], "value": 9201.890928960684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.6758479342145, 1472.5287907869479, 1640.4340502526632, 1813.084392381847, 1832.1022698877555, 7003.26465721099, 7931.0, 8170.509769413839, 8314.251717345438, 8351.582420878947, 7390.445716571252, 7576.318131368176, 7584.976028236187, 7912.564808935506, 8061.113277539466, 2251.144565065277, 2300.7584203658625, 2309.872956987365, 2310.549442858643, 2315.0392587076344, 2315.444293369596, 2321.1527792355755, 2335.6293362237343, 2343.5195784864145, 2353.7293211280667, 2282.3038973113194, 2288.187693368855, 2311.064947516653, 2318.281332786833, 2327.7323107842562, 1970.546774241918, 2026.0680087159924, 2275.3856458756127, 2300.194931773866, 2307.457747429353, 2304.884755762222, 2331.9883400583058, 2336.2523992322463, 2336.9649455258186, 2342.004648024583, 8044.074931382849, 8264.0, 8265.876011859827, 8276.544790036605, 8340.624671889718, 4973.850784476472, 5151.4333423323405, 5154.53609175176, 5157.664751791159, 5167.250748641463, 3156.0847354267235, 3156.842157892096, 3188.489841625352, 3195.7443404527817, 3215.4212241796467, 869.2567854484388, 995.3579940938126, 1049.0977759127145, 1066.3921564708119, 1068.433730123036, 10723.0, 10728.570857165703, 10746.838797418044, 10753.56985720578, 10780.5687772489, 4403.251447253974, 4511.368408422823, 4616.699914505546, 4672.159011377917, 4672.602828759594, 9208.907910920805, 9215.354925155174, 9216.861747073799, 9218.769530761785, 9220.308476864262, 4306.698531102793, 4999.225120106389, 5129.230615407719, 5136.640435169502, 5142.1772516397195, 3991.501062367204, 4478.462584489882, 4568.657350698644, 4685.0629874025335, 4701.576858082789, 3524.3127590120193, 3579.7673151245085, 3582.408902531053, 3651.014226158922, 3656.104254457675, 962.3263715399248, 1123.6797512708838, 1130.1298000539539, 1133.841262223273, 1140.6178930058522, 735.3712575747766, 872.925801306896, 888.6312180445173, 935.9719208423758, 963.8361478548524, 5355.30381050461, 5373.570114390839, 5634.915476267859, 5641.0, 5671.0, 407.13077579368263, 414.0394285258232, 420.27922113575363, 423.05025218384924, 431.7517427479212, 3117.7973431726864, 3558.8077993872344, 3756.380197267475, 3763.6236376362144, 3877.418387241936, 9560.521973901277, 9828.557714902847, 9939.602415903428, 9956.402615843073, 9977.401355918668, 9905.851412228822, 9910.20718342531, 9913.256505761952, 9931.50342482873, 9942.95598962113, 7308.415326773846, 7604.0, 7689.923100769032, 7704.8844267336035, 7783.299503044753, 5282.679330167458, 5330.62685612019, 5666.941179406586, 5790.623609465371, 5812.94187058124, 8973.820523589622, 9131.0412406699, 9205.76985575366, 9221.354505184572, 9320.813583728152, 7197.532160409557, 8010.599470026592, 9023.233025192669, 9206.907930920604, 9384.108509691569, 6902.896456553055, 7173.0675012248075, 7177.784666460015, 7181.138263408425, 7184.066071410683, 7678.0, 7682.539047657158, 7687.923120768721, 7762.5342479449155, 7776.183500732568, 5866.325372582037, 5915.290165180206, 6948.478864085113, 7021.1574611047, 7092.574445533284, 6743.494237932273, 6965.33829286217, 6968.233494315723, 7003.124609423822, 7016.19313778922, 6008.939910601013, 6219.346968568235, 6445.548811583144, 6475.643839588868, 6559.0817285581015, 4685.8594242172785, 4785.019071090349, 4822.662413631012, 4829.154897892925, 4834.371531700997, 4700.153972284885, 4772.284157376422, 4794.866284503362, 4818.156822555969, 4850.878728031827], "value": 4210.224436222034, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.92609625882295, 347.7461453139208, 348.2495222794878, 353.57570914902107, 357.75136280285204, 5111.948880511199, 5136.382039657506, 5177.818776342829, 5191.273221748954, 5230.973845130769, 4838.274258861173, 4988.850334489971, 5009.595394210781, 5026.547610715035, 5040.949590504094, 3519.964800352002, 3898.902527436808, 3961.810742352405, 3972.36442169253, 3979.343408337621, 4029.1538776856896, 4052.2098190852794, 4073.3279008963486, 4075.4090656854737, 4134.193832202722, 3124.140861263148, 3562.9311206637904, 3916.5104361954754, 4019.4975628046495, 4056.452378928851, 4034.0, 4044.1911617676287, 4064.9837540614844, 4074.5314288856866, 4075.7962101894936, 3031.7726170537076, 3579.0, 3616.0, 3618.782873027627, 3625.5105560749225, 4169.728967617126, 4466.8883277917985, 4865.832200271944, 5051.848444546669, 5075.0, 4508.909821803545, 4597.60920321773, 4600.815967361302, 4617.330487079388, 4682.367880336145, 5431.864203394907, 5442.401335853053, 5444.060207487992, 5445.319335083114, 5446.91829622556, 3362.7646064775477, 3363.394588973984, 3956.8417263309434, 3973.8609148679657, 3990.8004599770184, 4714.457837348748, 5233.245566098679, 5579.7489112990015, 5603.551715862721, 5670.234518340054, 3591.317649646559, 3698.1863989922176, 4016.297147999147, 4037.799399327315, 4040.0, 3438.621751607321, 3491.6033586565068, 4028.697847661437, 4088.202800453883, 4139.275626765304, 3903.4144878268485, 4018.3570628699854, 4398.318260669601, 4413.404190434315, 4611.2852507861335, 4414.602685758297, 5106.336176297058, 5118.718470484159, 5350.892982140335, 5432.6468779529205, 1243.440451796695, 1260.3635164241998, 1320.9762434113447, 1323.6889331007205, 1342.6305168727843, 786.7915002524336, 853.5319250888462, 880.7533890510667, 893.1738142218422, 946.9110522898721, 4172.645325147397, 4208.831646734157, 4437.73524545503, 4786.569208771228, 4897.853064408074, 5075.467075957045, 5251.081060814342, 5279.630425870152, 5286.3920649125075, 5296.590051526546, 4383.3618096979435, 4476.776161191928, 4828.975855120702, 4862.513748625109, 4869.295746488771, 2564.910228142006, 2750.2849259192353, 2763.623283975779, 2784.2482529716863, 2802.6547257316192, 5398.325209348832, 5422.674639521641, 5441.333746464204, 5441.483059109379, 5483.341998960151, 4706.88232794176, 5093.796248150106, 5124.92312615311, 5277.656952298088, 5795.478406943311, 5262.0, 5538.78448620555, 5561.610687251854, 5799.652020878761, 5828.504577110993, 4962.932969411594, 5265.4997775211295, 5553.500184983371, 5604.663720176803, 5615.382307946041, 5224.425313215619, 5545.750441230073, 5584.0, 5584.748686309207, 5590.273264475755, 4909.901801963869, 5252.816151434681, 5800.622959507618, 5800.883982320414, 5822.912656310074, 3340.2985373070956, 3413.2149605590357, 3556.0576447240983, 3618.222082252328, 3695.8521659133335, 4673.112108699336, 5551.555875529867, 5566.359868615161, 5578.386377498553, 5651.57613179005, 4914.967856750122, 4978.800847966041, 5430.642339415146, 5500.614956952975, 5523.861903452445, 5140.46025167352, 5157.381114266312, 5215.634905556574, 5336.946630533645, 5446.918296225639, 4217.0, 5013.273075404119, 5243.370795504564, 5313.920291195558, 5358.892822143614, 5298.602604804578, 5337.359516858002, 5435.483629055233, 5436.9126174764415, 5492.890142197213, 4519.502854686048, 4985.825496107619, 5345.54562862161, 5361.410244873139, 5404.43253458397], "value": 3974.2067922335473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.166059032113, 728.6720975560997, 739.1389031777979, 762.2872614105811, 786.7325109462781, 15199.924000379997, 15805.84194158058, 15839.604009899758, 15876.444324448647, 15911.84088159118, 14221.786673199884, 14380.424783008668, 14398.640033999156, 14402.423903043891, 14435.63910902228, 687.381356778898, 712.1667648850857, 715.2454160860291, 847.8897743293363, 860.6299291304737, 846.2130218896424, 875.3828550871652, 882.5851849630695, 899.5771987166022, 904.7466709321401, 953.5851904421564, 954.4416516337951, 956.8134213828306, 957.3059531839396, 959.0074273127315, 717.7595505505661, 743.0674503498129, 943.6791490893095, 943.9852158929144, 944.8346539355585, 677.2550194785746, 696.053367420308, 696.5472442912147, 701.4003027411541, 703.3810246982623, 14274.214918179496, 14284.642883927881, 14513.984021118526, 14722.969392142555, 14783.778243326358, 13252.602421927357, 13312.733745325038, 13317.533886313933, 13368.197908125543, 13375.99680024002, 12140.271583705005, 12239.082068844784, 12290.20113692607, 12364.814527782091, 12481.251124932442, 3771.3777226757825, 4339.457567804025, 4339.823501905262, 4381.715188512769, 4528.162289976365, 108501.0, 110246.0, 110428.0, 111021.44489277582, 112576.87423125746, 10433.426161561187, 10543.736406589896, 10594.417307048187, 10884.292520986111, 10974.0, 17944.461666150037, 21251.8937405312, 21289.148434062772, 21296.0, 21370.893145534174, 7084.4686648501565, 7343.88984165238, 7391.223921488274, 7435.330820226206, 7710.922890771133, 4026.4362989181536, 4107.979460102681, 4270.188664153801, 4296.699231053859, 4384.69307148503, 3260.83695815213, 3307.9007629771145, 3385.5937287525653, 3389.864405423755, 3393.5418718473184, 527.7729279425351, 602.9598941825316, 607.1105829959131, 615.6921539230385, 622.8536293970914, 595.675356930474, 610.6031079798166, 625.0499241153512, 629.175779728557, 651.3453978751324, 8535.274501667427, 8837.734867953972, 8873.0, 8960.283177345797, 9023.233025192932, 545.4627192215744, 579.0474669169278, 606.6936197220375, 615.5321955313904, 624.2290770897937, 3543.9013905689317, 4066.898327541835, 4169.419947832567, 4385.29280063686, 4478.350639157304, 97666.51166744121, 100006.49990250153, 104647.47676261723, 105238.0, 106879.93120068856, 86275.56862215648, 87542.56228718943, 87977.0, 87999.0, 88200.0, 79103.20896791073, 79104.20895791083, 81056.0, 82437.58781206295, 83281.58359208165, 8522.147785221676, 8557.187067228604, 8561.91438085636, 8672.78318042054, 8742.152066705148, 48856.77858053577, 50080.248796267355, 51238.48761512337, 52510.0, 53331.73334133304, 69679.0, 75076.62461687656, 75401.24598754161, 75609.62195188989, 77479.0, 10488.842667360148, 10644.520996555328, 10816.783664326827, 10859.34843909368, 11089.556417743523, 11995.460204291003, 12065.638030859089, 12155.453004614637, 12527.749445011232, 12561.246325220516, 11167.441627918734, 11261.324320540794, 11509.53961841517, 11648.0, 11662.0, 10719.624813131502, 11143.164262680493, 11229.0, 11349.0, 11587.246828956091, 10915.781684366428, 11353.091752659933, 11592.768144637228, 11612.129090318429, 11662.591809286634, 9265.0, 9513.619455221713, 9523.761905952406, 9573.138417542455, 9973.750656233653, 8099.87850182236, 8888.292692621037, 9667.226621870373, 9914.553845076845, 9922.454265015493], "value": 7149.019112152131, "unit": "score"}], "name": "dromaeo_css", "value": 7008.893961954868, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 103.0, 122.0, 189.0, 98.0, 146.0, 145.0, 145.0, 130.0, 115.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 202.0, 269.0, 182.0, 183.0, 182.0, 184.0, 183.0, 182.0], "value": 193.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 87.0, 63.0, 75.0, 83.0, 84.0, 87.0, 58.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 71.0, 86.0, 68.0, 68.0, 69.0, 84.0, 68.0, 70.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 110.0, 113.0, 109.0, 113.0, 111.0, 114.0, 109.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 98.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 88.0, 85.0, 87.0, 87.0, 87.0, 87.0, 87.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 57.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 78.0, 76.0, 73.0, 70.0, 71.0, 72.0, 72.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 88.0, 89.0, 90.0, 88.0, 95.0, 91.0, 95.0, 88.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 148.0, 150.0, 147.0, 149.0, 145.0, 140.0, 229.0, 154.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 178.0, 176.0, 179.0, 178.0, 175.0, 176.0, 188.0, 152.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1504.7, "alertThreshold": 2.0}]} 15:11:49 INFO - Return code: 0 15:11:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:11:49 INFO - # TBPL SUCCESS # 15:11:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:49 INFO - 2016-12-11 15:11:49.929 screenresolution[1660:9825] starting screenresolution argv=screenresolution get 15:11:49 INFO - 2016-12-11 15:11:49.931 screenresolution[1660:9825] Display 0: 1600x1200x32@60 15:11:49 INFO - 2016-12-11 15:11:49.937 screenresolution[1661:9828] starting screenresolution argv=screenresolution list 15:11:49 INFO - Available Modes on Display 0 15:11:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:11:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:11:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:11:50 INFO - Intel Iris: 15:11:50 INFO - Chipset Model: Intel Iris 15:11:50 INFO - Type: GPU 15:11:50 INFO - Bus: Built-In 15:11:50 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:50 INFO - Vendor: Intel (0x8086) 15:11:50 INFO - Device ID: 0x0a2e 15:11:50 INFO - Revision ID: 0x0009 15:11:50 INFO - Displays: 15:11:50 INFO - Display: 15:11:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:11:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:50 INFO - Display Serial Number: 1600x1200 60 15:11:50 INFO - Main Display: Yes 15:11:50 INFO - Mirror: Off 15:11:50 INFO - Online: Yes 15:11:50 INFO - Rotation: Supported 15:11:50 INFO - Return code: 0 15:11:50 INFO - Running post-action listener: _resource_record_post_action 15:11:50 INFO - [mozharness: 2016-12-11 23:11:50.173367Z] Finished run-tests step (success) 15:11:50 INFO - Running post-run listener: _resource_record_post_run 15:11:50 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 36275200; Write bytes: 551289344; Read time: 239; Write time: 1635 15:11:50 INFO - TinderboxPrint: CPU usage
53.7% 15:11:50 INFO - TinderboxPrint: I/O read bytes / time
36,275,200 / 239 15:11:50 INFO - TinderboxPrint: I/O write bytes / time
551,289,344 / 1,635 15:11:50 INFO - TinderboxPrint: CPU idle
2,229.8 (46.3%) 15:11:50 INFO - TinderboxPrint: CPU system
964.0 (20.0%) 15:11:50 INFO - TinderboxPrint: CPU user
1,619.8 (33.7%) 15:11:50 INFO - TinderboxPrint: Swap in / out
286,150,656 / 0 15:11:50 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243343872; Write bytes: 238249472; Read time: 17877; Write time: 480 15:11:50 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34161664; Write bytes: 297290752; Read time: 216; Write time: 1115 15:11:50 INFO - Running post-run listener: _upload_blobber_files 15:11:50 INFO - Blob upload gear active. 15:11:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:11:50 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 15:11:50 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:11:50 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:11:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:53 INFO - (blobuploader) - INFO - Done attempting. 15:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:54 INFO - (blobuploader) - INFO - Done attempting. 15:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:56 INFO - (blobuploader) - INFO - Done attempting. 15:11:56 INFO - (blobuploader) - INFO - Iteration through files over. 15:11:56 INFO - Return code: 0 15:11:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:11:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:11:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27cf936817a4ceb56216271aa9298f52b36ac49f83ab4d8c235c3da046033f42b51c63aad6b64f5344fc0a7193e21b8b5f7a3a285c592fe95f94341ec666a5a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b72524a86a5699624f0afb1d27d7151226802fb50424cd93c3393d402768feacf611c317b4cc55095afa8d56a8a7d6cb23940d14d01f9cbb0bcc9b247ca74fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c0078abca199411edc065fc5e75eb60686f07194b9ee4d9551f47d60ccb512a00137a649337514813861c9ca362025cc034d0a71bef6c637d2d47d3acaa6fac"} 15:11:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:11:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:11:56 INFO - Contents: 15:11:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27cf936817a4ceb56216271aa9298f52b36ac49f83ab4d8c235c3da046033f42b51c63aad6b64f5344fc0a7193e21b8b5f7a3a285c592fe95f94341ec666a5a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b72524a86a5699624f0afb1d27d7151226802fb50424cd93c3393d402768feacf611c317b4cc55095afa8d56a8a7d6cb23940d14d01f9cbb0bcc9b247ca74fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c0078abca199411edc065fc5e75eb60686f07194b9ee4d9551f47d60ccb512a00137a649337514813861c9ca362025cc034d0a71bef6c637d2d47d3acaa6fac"} 15:11:56 INFO - Running post-run listener: copy_logs_to_upload_dir 15:11:56 INFO - Copying logs to upload dir... 15:11:56 INFO - mkdir: /builds/slave/test/build/upload/logs 15:11:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.347522 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-12-11 15:11:56.795402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:56.798919) ========= 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.80SQFKyiqX/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.balSSZ2fIv/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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/Firefox/sha512/27cf936817a4ceb56216271aa9298f52b36ac49f83ab4d8c235c3da046033f42b51c63aad6b64f5344fc0a7193e21b8b5f7a3a285c592fe95f94341ec666a5a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b72524a86a5699624f0afb1d27d7151226802fb50424cd93c3393d402768feacf611c317b4cc55095afa8d56a8a7d6cb23940d14d01f9cbb0bcc9b247ca74fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c0078abca199411edc065fc5e75eb60686f07194b9ee4d9551f47d60ccb512a00137a649337514813861c9ca362025cc034d0a71bef6c637d2d47d3acaa6fac"} build_url:https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.010982 build_url: 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27cf936817a4ceb56216271aa9298f52b36ac49f83ab4d8c235c3da046033f42b51c63aad6b64f5344fc0a7193e21b8b5f7a3a285c592fe95f94341ec666a5a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b72524a86a5699624f0afb1d27d7151226802fb50424cd93c3393d402768feacf611c317b4cc55095afa8d56a8a7d6cb23940d14d01f9cbb0bcc9b247ca74fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c0078abca199411edc065fc5e75eb60686f07194b9ee4d9551f47d60ccb512a00137a649337514813861c9ca362025cc034d0a71bef6c637d2d47d3acaa6fac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:56.833668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:56.834052) ========= 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.80SQFKyiqX/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.balSSZ2fIv/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.005044 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:56.883553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 15:11:56.883939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 15:11:56.884318) ========= ========= Total master_lag: 0.26 =========