builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0293 starttime: 1476268870.26 results: success (0) buildid: 20161012004014 builduid: 4456791e80f54cae936cf6eb14cad357 revision: 18f93e548a3cfaa67c4a852f81d14cb0714974b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.258287) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.258710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.258975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.281822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.282176) ========= 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.DGCZBn7th1/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.74ZhcmemId/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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-10-12 03:41:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.08M=0.001s 2016-10-12 03:41:10 (8.08 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.429566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.429870) ========= 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.DGCZBn7th1/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.74ZhcmemId/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.020914 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:10.478105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 03:41:10.478455) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 18f93e548a3cfaa67c4a852f81d14cb0714974b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 18f93e548a3cfaa67c4a852f81d14cb0714974b9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DGCZBn7th1/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.74ZhcmemId/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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-10-12 03:41:10,557 truncating revision to first 12 chars 2016-10-12 03:41:10,557 Setting DEBUG logging. 2016-10-12 03:41:10,557 attempt 1/10 2016-10-12 03:41:10,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/18f93e548a3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 03:41:11,753 unpacking tar archive at: mozilla-aurora-18f93e548a3c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.488588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 03:41:11.988807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:11.989123) ========= script_repo_revision: 18f93e548a3cfaa67c4a852f81d14cb0714974b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:11.989530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:11.989789) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 03:41:12.008097) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-12 03:41:12.008503) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DGCZBn7th1/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.74ZhcmemId/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:12 INFO - MultiFileLogger online at 20161012 03:41:12 in /builds/slave/test 03:41:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:41:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:12 INFO - {'append_to_log': False, 03:41:12 INFO - 'base_work_dir': '/builds/slave/test', 03:41:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:41:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:12 INFO - 'branch': 'Mozilla-Aurora', 03:41:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:12 INFO - 'config_files': ('talos/mac_config.py',), 03:41:12 INFO - 'default_actions': ('clobber', 03:41:12 INFO - 'read-buildbot-config', 03:41:12 INFO - 'download-and-extract', 03:41:12 INFO - 'populate-webroot', 03:41:12 INFO - 'create-virtualenv', 03:41:12 INFO - 'install', 03:41:12 INFO - 'run-tests'), 03:41:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:12 INFO - 'download_minidump_stackwalk': True, 03:41:12 INFO - 'download_symbols': 'ondemand', 03:41:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:41:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:41:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:41:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:41:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:12 INFO - 'installer_path': 'installer.exe', 03:41:12 INFO - 'log_level': 'info', 03:41:12 INFO - 'log_name': 'talos', 03:41:12 INFO - 'log_to_console': True, 03:41:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:41:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:41:12 INFO - 'opt_config_files': (), 03:41:12 INFO - 'pip_index': False, 03:41:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:12 INFO - 'cmd': ('bash', 03:41:12 INFO - '-c', 03:41:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:12 INFO - 'enabled': True, 03:41:12 INFO - 'halt_on_failure': False, 03:41:12 INFO - 'name': 'check_screen_resolution'},), 03:41:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:41:12 INFO - 'cmd': ('bash', 03:41:12 INFO - '-c', 03:41:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:41:12 INFO - 'enabled': True, 03:41:12 INFO - 'halt_on_failure': False, 03:41:12 INFO - 'name': 'check_screen_resolution'},), 03:41:12 INFO - 'run_cmd_checks_enabled': True, 03:41:12 INFO - 'sps_profile': False, 03:41:12 INFO - 'sps_profile_interval': 0, 03:41:12 INFO - 'suite': 'dromaeojs', 03:41:12 INFO - 'system_bits': '32', 03:41:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:12 INFO - 'title': 't-yosemite-r7-0293', 03:41:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:12 INFO - 'use_talos_json': True, 03:41:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:12 INFO - 'work_dir': 'build'} 03:41:12 INFO - [mozharness: 2016-10-12 10:41:12.195927Z] Running clobber step. 03:41:12 INFO - Running pre-action listener: _resource_record_pre_action 03:41:12 INFO - Running main action method: clobber 03:41:12 INFO - rmtree: /builds/slave/test/build 03:41:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:12 INFO - Running post-action listener: _resource_record_post_action 03:41:12 INFO - [mozharness: 2016-10-12 10:41:12.374016Z] Finished clobber step (success) 03:41:12 INFO - [mozharness: 2016-10-12 10:41:12.374153Z] Running read-buildbot-config step. 03:41:12 INFO - Running pre-action listener: _resource_record_pre_action 03:41:12 INFO - Running main action method: read_buildbot_config 03:41:12 INFO - Using buildbot properties: 03:41:12 INFO - { 03:41:12 INFO - "project": "", 03:41:12 INFO - "product": "firefox", 03:41:12 INFO - "script_repo_revision": "production", 03:41:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:41:12 INFO - "repository": "", 03:41:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:41:12 INFO - "buildid": "20161012004014", 03:41:12 INFO - "stage_platform": "macosx64", 03:41:12 INFO - "basedir": "/builds/slave/test", 03:41:12 INFO - "nightly_build": "True", 03:41:12 INFO - "buildnumber": 49, 03:41:12 INFO - "slavename": "t-yosemite-r7-0293", 03:41:12 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:41:12 INFO - "platform": "yosemite_r7", 03:41:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:41:12 INFO - "branch": "mozilla-aurora", 03:41:12 INFO - "repo_path": "releases/mozilla-aurora", 03:41:12 INFO - "revision": "18f93e548a3cfaa67c4a852f81d14cb0714974b9", 03:41:12 INFO - "pgo_build": "False", 03:41:12 INFO - "builduid": "4456791e80f54cae936cf6eb14cad357", 03:41:12 INFO - "slavebuilddir": "test" 03:41:12 INFO - } 03:41:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:41:12 INFO - Running post-action listener: _resource_record_post_action 03:41:12 INFO - [mozharness: 2016-10-12 10:41:12.377572Z] Finished read-buildbot-config step (success) 03:41:12 INFO - [mozharness: 2016-10-12 10:41:12.377680Z] Running download-and-extract step. 03:41:12 INFO - Running pre-action listener: _resource_record_pre_action 03:41:12 INFO - Running main action method: download_and_extract 03:41:12 INFO - mkdir: /builds/slave/test/build/tests 03:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:12 INFO - trying https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:41:12 INFO - Downloading https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:41:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:41:13 INFO - Downloaded 1199 bytes. 03:41:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:41:13 INFO - Using the following test package requirements: 03:41:13 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:41:13 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:41:13 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:41:13 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'jsshell-mac.zip'], 03:41:13 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:41:13 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:41:13 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:41:13 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:41:13 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:41:13 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:41:13 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:41:13 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:41:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:41:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:41:13 INFO - Fetch https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:41:13 INFO - Expected file size: 16435146 03:41:20 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:41:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:41:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:41:20 INFO - Fetch https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:41:21 INFO - Expected file size: 16435146 03:41:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:41:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:41:27 INFO - Fetch https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:41:29 INFO - Expected file size: 14414059 03:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:30 INFO - trying https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:41:33 INFO - Downloaded 115445292 bytes. 03:41:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:41:33 INFO - mkdir: /builds/slave/test/properties 03:41:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:33 INFO - Contents: 03:41:33 INFO - build_url:https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:41:33 INFO - Running post-action listener: _resource_record_post_action 03:41:33 INFO - Running post-action listener: set_extra_try_arguments 03:41:33 INFO - [mozharness: 2016-10-12 10:41:33.986670Z] Finished download-and-extract step (success) 03:41:33 INFO - [mozharness: 2016-10-12 10:41:33.986818Z] Running populate-webroot step. 03:41:33 INFO - Running pre-action listener: _resource_record_pre_action 03:41:33 INFO - Running main action method: populate_webroot 03:41:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:33 INFO - '--tppagecycles', 03:41:33 INFO - '7'], 03:41:33 INFO - 'tests': ['tsvgm']}}, 03:41:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:41:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:41:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:33 INFO - 'talos_options': ['--disable-e10s'], 03:41:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:33 INFO - 'talos_options': ['--disable-e10s'], 03:41:33 INFO - 'tests': ['damp', 'tps']}, 03:41:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:33 INFO - 'tests': ['damp', 'tps']}, 03:41:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:41:33 INFO - 'tests': ['dromaeo_dom']}, 03:41:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:41:33 INFO - 'tests': ['basic_compositor_video']}, 03:41:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:41:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:41:33 INFO - 'tests': ['a11yr', 03:41:33 INFO - 'ts_paint', 03:41:33 INFO - 'tpaint', 03:41:33 INFO - 'sessionrestore', 03:41:33 INFO - 'sessionrestore_no_auto_restore', 03:41:33 INFO - 'tabpaint']}, 03:41:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:33 INFO - 'ts_paint', 03:41:33 INFO - 'tpaint', 03:41:33 INFO - 'sessionrestore', 03:41:33 INFO - 'sessionrestore_no_auto_restore', 03:41:33 INFO - 'tabpaint']}, 03:41:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:41:34 INFO - 'ts_paint', 03:41:34 INFO - 'tpaint', 03:41:34 INFO - 'sessionrestore', 03:41:34 INFO - 'sessionrestore_no_auto_restore', 03:41:34 INFO - 'tabpaint']}, 03:41:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:41:34 INFO - 'ts_paint', 03:41:34 INFO - 'tpaint', 03:41:34 INFO - 'sessionrestore', 03:41:34 INFO - 'sessionrestore_no_auto_restore', 03:41:34 INFO - 'tabpaint']}, 03:41:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:41:34 INFO - 'tests': ['a11yr', 03:41:34 INFO - 'ts_paint', 03:41:34 INFO - 'tpaint', 03:41:34 INFO - 'sessionrestore', 03:41:34 INFO - 'sessionrestore_no_auto_restore', 03:41:34 INFO - 'tabpaint']}, 03:41:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:41:34 INFO - 'tests': ['a11yr', 03:41:34 INFO - 'ts_paint', 03:41:34 INFO - 'tpaint', 03:41:34 INFO - 'sessionrestore', 03:41:34 INFO - 'sessionrestore_no_auto_restore', 03:41:34 INFO - 'tabpaint']}, 03:41:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:41:34 INFO - 'tests': ['tsvgx', 03:41:34 INFO - 'tsvgr_opacity', 03:41:34 INFO - 'tart', 03:41:34 INFO - 'tscrollx', 03:41:34 INFO - 'cart']}, 03:41:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:34 INFO - 'tsvgr_opacity', 03:41:34 INFO - 'tart', 03:41:34 INFO - 'tscrollx', 03:41:34 INFO - 'cart']}, 03:41:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:34 INFO - 'talos_options': ['--disable-e10s'], 03:41:34 INFO - 'tests': ['tp5o']}, 03:41:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:34 INFO - 'tests': ['tp5o']}, 03:41:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:34 INFO - 'talos_options': ['--disable-e10s', 03:41:34 INFO - '--xperf_path', 03:41:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:34 INFO - 'tests': ['tp5n']}, 03:41:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:34 INFO - 'talos_options': ['--xperf_path', 03:41:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:34 INFO - 'tests': ['tp5n']}}, 03:41:34 INFO - 'talos.zip': {'path': '', 03:41:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:34 INFO - Running post-action listener: _resource_record_post_action 03:41:34 INFO - [mozharness: 2016-10-12 10:41:34.005477Z] Finished populate-webroot step (success) 03:41:34 INFO - [mozharness: 2016-10-12 10:41:34.005605Z] Running create-virtualenv step. 03:41:34 INFO - Running pre-action listener: _resource_record_pre_action 03:41:34 INFO - Running main action method: create_virtualenv 03:41:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:34 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 03:41:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:34 INFO - Using real prefix '/tools/python27' 03:41:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:37 INFO - Installing pip.................done. 03:41:37 INFO - Return code: 0 03:41:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:37 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')]} 03:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:37 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')]} 03:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:37 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:37 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 03:41:37 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 03:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:37 INFO - 'HOME': '/Users/cltbld', 03:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:37 INFO - 'LOGNAME': 'cltbld', 03:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:37 INFO - 'MOZ_NO_REMOTE': '1', 03:41:37 INFO - 'NO_EM_RESTART': '1', 03:41:37 INFO - 'PAGER': '/bin/cat', 03:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:37 INFO - 'PWD': '/builds/slave/test', 03:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:37 INFO - 'SHELL': '/bin/bash', 03:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:37 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:37 INFO - 'USER': 'cltbld', 03:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:37 INFO - 'XPC_FLAGS': '0x0', 03:41:37 INFO - 'XPC_SERVICE_NAME': '0', 03:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:38 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 03:41:38 INFO - Cleaning up... 03:41:38 INFO - Return code: 0 03:41:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:38 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')]} 03:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:38 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')]} 03:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:38 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:38 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 03:41:38 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 03:41:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:38 INFO - 'HOME': '/Users/cltbld', 03:41:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:38 INFO - 'LOGNAME': 'cltbld', 03:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:38 INFO - 'MOZ_NO_REMOTE': '1', 03:41:38 INFO - 'NO_EM_RESTART': '1', 03:41:38 INFO - 'PAGER': '/bin/cat', 03:41:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:38 INFO - 'PWD': '/builds/slave/test', 03:41:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:38 INFO - 'SHELL': '/bin/bash', 03:41:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:38 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:38 INFO - 'USER': 'cltbld', 03:41:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:38 INFO - 'XPC_FLAGS': '0x0', 03:41:38 INFO - 'XPC_SERVICE_NAME': '0', 03:41:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:38 INFO - Downloading/unpacking psutil>=3.1.1 03:41:38 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 03:41:38 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 03:41:38 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 03:41:38 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 03:41:38 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 03:41:38 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 03:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:41 INFO - Installing collected packages: psutil 03:41:41 INFO - Running setup.py install for psutil 03:41:41 INFO - building 'psutil._psutil_osx' extension 03:41:41 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 03:41:41 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 03:41:41 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 03:41:41 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 03:41:41 INFO - building 'psutil._psutil_posix' extension 03:41:41 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 03:41:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:41:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:41:42 INFO - ^ 03:41:42 INFO - 1 warning generated. 03:41:42 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 03:41:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:42 INFO - Successfully installed psutil 03:41:42 INFO - Cleaning up... 03:41:42 INFO - Return code: 0 03:41:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:42 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:42 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 03:41:42 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 03:41:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:42 INFO - 'HOME': '/Users/cltbld', 03:41:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:42 INFO - 'LOGNAME': 'cltbld', 03:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:42 INFO - 'MOZ_NO_REMOTE': '1', 03:41:42 INFO - 'NO_EM_RESTART': '1', 03:41:42 INFO - 'PAGER': '/bin/cat', 03:41:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:42 INFO - 'PWD': '/builds/slave/test', 03:41:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:42 INFO - 'SHELL': '/bin/bash', 03:41:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:42 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:42 INFO - 'USER': 'cltbld', 03:41:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:42 INFO - 'XPC_FLAGS': '0x0', 03:41:42 INFO - 'XPC_SERVICE_NAME': '0', 03:41:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:45 INFO - Installing collected packages: mozsystemmonitor 03:41:45 INFO - Running setup.py install for mozsystemmonitor 03:41:45 INFO - Successfully installed mozsystemmonitor 03:41:45 INFO - Cleaning up... 03:41:45 INFO - Return code: 0 03:41:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41: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')]} 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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')]} 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:45 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:45 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 03:41:45 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 03:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:45 INFO - 'HOME': '/Users/cltbld', 03:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:45 INFO - 'LOGNAME': 'cltbld', 03:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:45 INFO - 'MOZ_NO_REMOTE': '1', 03:41:45 INFO - 'NO_EM_RESTART': '1', 03:41:45 INFO - 'PAGER': '/bin/cat', 03:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:45 INFO - 'PWD': '/builds/slave/test', 03:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:45 INFO - 'SHELL': '/bin/bash', 03:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:45 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:45 INFO - 'USER': 'cltbld', 03:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:45 INFO - 'XPC_FLAGS': '0x0', 03:41:45 INFO - 'XPC_SERVICE_NAME': '0', 03:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:45 INFO - Downloading/unpacking jsonschema==2.5.1 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:41:47 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 03:41:47 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 03:41:47 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 03:41:47 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 03:41:47 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 03:41:47 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 03:41:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:48 INFO - warning: no files found matching '*.txt' 03:41:48 INFO - no previously-included directories found matching 'build' 03:41:48 INFO - no previously-included directories found matching 'dist' 03:41:48 INFO - no previously-included directories found matching '.git*' 03:41:48 INFO - Installing collected packages: jsonschema, functools32 03:41:48 INFO - Running setup.py install for functools32 03:41:48 INFO - warning: no files found matching '*.txt' 03:41:48 INFO - no previously-included directories found matching 'build' 03:41:48 INFO - no previously-included directories found matching 'dist' 03:41:48 INFO - no previously-included directories found matching '.git*' 03:41:48 INFO - Successfully installed jsonschema functools32 03:41:48 INFO - Cleaning up... 03:41:48 INFO - Return code: 0 03:41:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:41:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:48 INFO - 'HOME': '/Users/cltbld', 03:41:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:48 INFO - 'LOGNAME': 'cltbld', 03:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:48 INFO - 'MOZ_NO_REMOTE': '1', 03:41:48 INFO - 'NO_EM_RESTART': '1', 03:41:48 INFO - 'PAGER': '/bin/cat', 03:41:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:48 INFO - 'PWD': '/builds/slave/test', 03:41:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:48 INFO - 'SHELL': '/bin/bash', 03:41:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:48 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:48 INFO - 'USER': 'cltbld', 03:41:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:48 INFO - 'XPC_FLAGS': '0x0', 03:41:48 INFO - 'XPC_SERVICE_NAME': '0', 03:41:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:41:49 INFO - Cleaning up... 03:41:49 INFO - Return code: 0 03:41:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:49 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')]} 03:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:49 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')]} 03:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:49 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:49 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 03:41:49 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 03:41:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:49 INFO - 'HOME': '/Users/cltbld', 03:41:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:49 INFO - 'LOGNAME': 'cltbld', 03:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:49 INFO - 'MOZ_NO_REMOTE': '1', 03:41:49 INFO - 'NO_EM_RESTART': '1', 03:41:49 INFO - 'PAGER': '/bin/cat', 03:41:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:49 INFO - 'PWD': '/builds/slave/test', 03:41:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:49 INFO - 'SHELL': '/bin/bash', 03:41:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:49 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:49 INFO - 'USER': 'cltbld', 03:41:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:49 INFO - 'XPC_FLAGS': '0x0', 03:41:49 INFO - 'XPC_SERVICE_NAME': '0', 03:41:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:49 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 03:41:49 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 03:41:49 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 03:41:49 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 03:41:49 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 03:41:49 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 03:41:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:52 INFO - Downloading docopt-0.6.1.tar.gz 03:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:53 INFO - Running setup.py install for blobuploader 03:41:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:53 INFO - Running setup.py install for requests 03:41:53 INFO - Running setup.py install for docopt 03:41:53 INFO - Successfully installed blobuploader requests docopt 03:41:53 INFO - Cleaning up... 03:41:53 INFO - Return code: 0 03:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:53 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')]} 03:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:53 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')]} 03:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:53 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:53 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 03:41:53 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 03:41:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:53 INFO - 'HOME': '/Users/cltbld', 03:41:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:53 INFO - 'LOGNAME': 'cltbld', 03:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:53 INFO - 'MOZ_NO_REMOTE': '1', 03:41:53 INFO - 'NO_EM_RESTART': '1', 03:41:53 INFO - 'PAGER': '/bin/cat', 03:41:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:53 INFO - 'PWD': '/builds/slave/test', 03:41:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:53 INFO - 'SHELL': '/bin/bash', 03:41:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:53 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:53 INFO - 'USER': 'cltbld', 03:41:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:53 INFO - 'XPC_FLAGS': '0x0', 03:41:53 INFO - 'XPC_SERVICE_NAME': '0', 03:41:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-AVOxJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-6qq1O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-XpxJhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-n0QrXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-QjjWzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-a15XJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-dUJga4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:54 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Rmxcvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-64sB6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-090we9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-exXhqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-jQsPe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-oB4gg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-QoWFBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-DmK6Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-VPLdi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:55 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-YtMRIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:55 INFO - Running setup.py install for manifestparser 03:41:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:56 INFO - Running setup.py install for mozcrash 03:41:56 INFO - Running setup.py install for mozdebug 03:41:56 INFO - Running setup.py install for mozdevice 03:41:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:56 INFO - Running setup.py install for mozfile 03:41:56 INFO - Running setup.py install for mozhttpd 03:41:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:56 INFO - Running setup.py install for mozinfo 03:41:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:56 INFO - Running setup.py install for mozInstall 03:41:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Running setup.py install for mozleak 03:41:57 INFO - Running setup.py install for mozlog 03:41:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Running setup.py install for moznetwork 03:41:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Running setup.py install for mozprocess 03:41:57 INFO - Running setup.py install for mozprofile 03:41:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:57 INFO - Running setup.py install for mozrunner 03:41:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Running setup.py install for mozscreenshot 03:41:58 INFO - Running setup.py install for moztest 03:41:58 INFO - Running setup.py install for mozversion 03:41:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:58 INFO - Cleaning up... 03:41:58 INFO - Return code: 0 03:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:58 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:41:58 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 03:41:58 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 03:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:58 INFO - 'HOME': '/Users/cltbld', 03:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:58 INFO - 'LOGNAME': 'cltbld', 03:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:58 INFO - 'MOZ_NO_REMOTE': '1', 03:41:58 INFO - 'NO_EM_RESTART': '1', 03:41:58 INFO - 'PAGER': '/bin/cat', 03:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:58 INFO - 'PWD': '/builds/slave/test', 03:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:58 INFO - 'SHELL': '/bin/bash', 03:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:41:58 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:58 INFO - 'USER': 'cltbld', 03:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:58 INFO - 'XPC_FLAGS': '0x0', 03:41:58 INFO - 'XPC_SERVICE_NAME': '0', 03:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:58 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-MjhoCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:58 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)) 03:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:58 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-hOXrU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-kotJ9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-46xNQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-8useFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-KQESdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-aVq8Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-DYT55r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-0qYFei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-W6I9jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-W9_sN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:59 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)) 03:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:59 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-PGLQBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:00 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-UKdxnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:00 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-_b0dOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:00 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-nDZPVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:00 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-qKbU1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:00 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)) 03:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:00 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-IlUkno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:00 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)) 03:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:42:00 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)) 03:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:00 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 03:42:00 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 03:42:00 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 03:42:00 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 03:42:00 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 03:42:00 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 03:42:03 INFO - Downloading blessings-1.6.tar.gz 03:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:03 INFO - Installing collected packages: blessings 03:42:03 INFO - Running setup.py install for blessings 03:42:03 INFO - Successfully installed blessings 03:42:03 INFO - Cleaning up... 03:42:03 INFO - Return code: 0 03:42:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:03 INFO - Reading from file tmpfile_stdout 03:42:03 INFO - Current package versions: 03:42:03 INFO - blessings == 1.6 03:42:03 INFO - blobuploader == 1.2.4 03:42:03 INFO - docopt == 0.6.1 03:42:03 INFO - functools32 == 3.2.3-2 03:42:03 INFO - jsonschema == 2.5.1 03:42:03 INFO - manifestparser == 1.1 03:42:03 INFO - mozInstall == 1.12 03:42:03 INFO - mozcrash == 0.17 03:42:03 INFO - mozdebug == 0.1 03:42:03 INFO - mozdevice == 0.48 03:42:03 INFO - mozfile == 1.2 03:42:03 INFO - mozhttpd == 0.7 03:42:03 INFO - mozinfo == 0.9 03:42:03 INFO - mozleak == 0.1 03:42:03 INFO - mozlog == 3.4 03:42:03 INFO - moznetwork == 0.27 03:42:03 INFO - mozprocess == 0.23 03:42:03 INFO - mozprofile == 0.28 03:42:03 INFO - mozrunner == 6.12 03:42:03 INFO - mozscreenshot == 0.1 03:42:03 INFO - mozsystemmonitor == 0.3 03:42:03 INFO - moztest == 0.7 03:42:03 INFO - mozversion == 1.4 03:42:03 INFO - psutil == 3.1.1 03:42:03 INFO - requests == 1.2.3 03:42:03 INFO - wsgiref == 0.1.2 03:42:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:03 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')]} 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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')]} 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:42:03 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 03:42:03 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 03:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:03 INFO - 'HOME': '/Users/cltbld', 03:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:03 INFO - 'LOGNAME': 'cltbld', 03:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:03 INFO - 'MOZ_NO_REMOTE': '1', 03:42:03 INFO - 'NO_EM_RESTART': '1', 03:42:03 INFO - 'PAGER': '/bin/cat', 03:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:03 INFO - 'PWD': '/builds/slave/test', 03:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:03 INFO - 'SHELL': '/bin/bash', 03:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:42:03 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:03 INFO - 'USER': 'cltbld', 03:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:03 INFO - 'XPC_FLAGS': '0x0', 03:42:03 INFO - 'XPC_SERVICE_NAME': '0', 03:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 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)) 03:42:03 INFO - Cleaning up... 03:42:03 INFO - Return code: 0 03:42:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42:03 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')]} 03:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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')]} 03:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:03 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 0x109c1f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b95570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8922d9d040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, '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.DGCZBn7th1/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.74ZhcmemId/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 03:42:03 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 03:42:03 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 03:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:03 INFO - 'HOME': '/Users/cltbld', 03:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:03 INFO - 'LOGNAME': 'cltbld', 03:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:03 INFO - 'MOZ_NO_REMOTE': '1', 03:42:03 INFO - 'NO_EM_RESTART': '1', 03:42:03 INFO - 'PAGER': '/bin/cat', 03:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:03 INFO - 'PWD': '/builds/slave/test', 03:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:03 INFO - 'SHELL': '/bin/bash', 03:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:42:03 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:03 INFO - 'USER': 'cltbld', 03:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:03 INFO - 'XPC_FLAGS': '0x0', 03:42:03 INFO - 'XPC_SERVICE_NAME': '0', 03:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:04 INFO - Cleaning up... 03:42:04 INFO - Return code: 0 03:42:04 INFO - Running post-action listener: _resource_record_post_action 03:42:04 INFO - Running post-action listener: _start_resource_monitoring 03:42:04 INFO - Starting resource monitoring. 03:42:04 INFO - [mozharness: 2016-10-12 10:42:04.263902Z] Finished create-virtualenv step (success) 03:42:04 INFO - [mozharness: 2016-10-12 10:42:04.264910Z] Running install step. 03:42:04 INFO - Running pre-action listener: _resource_record_pre_action 03:42:04 INFO - Running main action method: install 03:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:04 INFO - Reading from file tmpfile_stdout 03:42:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:04 INFO - Reading from file tmpfile_stdout 03:42:04 INFO - Output received: 03:42:04 INFO - Usage: mozinstall [options] installer 03:42:04 INFO - Options: 03:42:04 INFO - -h, --help show this help message and exit 03:42:04 INFO - -d DEST, --destination=DEST 03:42:04 INFO - Directory to install application into. [default: 03:42:04 INFO - "/builds/slave/test"] 03:42:04 INFO - --app=APP Application being installed. [default: firefox] 03:42:04 INFO - mkdir: /builds/slave/test/build/application 03:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:42:36 INFO - Reading from file tmpfile_stdout 03:42:36 INFO - Output received: 03:42:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:42:36 INFO - Running post-action listener: _resource_record_post_action 03:42:36 INFO - [mozharness: 2016-10-12 10:42:36.901494Z] Finished install step (success) 03:42:36 INFO - [mozharness: 2016-10-12 10:42:36.901627Z] Running run-tests step. 03:42:36 INFO - Running pre-action listener: _resource_record_pre_action 03:42:36 INFO - Running main action method: run_tests 03:42:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:42:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:42:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:42:36 INFO - 2016-10-12 03:42:36.916 screenresolution[1938:9227] starting screenresolution argv=screenresolution get 03:42:36 INFO - 2016-10-12 03:42:36.918 screenresolution[1938:9227] Display 0: 1600x1200x32@60 03:42:36 INFO - 2016-10-12 03:42:36.924 screenresolution[1939:9229] starting screenresolution argv=screenresolution list 03:42:36 INFO - Available Modes on Display 0 03:42:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:42:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:42:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:42:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:37 INFO - Intel Iris: 03:42:37 INFO - Chipset Model: Intel Iris 03:42:37 INFO - Type: GPU 03:42:37 INFO - Bus: Built-In 03:42:37 INFO - VRAM (Dynamic, Max): 1536 MB 03:42:37 INFO - Vendor: Intel (0x8086) 03:42:37 INFO - Device ID: 0x0a2e 03:42:37 INFO - Revision ID: 0x0009 03:42:37 INFO - Displays: 03:42:37 INFO - Display: 03:42:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:37 INFO - Display Serial Number: 1600x1200 60 03:42:37 INFO - Main Display: Yes 03:42:37 INFO - Mirror: Off 03:42:37 INFO - Online: Yes 03:42:37 INFO - Rotation: Supported 03:42:37 INFO - Return code: 0 03:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:37 INFO - Python 2.7.3 03:42:37 INFO - Return code: 0 03:42:37 INFO - grabbing minidump binary from tooltool 03:42:37 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')]} 03:42:37 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 0x109a33d30>, '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 0x109899db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109a2bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:37 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 03:42:37 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 03:42:37 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 03:42:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:37 INFO - Return code: 0 03:42:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:42:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:42:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--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 03:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0293 --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 03:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DGCZBn7th1/Render', 03:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:37 INFO - 'HOME': '/Users/cltbld', 03:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:37 INFO - 'LOGNAME': 'cltbld', 03:42:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:37 INFO - 'MOZ_NO_REMOTE': '1', 03:42:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:37 INFO - 'NO_EM_RESTART': '1', 03:42:37 INFO - 'PAGER': '/bin/cat', 03:42:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:37 INFO - 'PWD': '/builds/slave/test', 03:42:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:37 INFO - 'SHELL': '/bin/bash', 03:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74ZhcmemId/Listeners', 03:42:37 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 03:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:37 INFO - 'USER': 'cltbld', 03:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:37 INFO - 'XPC_FLAGS': '0x0', 03:42:37 INFO - 'XPC_SERVICE_NAME': '0', 03:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--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 03:42:37 INFO - mozversion application_buildid: 20161012004014 03:42:37 INFO - mozversion application_changeset: 18f93e548a3cfaa67c4a852f81d14cb0714974b9 03:42:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:42:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:37 INFO - mozversion application_name: Firefox 03:42:37 INFO - mozversion application_remotingname: firefox-dev 03:42:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:42:37 INFO - mozversion application_vendor: Mozilla 03:42:37 INFO - mozversion application_version: 51.0a2 03:42:37 INFO - mozversion platform_buildid: 20161012004014 03:42:37 INFO - mozversion platform_changeset: 18f93e548a3cfaa67c4a852f81d14cb0714974b9 03:42:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:42:37 INFO - mozversion platform_version: 51.0a2 03:42:37 INFO - using testdate: 1476268957 03:42:37 INFO - actual date: 1476268957 03:42:37 INFO - starting webserver on 'localhost:49440' 03:42:37 INFO - SUITE-START | Running 2 tests 03:42:37 INFO - TEST-START | dromaeo_css 03:42:37 INFO - operating with platform_type : mac_ 03:42:37 INFO - Initialising browser for dromaeo_css test... 03:42:37 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpUXUUZ6/profile http://localhost:49440/getInfo.html) 03:42:39 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 03:42:39 INFO - PROCESS | 1949 | colorDepth:24 03:42:39 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 03:42:39 INFO - PROCESS | 1949 | __metrics 03:42:39 INFO - PROCESS | 1949 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:42:39 INFO - PROCESS | 1949 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:40 INFO - TEST-INFO | 1949: exit 0 03:42:40 INFO - Browser initialized. 03:42:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:40 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpUXUUZ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:52 INFO - PROCESS | 1952 | RSS: Main: 219320320 03:42:52 INFO - PROCESS | 1952 | 03:43:44 INFO - PROCESS | 1952 | 1476269024141 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] 03:45:55 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49440/tests/dromaeo/cssquery-ext.html) 03:45:57 INFO - PROCESS | 1952 | RSS: Main: 373334016 03:45:57 INFO - PROCESS | 1952 | 03:49:00 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-ext.html (next: http://localhost:49440/tests/dromaeo/cssquery-jquery.html) 03:49:01 INFO - PROCESS | 1952 | RSS: Main: 349659136 03:49:01 INFO - PROCESS | 1952 | 03:52:03 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49440/tests/dromaeo/cssquery-mootools.html) 03:52:03 INFO - PROCESS | 1952 | RSS: Main: 316878848 03:52:03 INFO - PROCESS | 1952 | 03:55:06 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49440/tests/dromaeo/cssquery-prototype.html) 03:55:06 INFO - PROCESS | 1952 | RSS: Main: 326291456 03:55:06 INFO - PROCESS | 1952 | 03:58:10 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49440/tests/dromaeo/cssquery-yui.html) 03:58:10 INFO - PROCESS | 1952 | RSS: Main: 309358592 03:58:10 INFO - PROCESS | 1952 | 04:01:13 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-yui.html (next: http://localhost:49440/tests/dromaeo/cssquery-dojo.html) 04:01:13 INFO - PROCESS | 1952 | RSS: Main: 363032576 04:01:13 INFO - PROCESS | 1952 | 04:01:13 INFO - PROCESS | 1952 | __start_tp_report 04:01:13 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 04:01:13 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 04:01:13 INFO - PROCESS | 1952 | |i|pagename|runs| 04:01:13 INFO - PROCESS | 1952 | |0;dojo.html;3278.8687902673582;3291.5391845141685;3328.8169150696717;3333.616634087081;3377.408953433149;5580.944190558093;5657.773689052438;5684.54523638109;5739.741711622976;5759.45285197906;5608.551315894729;5616.775328986836;5651.434856514346;5669.0646043402785;5724.7996320128805;5155.871103222412;5182.404023537285;5191.766370513336;5210;5238.4499627539135;5142.228665700156;5148;5163.019026384994;5280.735963201824;5343.625946183769;5259.631825772198;5278.709670968095;5279.973600131994;5281.207818827187;5287.444818294081;4367.650587952956;5261.184516399964;5262.605304602151;5274.525292723673;5277.6041796865;4629.583337499641;4765.26138448541;5165.9225111623355;5213.504717051874;5218.478152184751;5595.21666966625;5663.603547751659;5698.857528561778;5704.458076482728;5742.052561327376;6151;6197.225346831646;6200.81397558074;6220.284667263232;6238.1578486904145;5322.4411436799355;6233.812985610439;6254.562180647356;6305.653189074599;6309.810705678837;4969.403671559364;5626.774929002835;5702.258706368146;5735.627184233012;5769;6146.647737497743;6248.625082495065;6262.060690896402;6263.154474146023;6279.654618995908;6110.236220472441;6115.235595550556;6125.234345706786;6134.447899689049;6137.202163718688;6130.417610327012;6139.017757158833;6172.783952561639;6227.221597300338;6228.719707613168;6195.721192546346;6217.0052791553135;6248.718807653667;6250.312465628777;6261.123442718023;6248.4688801452385;6266.592671476339;6274.403931626488;6276.6547839869245;6293.622382657055;4834.5890599299455;4852.708837469763;4862.367892173995;4914.508549145128;4944.456109827916;4395.384646149541;4457.286834106528;4463.397441345377;4473.485549161888;4486.5962063414445;5788.334341550775;5813.680247586339;5821;5821.301443826768;5842.620229685057;6211.937880621226;6235.875282494325;6244.594101383395;6247.219097612799;6279.183706118267;5662.122371032414;5681.34664513578;5704.828855134353;5740.741666625012;5744.626599271034;5391.757370918318;5405.567554595702;5443.700596467233;5447.182922561568;5454.236406903036;6249.312575616587;6268.592541484789;6274.152989346379;6281.905771413432;6289.96855015722;6092;6160.014397696347;6186.1030150627;6188.597741146811;6260.780872669435;6204.5036397089025;6241.188645476059;6244.2819075806865;6256.7810126645345;6270.49836013127;6117.816465506042;6117.877642447037;6132.141500189888;6136.140940268277;6155.107509411021;6175.413335733098;6202.627842329474;6219.284782250099;6233.657148856675;6253.593516421418;5925.733341999534;6004.219451471456;6026.728797204224;6044.818655440344;6070.605410648293;6055.424734650202;6069.484093852072;6088.178095956989;6094.939050609437;6098.115773212948;5461.863453413696;5899.705014749159;5919.052951527735;5924.555658325557;5942.64344139353;5241.135212689864;5725.799597014251;6006.879862402815;6025.6083354581815;6043.36544662804;5919.141724450017;5950.375210602824;5963.582549221513;5968.910466342922;5973.104034394875 04:01:13 INFO - PROCESS | 1952 | |1;ext.html;454.5068600568384;501.9447860735319;518.3287642502959;522.1306524636481;528.3263838605777;30620.846895765517;40382.78851634452;41626.58373416269;41726;43822.46621368253;43865;44013.77993110038;44073.55926440735;44097.338539921926;44161;9729.075737804915;9911.306208565404;9920.95829937857;9921.801563968753;9942.353747006458;8792.42849214799;8995;12034.759304813899;12232;12234.265944043385;12111.818322725123;12205.267683938991;12208.206466579688;12216.511339546407;12237.021038316912;12146.635600931986;12208.877911220863;12225.572104976283;12228.082893782914;12253.203541769757;12013.339266340348;12066.215695979821;12102.697432564168;12115.454804533818;12116.81824772629;40571.37714491446;40944.795276023724;41039;41071;41340.793296033626;3250.8374581271078;3301.950470742941;3308.586426696663;3344.0803778960735;3369.4945758136478;30755;31670.208244793834;31835.204119896956;32004.839975800205;32079.679203207903;2868.0535423310257;3188.9202769930707;3193.840307984615;3199.9040028799172;3396.235846934445;524603;527921;528305.358473209;529463;529602;61839;62022;62344.37655623476;62418.127456175476;62426.68786656038;35853.82073089618;36223.4566481503;36526;36587.4511882322;36623.4506482403;17223.96656200632;17354.826451735575;17375.73936390955;17393.65212695739;17409.47771566855;11997.700057498632;12276.877231227574;13218.405171767294;13321.800172997413;13324.333783310796;19389.22443102288;19448.4285125833;19525.51186220356;19567.608647826964;20048.69926951097;7804.6878124874365;7869;7887.132415434297;7890.64492097857;7976.242256985577;797.7247849491916;877.2674816528271;884.425123669607;918.3112665500875;978.1587834462357;30078.947236846605;30256.54615180774;30389.344872418013;30399.24001899926;30536.694633053386;1043.968680939573;1059.0204061243319;1060.984085238722;1076.7523469602036;1082.9187810914214;13262.806347428777;13788.379522921492;14710.896682748837;15330.233488325539;15437.922810385877;693521;702429;706456;714242;715593;52866.735666322194;56342.436575634536;56432.435675642715;56609.71695141498;56634;1236.3262022197923;1257.1388598810026;1340.631326385252;1363.7272545490941;1378.5864240727942;29621.5556766653;29989.55015674723;30232.84883575568;30395.351850190742;30714.539281911235;46735;47294;47299.52700473089;47387.052258955315;47438;560906;564391;566613;566639;567027;24693.87653061723;25263;25310.240692779247;25328;25347.746522534537;45666.71666416599;47461.28808067951;47774.5222547784;47924.5207547934;48776.07343559398;38107.329362580516;38987.80506097451;39337.80331098326;40118.799406002785;40780.38829417502;38515.807420963836;39002.804985974886;39038.4144237831;40641.796791015855;40771.1845763089;38097.23805523929;38398;38730.4190437138;39057.218855623294;39058;33951.49072763861;34434.65565344415;34592.82703586466;35087;35138.12154696153;25320.746792531838;25702;25797.484050319264;25905;26268 04:01:14 INFO - PROCESS | 1952 | |2;jquery.html;355.68699544400926;378.6251610905204;381.1880694121519;388.23517670189733;412.1612518524803;15048.473303434383;15090.849091509095;18028.369007084737;20642.174313027463;20751.273705420277;19924;20023.799762002374;20635.793642063574;20721.689174662355;20723.171073157093;5517.089680202762;5806.390329015435;5844.883102337962;6095.3599872013465;6095.390460953891;5218.425973142951;5887.499562537189;6072.180255665495;6084.665343406111;6093.055576385667;5713.542916566665;5833.125031245305;5881.794137205198;6033.185519954794;6038.48672862805;5924.58527903047;5937.1984782054515;5939.584229103964;5952.136940143677;5961.552883533731;4996.475370086125;5109;5114.846554603368;5169.870753231162;5186.222066690027;24617.63073553898;25520.36199095019;25719;25785.871070644713;25831.35421614456;2398.069677521427;2412.1075202175134;2423.7212720537186;2511.3470497670555;3102.0685452247635;10159.695209143738;12565.371731413485;13070.477180912752;14670.339834707356;15623;1882.1718443884647;1893.1764682363216;1908.236705317884;1933.0721253798256;1942.8931408772512;91955;116041;118437.40781296039;119852.40073799662;120720;11185.720356990978;11234.371016202605;11330.490127944262;11428.771424571461;11450.828237576443;14339.283035848166;14384.928075359556;14394.640133996734;14397.78403323951;14408.42366305336;8516.957415212884;8628.22345988864;8641.697540586048;8684.305255579538;8760.123987601317;7378.114626244777;8641.870371944426;8671.479711217347;8815.603297851483;8819.647214111492;4337.869863904025;4461.643068554507;4492.05666809967;4492.573205545468;4544.0457503924545;1867.327762005677;1908.265317852609;1918.6642337590865;1922.0774028466415;1924.7401600783714;824.3528829868644;939.8966113727485;944.4427787605208;961.990380096204;1001.6093723447862;17891.910540447476;19411.2235510578;19842;20551.79448205499;20717;908.8591268353416;925.3106435705442;933.7992331648728;936.3071327217809;941.4445477168504;10267.486625668687;10557.47212639365;10691.946540267249;10777.515011824487;10795.676129716121;547296;549058;550354;559870;563276;114113;117515.8248417522;119217.40391297988;124902;126345;952.7094236258008;953.0897992417086;954.1365064616533;990.3661656539821;995;15062.794976402081;16961.66076678435;17349;18145.818541814413;18495.815041849408;52786.472135278156;53433.931321372576;54079.45920540902;54360;55383.78464861522;74414.2558574429;75039;75453.11367215864;76253;76405;6252.280987686474;6865.27914568963;6981.895271571032;7198.280171982759;7263.745768898063;7747;11981.76036479248;12460.87539124597;12824.679383015125;13123.671908202372;10937.398443085707;11125.109991200847;11250.66248012561;11400.771984560428;11552.191346605658;11060.723481913017;11129.165312601426;11272.210945233755;11381.658550243506;11483.770324593628;11180.888191117985;11391.487383067617;11729.589464368706;11894.286342819458;11902.523899043941;7151.141862976476;7432.814179645552;7500.437467189873;7503.624818759149;7592.658330375036;9873.111419972238;10892.18308626872;10937.726556836144;11335.319880807177;11456.656300311004 04:01:14 INFO - PROCESS | 1952 | |3;mootools.html;1335.2989680417786;1468.2658670664664;1506.6986602679463;1684.418875487957;1861.4787859399364;7956.880646790296;8413.116622754615;8416.368772342068;8423.326133909288;8431.156884311573;8206.343492520598;8731.476111433318;8942;8944.418612790181;8975.192232699055;2379.7144342678857;2412.372783076395;2413.420779013033;2415.4202991282054;2416.178499310234;2371.845830021043;2402.231285988484;2413.7706917842866;2414.263649586875;2419.1532963462823;2380.2026321182425;2398.2565404724505;2407.626817843237;2413.3604594782396;2417.576924038295;1976.2391479280436;2379.9286021419384;2394.5929192037306;2394.844335118229;2398.3524448399007;2348.835581509295;2372.8694921779297;2380.5119950410126;2381.988090059556;2387.749286324928;8811.77970550735;8847.557622118868;8936.8659470108;8940.73177804667;8947.731568052968;5257.605679574047;5319.228711836762;5446.836594902159;5452.345718513764;5454.372747134091;3673.1735359544155;3737.794421306827;3741.8129093545213;3755.324041672498;3769.6795772359383;1097.6048622495896;1113.788380207766;1123.27548731068;1125.9605913792977;1137;11751.353675547842;11882.930536251779;11968.82046769299;11971.94014029933;12151;3939.7242193046786;3954.3277642800795;4330.328799036154;4632.452151316762;4697.271922851964;9257.861132083024;9259.67591134307;9260.814783704289;9263.722088337227;9269.907300926905;5299.39057008449;5314.388845282765;5314.5216930476445;5315.893682126413;5316.574674026146;4437.29003359461;4535.455745310584;4931.7040977541465;4956.157453232959;4993.17612593918;3751.756135851161;3753.174301653632;3849.3840985442193;3856.1130939883983;3881.7865017424315;976.9218462522981;1164.8136298192248;1179.598936361641;1180.5749930025183;1183.3136780667191;757.4167890724111;846.8221673448645;890.3366991591306;912.6121398405651;919.6735159018585;5728.283964504437;5737.569682273846;5738.167965644958;6037.516998640098;6123.663198524035;928.9535523223811;946.1012038563392;952.0859974424492;964.1611797736015;986.7483791633088;3808.1622043151015;3968.9603103969166;4000.27994960904;4061.268971585143;4077.3068578341754;10716.03555679977;10926.945365273281;11044.668659940215;11071.944640276746;11084.445777711244;10616.416097114577;10993.560257589606;11009.2843965142;11013.559457621606;11021.504032318566;7207.351338379466;8367.790805229795;8382.83234335322;8386.664533418718;8408.537530435884;5710.2862142232225;5738.340090889435;5741.282339707536;5897.734601942837;5913.34953155144;8779.780505487159;10009.449480278654;10154.847677284994;10332.948335258276;10358.637447689294;9629.085236902483;9822.705318840446;9938.155256803253;10143.695689129338;10304.484775761332;6932.930670693228;7137.678804453708;7157.498975071903;7479.102507699111;7540.359069479156;7873.606319684108;7913.248241417056;7937.32532734724;8134.87797683047;8422.873656895274;7444.292792184734;7533.849323013399;7564.167941526538;7590.734324298623;7712.9614351927885;7281.708731650675;7352.154502232312;7374.225706300761;7469.9915511407435;7557.811054723676;6925.376716095576;7068.71725130989;7070.823229419306;7079.115110611174;7100.751473698396;4944.25593795447;4956.355673762532;5003.849884503471;5007.874803129951;5039.445660977216;4837.685550439211;4871.391076115486;4906.215005599087;5019.222020586815;5031.245313203049 04:01:14 INFO - PROCESS | 1952 | |4;prototype.html;296.57885802160916;297.99255018624535;307.6600356605951;309.924068603192;312.2739630359415;4538.90922181557;4829.468758436574;5142.588592912567;5182.844514664556;5292.259083728281;4940.481249468808;4957.620342235729;5032.949670503293;5037.798488060483;5184.922226166611;4002.6597739192202;4011.618896204856;4016.8594099206534;4024.678025757932;4031.919361612766;3316.950245746316;3541.8583256669704;3790.6019867913888;3964.623360780721;4036.475258216428;3346.7322614190807;3881.8835434936996;3986.4219688145345;3994.4208089826957;4032.0927791247027;3730.9440358394645;4016.9397459038137;4020.477337946063;4021;4043.5147782266317;3342.699157075875;3482.432905192648;3518.683318501347;3525.906968839668;3539.0181498361;5002.974985125087;5065.569426598743;5091.8981620367385;5103.438621751604;5114.820981265675;4066.593340665939;4076.694247931417;4546.317862390936;4576.679632425731;4587.4036375271;4513.413256276663;5431.266778984826;5485.917711234335;5493.642913210629;5579.572885794692;3401.4727717203627;3596.1369271374942;3885.941710874339;3887.3974533947285;3909.061825161969;4764.190087685032;5252.553532949704;5369.623756638366;5377.838664840061;5688.752942587655;3794.430835374716;3818.4463252828186;3822.5604055533413;3848.9807550962064;3873.845046198177;3900.7907548660005;3914.119323152268;3919.628130154423;3919.9612102792785;3933.724639275223;4234.591154120901;4520.52534483881;4544.613892762739;4554.772261386917;4595.862124136214;4615.861524154281;4808.2547205183255;5488.067028605146;5575.358833734173;5605.663660180402;1088.1131877519797;1295.3005377096451;1343.751405989895;1347.158026233604;1349.7840345544862;762.7376691575452;832.5545832979327;860.8206756743302;924.7549399409162;942.4580866002076;5019.247112933016;5086.287919691246;5125.410577783528;5165.14775062118;5217.2695822584865;5166.793328266827;5301.363836339664;5597.916031259534;5645.661260324394;5684.573656975744;4527.864164075083;4719.38647975761;5067.41724701664;5103.234514822806;5145.794168233304;2576.9226923192336;2938.9566703820265;2941;2948.764098872085;2949.985250073779;4957.256411538226;5479.150731636602;5800.796972105956;5819.73811178498;5832.650040997553;5105.366282789546;5485.890282194334;5527.861803454865;5614.887702245932;5744.253247077853;5126.897462050738;5224.373075230997;5445.264889239981;5532.197831314517;5779.219805326311;4406.523814522171;4674.766261686834;4859.854204373874;5310.548603368757;5656.953463609246;5526.972365138148;5534.557235421076;5544.584156188222;5549.889002220014;5608.906263278622;5076.390833100052;5776.335721392094;5792.420757924342;5826.271716035496;5849.612790407195;3320.9501857471673;3649.3978493548266;3893.377059670439;3902.8829135125993;3918.7648741074486;4655.4180727409075;5585.676522469124;5588.720563971867;5598.888022239451;5613.382527921844;4371.868843934687;5014.297998280171;5437.429069947599;5489.752961116679;5559.833205003856;4324.2648749712;4988.759554378749;5076.771545280398;5376.623636345418;5399.271098401666;4367.432233809584;4431.8670439886855;5095.159298715818;5176.171812509981;5305.442928492453;5237.659552129099;5399.622026458111;5410.621256512164;5509.063459211863;5524.392316845224;5384.434634363335;5410.891782164414;5416.968636761215;5418.45815418455;5433.076377015996 04:01:14 INFO - PROCESS | 1952 | |5;yui.html;697.3235961117717;719.1514013464111;773.7523992322459;774.4540099230044;813;15428.922855385721;16485.258163382645;16488.42290519832;16540.255688494017;16551.83448165518;14804.777928331083;14847.257637118155;14863.108213507197;14863.256837158126;14922.477713280037;678.6403206300669;701.3337329536935;707.2397173039004;832.81261716114;841.0622156295717;859.2395729779159;859.2610355094614;873.5894129759004;876.7939534209455;878.8857448531681;917.6329468212701;919.797644518205;920.282179899676;920.4937284493535;924.3945215883573;716.44833478222;736.9976831509143;910.3081657939947;912.4206129108031;913.7167478081783;656.6257233376977;671.1979184874077;674.7570874485182;675.1864003875319;676.610948704492;13412.195268283935;14432.711345773027;14852.925735371255;15388.230588470531;15388.999715018488;13139.34303284832;13576.049676522647;13662.726745465134;13988.72022559543;14072.22602756848;12288.569900053455;12592.937035314857;12700.751729974629;12973.021501997528;13353.399097040656;4540.591346778772;4574.679772415932;4628.995263769337;4665.300204969248;4748.978969521535;117717;118685.40657296659;119586;120197.39901300526;120621.53229545247;9423.90576094244;10942.617008404668;10987.450627468595;11442.427878606037;11451.541938322374;21716;22372.216972405888;22423.88788056082;22430.775692243194;22511;7551.395888328921;7733.188015258429;7744.535327880232;7896.170902055316;8073.6366863491285;4213.4522512073845;4278.44380230568;4392.165488557164;4402.427684401071;4453.688241823042;3455.4125798614295;3573.0352804742574;3574.5889222739197;3577.713782897362;3579.2483578448296;631.8957372033562;633.6514916795836;638.1034646321925;658.8517583543664;662.9303923088103;502.52762403340745;518.8287865004539;584.41040370193;680.9080774095434;700.8072779985545;8710.695125670698;9547.952260238655;9688.12806847373;9794.608215671293;9858.654947076819;631.9178506794179;633.0535848905915;638.5274896576593;649.5875119299279;686.4028295383049;4255.638270747021;4636.304554316812;4754.405699287589;4867.367242258484;5074.949250507521;114956;151234;153905.23047384692;157688.21155894146;160361;129422;131348;131583;133517;137976;116726;117711.2343314851;118509.99999999827;120213;120637.39681301537;9990.450525221182;10125.179683756789;10173.796524069625;10184.847227291448;10233.385996840214;47411.52588474071;49100.75449622729;65823.67088164529;66411;68715;54382;56666.7166664164;63978.3602163991;63998;82906.58546707469;13109.541166059142;13218.537351192663;13283.535076272285;13373.53192638253;13863.722725545635;14889.106653600818;14907.850921490646;14911.32899019525;14917.701645967238;14932.253387330808;11649.650510484698;13110.672233194246;13464.192148471124;13524.661883452993;13952.16287022782;12875;13538.390772415461;13736.725265494833;13876.375563099886;13879.861201387857;13114;13338.733225335633;13668.65828354299;14253.429862805371;14278.500252491112;11145.331280123219;11495.310281383145;11848.52605895789;11993.580224692094;12037.398130093285;11201.159913006393;11512.481938312963;11669.76660466769;11737.823932641188;11769 04:01:14 INFO - PROCESS | 1952 | __end_tp_report 04:01:14 INFO - PROCESS | 1952 | __start_cc_report 04:01:14 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,1524 04:01:14 INFO - PROCESS | 1952 | __end_cc_report 04:01:14 INFO - PROCESS | 1952 | __startTimestamp1476270073991__endTimestamp 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - PROCESS | 1952 | ------- Summary: start ------- 04:01:14 INFO - PROCESS | 1952 | Number of tests: 6 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5705.45 Median:5924.56 stddev:647.72 (10.9%) stddev-sans-first:621.11 04:01:14 INFO - PROCESS | 1952 | Values: 3278.9 3291.5 3328.8 3333.6 3377.4 5580.9 5657.8 5684.5 5739.7 5759.5 5608.6 5616.8 5651.4 5669.1 5724.8 5155.9 5182.4 5191.8 5210.0 5238.4 5142.2 5148.0 5163.0 5280.7 5343.6 5259.6 5278.7 5280.0 5281.2 5287.4 4367.7 5261.2 5262.6 5274.5 5277.6 4629.6 4765.3 5165.9 5213.5 5218.5 5595.2 5663.6 5698.9 5704.5 5742.1 6151.0 6197.2 6200.8 6220.3 6238.2 5322.4 6233.8 6254.6 6305.7 6309.8 4969.4 5626.8 5702.3 5735.6 5769.0 6146.6 6248.6 6262.1 6263.2 6279.7 6110.2 6115.2 6125.2 6134.4 6137.2 6130.4 6139.0 6172.8 6227.2 6228.7 6195.7 6217.0 6248.7 6250.3 6261.1 6248.5 6266.6 6274.4 6276.7 6293.6 4834.6 4852.7 4862.4 4914.5 4944.5 4395.4 4457.3 4463.4 4473.5 4486.6 5788.3 5813.7 5821.0 5821.3 5842.6 6211.9 6235.9 6244.6 6247.2 6279.2 5662.1 5681.3 5704.8 5740.7 5744.6 5391.8 5405.6 5443.7 5447.2 5454.2 6249.3 6268.6 6274.2 6281.9 6290.0 6092.0 6160.0 6186.1 6188.6 6260.8 6204.5 6241.2 6244.3 6256.8 6270.5 6117.8 6117.9 6132.1 6136.1 6155.1 6175.4 6202.6 6219.3 6233.7 6253.6 5925.7 6004.2 6026.7 6044.8 6070.6 6055.4 6069.5 6088.2 6094.9 6098.1 5461.9 5899.7 5919.1 5924.6 5942.6 5241.1 5725.8 6006.9 6025.6 6043.4 5919.1 5950.4 5963.6 5968.9 5973.1 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:72459.02 Median:36374.73 stddev:161869.78 (445.0%) stddev-sans-first:162233.59 04:01:14 INFO - PROCESS | 1952 | Values: 454.5 501.9 518.3 522.1 528.3 30620.8 40382.8 41626.6 41726.0 43822.5 43865.0 44013.8 44073.6 44097.3 44161.0 9729.1 9911.3 9921.0 9921.8 9942.4 8792.4 8995.0 12034.8 12232.0 12234.3 12111.8 12205.3 12208.2 12216.5 12237.0 12146.6 12208.9 12225.6 12228.1 12253.2 12013.3 12066.2 12102.7 12115.5 12116.8 40571.4 40944.8 41039.0 41071.0 41340.8 3250.8 3302.0 3308.6 3344.1 3369.5 30755.0 31670.2 31835.2 32004.8 32079.7 2868.1 3188.9 3193.8 3199.9 3396.2 524603.0 527921.0 528305.4 529463.0 529602.0 61839.0 62022.0 62344.4 62418.1 62426.7 35853.8 36223.5 36526.0 36587.5 36623.5 17224.0 17354.8 17375.7 17393.7 17409.5 11997.7 12276.9 13218.4 13321.8 13324.3 19389.2 19448.4 19525.5 19567.6 20048.7 7804.7 7869.0 7887.1 7890.6 7976.2 797.7 877.3 884.4 918.3 978.2 30078.9 30256.5 30389.3 30399.2 30536.7 1044.0 1059.0 1061.0 1076.8 1082.9 13262.8 13788.4 14710.9 15330.2 15437.9 693521.0 702429.0 706456.0 714242.0 715593.0 52866.7 56342.4 56432.4 56609.7 56634.0 1236.3 1257.1 1340.6 1363.7 1378.6 29621.6 29989.6 30232.8 30395.4 30714.5 46735.0 47294.0 47299.5 47387.1 47438.0 560906.0 564391.0 566613.0 566639.0 567027.0 24693.9 25263.0 25310.2 25328.0 25347.7 45666.7 47461.3 47774.5 47924.5 48776.1 38107.3 38987.8 39337.8 40118.8 40780.4 38515.8 39002.8 39038.4 40641.8 40771.2 38097.2 38398.0 38730.4 39057.2 39058.0 33951.5 34434.7 34592.8 35087.0 35138.1 25320.7 25702.0 25797.5 25905.0 26268.0 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:33290.42 Median:25808.61 stddev:92596.26 (358.8%) stddev-sans-first:92823.00 04:01:14 INFO - PROCESS | 1952 | Values: 355.7 378.6 381.2 388.2 412.2 15048.5 15090.8 18028.4 20642.2 20751.3 19924.0 20023.8 20635.8 20721.7 20723.2 5517.1 5806.4 5844.9 6095.4 6095.4 5218.4 5887.5 6072.2 6084.7 6093.1 5713.5 5833.1 5881.8 6033.2 6038.5 5924.6 5937.2 5939.6 5952.1 5961.6 4996.5 5109.0 5114.8 5169.9 5186.2 24617.6 25520.4 25719.0 25785.9 25831.4 2398.1 2412.1 2423.7 2511.3 3102.1 10159.7 12565.4 13070.5 14670.3 15623.0 1882.2 1893.2 1908.2 1933.1 1942.9 91955.0 116041.0 118437.4 119852.4 120720.0 11185.7 11234.4 11330.5 11428.8 11450.8 14339.3 14384.9 14394.6 14397.8 14408.4 8517.0 8628.2 8641.7 8684.3 8760.1 7378.1 8641.9 8671.5 8815.6 8819.6 4337.9 4461.6 4492.1 4492.6 4544.0 1867.3 1908.3 1918.7 1922.1 1924.7 824.4 939.9 944.4 962.0 1001.6 17891.9 19411.2 19842.0 20551.8 20717.0 908.9 925.3 933.8 936.3 941.4 10267.5 10557.5 10691.9 10777.5 10795.7 547296.0 549058.0 550354.0 559870.0 563276.0 114113.0 117515.8 119217.4 124902.0 126345.0 952.7 953.1 954.1 990.4 995.0 15062.8 16961.7 17349.0 18145.8 18495.8 52786.5 53433.9 54079.5 54360.0 55383.8 74414.3 75039.0 75453.1 76253.0 76405.0 6252.3 6865.3 6981.9 7198.3 7263.7 7747.0 11981.8 12460.9 12824.7 13123.7 10937.4 11125.1 11250.7 11400.8 11552.2 11060.7 11129.2 11272.2 11381.7 11483.8 11180.9 11391.5 11729.6 11894.3 11902.5 7151.1 7432.8 7500.4 7503.6 7592.7 9873.1 10892.2 10937.7 11335.3 11456.7 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:5692.49 Median:5005.86 stddev:3202.53 (64.0%) stddev-sans-first:3194.77 04:01:14 INFO - PROCESS | 1952 | Values: 1335.3 1468.3 1506.7 1684.4 1861.5 7956.9 8413.1 8416.4 8423.3 8431.2 8206.3 8731.5 8942.0 8944.4 8975.2 2379.7 2412.4 2413.4 2415.4 2416.2 2371.8 2402.2 2413.8 2414.3 2419.2 2380.2 2398.3 2407.6 2413.4 2417.6 1976.2 2379.9 2394.6 2394.8 2398.4 2348.8 2372.9 2380.5 2382.0 2387.7 8811.8 8847.6 8936.9 8940.7 8947.7 5257.6 5319.2 5446.8 5452.3 5454.4 3673.2 3737.8 3741.8 3755.3 3769.7 1097.6 1113.8 1123.3 1126.0 1137.0 11751.4 11882.9 11968.8 11971.9 12151.0 3939.7 3954.3 4330.3 4632.5 4697.3 9257.9 9259.7 9260.8 9263.7 9269.9 5299.4 5314.4 5314.5 5315.9 5316.6 4437.3 4535.5 4931.7 4956.2 4993.2 3751.8 3753.2 3849.4 3856.1 3881.8 976.9 1164.8 1179.6 1180.6 1183.3 757.4 846.8 890.3 912.6 919.7 5728.3 5737.6 5738.2 6037.5 6123.7 929.0 946.1 952.1 964.2 986.7 3808.2 3969.0 4000.3 4061.3 4077.3 10716.0 10926.9 11044.7 11071.9 11084.4 10616.4 10993.6 11009.3 11013.6 11021.5 7207.4 8367.8 8382.8 8386.7 8408.5 5710.3 5738.3 5741.3 5897.7 5913.3 8779.8 10009.4 10154.8 10332.9 10358.6 9629.1 9822.7 9938.2 10143.7 10304.5 6932.9 7137.7 7157.5 7479.1 7540.4 7873.6 7913.2 7937.3 8134.9 8422.9 7444.3 7533.8 7564.2 7590.7 7713.0 7281.7 7352.2 7374.2 7470.0 7557.8 6925.4 7068.7 7070.8 7079.1 7100.8 4944.3 4956.4 5003.8 5007.9 5039.4 4837.7 4871.4 4906.2 5019.2 5031.2 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:4413.77 Median:5008.64 stddev:1331.34 (26.6%) stddev-sans-first:1298.71 04:01:14 INFO - PROCESS | 1952 | Values: 296.6 298.0 307.7 309.9 312.3 4538.9 4829.5 5142.6 5182.8 5292.3 4940.5 4957.6 5032.9 5037.8 5184.9 4002.7 4011.6 4016.9 4024.7 4031.9 3317.0 3541.9 3790.6 3964.6 4036.5 3346.7 3881.9 3986.4 3994.4 4032.1 3730.9 4016.9 4020.5 4021.0 4043.5 3342.7 3482.4 3518.7 3525.9 3539.0 5003.0 5065.6 5091.9 5103.4 5114.8 4066.6 4076.7 4546.3 4576.7 4587.4 4513.4 5431.3 5485.9 5493.6 5579.6 3401.5 3596.1 3885.9 3887.4 3909.1 4764.2 5252.6 5369.6 5377.8 5688.8 3794.4 3818.4 3822.6 3849.0 3873.8 3900.8 3914.1 3919.6 3920.0 3933.7 4234.6 4520.5 4544.6 4554.8 4595.9 4615.9 4808.3 5488.1 5575.4 5605.7 1088.1 1295.3 1343.8 1347.2 1349.8 762.7 832.6 860.8 924.8 942.5 5019.2 5086.3 5125.4 5165.1 5217.3 5166.8 5301.4 5597.9 5645.7 5684.6 4527.9 4719.4 5067.4 5103.2 5145.8 2576.9 2939.0 2941.0 2948.8 2950.0 4957.3 5479.2 5800.8 5819.7 5832.7 5105.4 5485.9 5527.9 5614.9 5744.3 5126.9 5224.4 5445.3 5532.2 5779.2 4406.5 4674.8 4859.9 5310.5 5657.0 5527.0 5534.6 5544.6 5549.9 5608.9 5076.4 5776.3 5792.4 5826.3 5849.6 3321.0 3649.4 3893.4 3902.9 3918.8 4655.4 5585.7 5588.7 5598.9 5613.4 4371.9 5014.3 5437.4 5489.8 5559.8 4324.3 4988.8 5076.8 5376.6 5399.3 4367.4 4431.9 5095.2 5176.2 5305.4 5237.7 5399.6 5410.6 5509.1 5524.4 5384.4 5410.9 5417.0 5418.5 5433.1 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:24757.93 Median:22427.33 stddev:39933.32 (178.1%) stddev-sans-first:40004.48 04:01:14 INFO - PROCESS | 1952 | Values: 697.3 719.2 773.8 774.5 813.0 15428.9 16485.3 16488.4 16540.3 16551.8 14804.8 14847.3 14863.1 14863.3 14922.5 678.6 701.3 707.2 832.8 841.1 859.2 859.3 873.6 876.8 878.9 917.6 919.8 920.3 920.5 924.4 716.4 737.0 910.3 912.4 913.7 656.6 671.2 674.8 675.2 676.6 13412.2 14432.7 14852.9 15388.2 15389.0 13139.3 13576.0 13662.7 13988.7 14072.2 12288.6 12592.9 12700.8 12973.0 13353.4 4540.6 4574.7 4629.0 4665.3 4749.0 117717.0 118685.4 119586.0 120197.4 120621.5 9423.9 10942.6 10987.5 11442.4 11451.5 21716.0 22372.2 22423.9 22430.8 22511.0 7551.4 7733.2 7744.5 7896.2 8073.6 4213.5 4278.4 4392.2 4402.4 4453.7 3455.4 3573.0 3574.6 3577.7 3579.2 631.9 633.7 638.1 658.9 662.9 502.5 518.8 584.4 680.9 700.8 8710.7 9548.0 9688.1 9794.6 9858.7 631.9 633.1 638.5 649.6 686.4 4255.6 4636.3 4754.4 4867.4 5074.9 114956.0 151234.0 153905.2 157688.2 160361.0 129422.0 131348.0 131583.0 133517.0 137976.0 116726.0 117711.2 118510.0 120213.0 120637.4 9990.5 10125.2 10173.8 10184.8 10233.4 47411.5 49100.8 65823.7 66411.0 68715.0 54382.0 56666.7 63978.4 63998.0 82906.6 13109.5 13218.5 13283.5 13373.5 13863.7 14889.1 14907.9 14911.3 14917.7 14932.3 11649.7 13110.7 13464.2 13524.7 13952.2 12875.0 13538.4 13736.7 13876.4 13879.9 13114.0 13338.7 13668.7 14253.4 14278.5 11145.3 11495.3 11848.5 11993.6 12037.4 11201.2 11512.5 11669.8 11737.8 11769.0 04:01:14 INFO - PROCESS | 1952 | -------- Summary: end -------- 04:01:14 INFO - PROCESS | 1952 | 04:01:14 INFO - TEST-INFO | 1952: exit 0 04:01:14 INFO - TEST-OK | dromaeo_css | took 1117110ms 04:01:14 INFO - TEST-START | kraken 04:01:14 INFO - operating with platform_type : mac_ 04:01:14 INFO - Initialising browser for kraken test... 04:01:14 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmp24V_uN/profile http://localhost:49440/getInfo.html) 04:01:17 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 04:01:17 INFO - PROCESS | 1961 | colorDepth:24 04:01:17 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 04:01:17 INFO - PROCESS | 1961 | __metrics 04:01:17 INFO - PROCESS | 1961 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:01:17 INFO - PROCESS | 1961 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:01:17 INFO - TEST-INFO | 1961: exit 0 04:01:17 INFO - Browser initialized. 04:01:17 INFO - Running cycle 1/1 for kraken test... 04:01:17 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmp24V_uN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:29 INFO - PROCESS | 1963 | RSS: Main: 219729920 04:01:29 INFO - PROCESS | 1963 | 04:01:32 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:33 INFO - PROCESS | 1963 | RSS: Main: 270774272 04:01:33 INFO - PROCESS | 1963 | 04:01:35 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-dft) 04:01:36 INFO - PROCESS | 1963 | RSS: Main: 281681920 04:01:36 INFO - PROCESS | 1963 | 04:01:39 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-fft) 04:01:40 INFO - PROCESS | 1963 | RSS: Main: 380395520 04:01:40 INFO - PROCESS | 1963 | 04:01:42 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator) 04:01:42 INFO - PROCESS | 1963 | RSS: Main: 280731648 04:01:42 INFO - PROCESS | 1963 | 04:01:44 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:45 INFO - PROCESS | 1963 | RSS: Main: 281169920 04:01:45 INFO - PROCESS | 1963 | 04:01:48 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:48 INFO - PROCESS | 1963 | RSS: Main: 318771200 04:01:48 INFO - PROCESS | 1963 | 04:01:51 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:52 INFO - PROCESS | 1963 | RSS: Main: 321101824 04:01:52 INFO - PROCESS | 1963 | 04:01:55 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial) 04:01:55 INFO - PROCESS | 1963 | RSS: Main: 317014016 04:01:55 INFO - PROCESS | 1963 | 04:01:57 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:58 INFO - PROCESS | 1963 | RSS: Main: 290332672 04:01:58 INFO - PROCESS | 1963 | 04:01:59 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:00 INFO - PROCESS | 1963 | RSS: Main: 295727104 04:02:00 INFO - PROCESS | 1963 | 04:02:02 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:02:03 INFO - PROCESS | 1963 | RSS: Main: 298385408 04:02:03 INFO - PROCESS | 1963 | 04:02:06 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:07 INFO - PROCESS | 1963 | RSS: Main: 308948992 04:02:07 INFO - PROCESS | 1963 | 04:02:09 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:02:10 INFO - PROCESS | 1963 | RSS: Main: 308416512 04:02:10 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49440/tests/kraken/driver.html?testName=ai-astar) 04:02:12 INFO - PROCESS | 1963 | RSS: Main: 351956992 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | __start_tp_report 04:02:12 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 04:02:12 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 04:02:12 INFO - PROCESS | 1963 | |i|pagename|runs| 04:02:12 INFO - PROCESS | 1963 | |0;ai-astar;114;115;115;114;114;115;113;114;115;115 04:02:12 INFO - PROCESS | 1963 | |1;audio-beat-detection;141;107;107;140;109;108;107;112;170;112 04:02:12 INFO - PROCESS | 1963 | |2;audio-dft;182;185;182;186;183;182;179;184;186;183 04:02:12 INFO - PROCESS | 1963 | |3;audio-fft;80;58;59;94;86;81;59;58;82;57 04:02:12 INFO - PROCESS | 1963 | |4;audio-oscillator;88;70;93;70;67;69;92;68;69;90 04:02:12 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;88;85;87;85;85;84;88;85;89;129 04:02:12 INFO - PROCESS | 1963 | |6;imaging-darkroom;92;94;93;93;92;93;93;109;148;147 04:02:12 INFO - PROCESS | 1963 | |7;imaging-desaturate;84;84;83;87;102;142;84;84;84;85 04:02:12 INFO - PROCESS | 1963 | |8;json-parse-financial;60;55;55;55;57;59;60;58;56;58 04:02:12 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;69;69;63;75;71;69;68;70;71;72 04:02:12 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;83;82;83;81;80;71;93;92;99;89 04:02:12 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;138;138;139;144;146;139;141;139;172;137 04:02:12 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;157;166;162;161;163;161;163;160;162;162 04:02:12 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;67;67;69;77;83;82;83;83;81;72 04:02:12 INFO - PROCESS | 1963 | __end_tp_report 04:02:12 INFO - PROCESS | 1963 | __start_cc_report 04:02:12 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1915 04:02:12 INFO - PROCESS | 1963 | __end_cc_report 04:02:12 INFO - PROCESS | 1963 | __startTimestamp1476270132534__endTimestamp 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | ------- Summary: start ------- 04:02:12 INFO - PROCESS | 1963 | Number of tests: 14 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:02:12 INFO - PROCESS | 1963 | Values: 114.0 115.0 115.0 114.0 114.0 115.0 113.0 114.0 115.0 115.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:121.30 Median:112.00 stddev:21.66 (19.3%) stddev-sans-first:21.77 04:02:12 INFO - PROCESS | 1963 | Values: 141.0 107.0 107.0 140.0 109.0 108.0 107.0 112.0 170.0 112.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:2.15 (1.2%) stddev-sans-first:2.24 04:02:12 INFO - PROCESS | 1963 | Values: 182.0 185.0 182.0 186.0 183.0 182.0 179.0 184.0 186.0 183.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:71.40 Median:80.50 stddev:14.44 (17.9%) stddev-sans-first:14.98 04:02:12 INFO - PROCESS | 1963 | Values: 80.0 58.0 59.0 94.0 86.0 81.0 59.0 58.0 82.0 57.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.00 stddev:11.42 (14.5%) stddev-sans-first:11.48 04:02:12 INFO - PROCESS | 1963 | Values: 88.0 70.0 93.0 70.0 67.0 69.0 92.0 68.0 69.0 90.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:86.00 stddev:13.63 (15.9%) stddev-sans-first:14.43 04:02:12 INFO - PROCESS | 1963 | Values: 88.0 85.0 87.0 85.0 85.0 84.0 88.0 85.0 89.0 129.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:105.40 Median:93.00 stddev:22.76 (24.5%) stddev-sans-first:23.62 04:02:12 INFO - PROCESS | 1963 | Values: 92.0 94.0 93.0 93.0 92.0 93.0 93.0 109.0 148.0 147.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:84.00 stddev:18.48 (22.0%) stddev-sans-first:19.38 04:02:12 INFO - PROCESS | 1963 | Values: 84.0 84.0 83.0 87.0 102.0 142.0 84.0 84.0 84.0 85.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:2.00 (3.5%) stddev-sans-first:1.87 04:02:12 INFO - PROCESS | 1963 | Values: 60.0 55.0 55.0 55.0 57.0 59.0 60.0 58.0 56.0 58.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.50 stddev:3.09 (4.4%) stddev-sans-first:3.27 04:02:12 INFO - PROCESS | 1963 | Values: 69.0 69.0 63.0 75.0 71.0 69.0 68.0 70.0 71.0 72.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:8.01 (9.3%) stddev-sans-first:8.46 04:02:12 INFO - PROCESS | 1963 | Values: 83.0 82.0 83.0 81.0 80.0 71.0 93.0 92.0 99.0 89.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:140.00 stddev:10.48 (7.5%) stddev-sans-first:10.94 04:02:12 INFO - PROCESS | 1963 | Values: 138.0 138.0 139.0 144.0 146.0 139.0 141.0 139.0 172.0 137.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:1.72 04:02:12 INFO - PROCESS | 1963 | Values: 157.0 166.0 162.0 161.0 163.0 161.0 163.0 160.0 162.0 162.0 04:02:12 INFO - PROCESS | 1963 | 04:02:12 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:81.50 stddev:6.95 (8.5%) stddev-sans-first:6.48 04:02:12 INFO - PROCESS | 1963 | Values: 67.0 67.0 69.0 77.0 83.0 82.0 83.0 83.0 81.0 72.0 04:02:12 INFO - PROCESS | 1963 | -------- Summary: end -------- 04:02:12 INFO - PROCESS | 1963 | 04:02:13 INFO - TEST-INFO | 1963: exit 0 04:02:13 INFO - TEST-OK | kraken | took 58738ms 04:02:13 INFO - SUITE-END | took 1175s 04:02:13 INFO - Completed test suite (00:19:36) 04:02:13 INFO - javascript benchmark 04:02:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.8687902673582, 3291.5391845141685, 3328.8169150696717, 3333.616634087081, 3377.408953433149, 5580.944190558093, 5657.773689052438, 5684.54523638109, 5739.741711622976, 5759.45285197906, 5608.551315894729, 5616.775328986836, 5651.434856514346, 5669.0646043402785, 5724.7996320128805, 5155.871103222412, 5182.404023537285, 5191.766370513336, 5210.0, 5238.4499627539135, 5142.228665700156, 5148.0, 5163.019026384994, 5280.735963201824, 5343.625946183769, 5259.631825772198, 5278.709670968095, 5279.973600131994, 5281.207818827187, 5287.444818294081, 4367.650587952956, 5261.184516399964, 5262.605304602151, 5274.525292723673, 5277.6041796865, 4629.583337499641, 4765.26138448541, 5165.9225111623355, 5213.504717051874, 5218.478152184751, 5595.21666966625, 5663.603547751659, 5698.857528561778, 5704.458076482728, 5742.052561327376, 6151.0, 6197.225346831646, 6200.81397558074, 6220.284667263232, 6238.1578486904145, 5322.4411436799355, 6233.812985610439, 6254.562180647356, 6305.653189074599, 6309.810705678837, 4969.403671559364, 5626.774929002835, 5702.258706368146, 5735.627184233012, 5769.0, 6146.647737497743, 6248.625082495065, 6262.060690896402, 6263.154474146023, 6279.654618995908, 6110.236220472441, 6115.235595550556, 6125.234345706786, 6134.447899689049, 6137.202163718688, 6130.417610327012, 6139.017757158833, 6172.783952561639, 6227.221597300338, 6228.719707613168, 6195.721192546346, 6217.0052791553135, 6248.718807653667, 6250.312465628777, 6261.123442718023, 6248.4688801452385, 6266.592671476339, 6274.403931626488, 6276.6547839869245, 6293.622382657055, 4834.5890599299455, 4852.708837469763, 4862.367892173995, 4914.508549145128, 4944.456109827916, 4395.384646149541, 4457.286834106528, 4463.397441345377, 4473.485549161888, 4486.5962063414445, 5788.334341550775, 5813.680247586339, 5821.0, 5821.301443826768, 5842.620229685057, 6211.937880621226, 6235.875282494325, 6244.594101383395, 6247.219097612799, 6279.183706118267, 5662.122371032414, 5681.34664513578, 5704.828855134353, 5740.741666625012, 5744.626599271034, 5391.757370918318, 5405.567554595702, 5443.700596467233, 5447.182922561568, 5454.236406903036, 6249.312575616587, 6268.592541484789, 6274.152989346379, 6281.905771413432, 6289.96855015722, 6092.0, 6160.014397696347, 6186.1030150627, 6188.597741146811, 6260.780872669435, 6204.5036397089025, 6241.188645476059, 6244.2819075806865, 6256.7810126645345, 6270.49836013127, 6117.816465506042, 6117.877642447037, 6132.141500189888, 6136.140940268277, 6155.107509411021, 6175.413335733098, 6202.627842329474, 6219.284782250099, 6233.657148856675, 6253.593516421418, 5925.733341999534, 6004.219451471456, 6026.728797204224, 6044.818655440344, 6070.605410648293, 6055.424734650202, 6069.484093852072, 6088.178095956989, 6094.939050609437, 6098.115773212948, 5461.863453413696, 5899.705014749159, 5919.052951527735, 5924.555658325557, 5942.64344139353, 5241.135212689864, 5725.799597014251, 6006.879862402815, 6025.6083354581815, 6043.36544662804, 5919.141724450017, 5950.375210602824, 5963.582549221513, 5968.910466342922, 5973.104034394875], "value": 5663.7191202398635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.5068600568384, 501.9447860735319, 518.3287642502959, 522.1306524636481, 528.3263838605777, 30620.846895765517, 40382.78851634452, 41626.58373416269, 41726.0, 43822.46621368253, 43865.0, 44013.77993110038, 44073.55926440735, 44097.338539921926, 44161.0, 9729.075737804915, 9911.306208565404, 9920.95829937857, 9921.801563968753, 9942.353747006458, 8792.42849214799, 8995.0, 12034.759304813899, 12232.0, 12234.265944043385, 12111.818322725123, 12205.267683938991, 12208.206466579688, 12216.511339546407, 12237.021038316912, 12146.635600931986, 12208.877911220863, 12225.572104976283, 12228.082893782914, 12253.203541769757, 12013.339266340348, 12066.215695979821, 12102.697432564168, 12115.454804533818, 12116.81824772629, 40571.37714491446, 40944.795276023724, 41039.0, 41071.0, 41340.793296033626, 3250.8374581271078, 3301.950470742941, 3308.586426696663, 3344.0803778960735, 3369.4945758136478, 30755.0, 31670.208244793834, 31835.204119896956, 32004.839975800205, 32079.679203207903, 2868.0535423310257, 3188.9202769930707, 3193.840307984615, 3199.9040028799172, 3396.235846934445, 524603.0, 527921.0, 528305.358473209, 529463.0, 529602.0, 61839.0, 62022.0, 62344.37655623476, 62418.127456175476, 62426.68786656038, 35853.82073089618, 36223.4566481503, 36526.0, 36587.4511882322, 36623.4506482403, 17223.96656200632, 17354.826451735575, 17375.73936390955, 17393.65212695739, 17409.47771566855, 11997.700057498632, 12276.877231227574, 13218.405171767294, 13321.800172997413, 13324.333783310796, 19389.22443102288, 19448.4285125833, 19525.51186220356, 19567.608647826964, 20048.69926951097, 7804.6878124874365, 7869.0, 7887.132415434297, 7890.64492097857, 7976.242256985577, 797.7247849491916, 877.2674816528271, 884.425123669607, 918.3112665500875, 978.1587834462357, 30078.947236846605, 30256.54615180774, 30389.344872418013, 30399.24001899926, 30536.694633053386, 1043.968680939573, 1059.0204061243319, 1060.984085238722, 1076.7523469602036, 1082.9187810914214, 13262.806347428777, 13788.379522921492, 14710.896682748837, 15330.233488325539, 15437.922810385877, 693521.0, 702429.0, 706456.0, 714242.0, 715593.0, 52866.735666322194, 56342.436575634536, 56432.435675642715, 56609.71695141498, 56634.0, 1236.3262022197923, 1257.1388598810026, 1340.631326385252, 1363.7272545490941, 1378.5864240727942, 29621.5556766653, 29989.55015674723, 30232.84883575568, 30395.351850190742, 30714.539281911235, 46735.0, 47294.0, 47299.52700473089, 47387.052258955315, 47438.0, 560906.0, 564391.0, 566613.0, 566639.0, 567027.0, 24693.87653061723, 25263.0, 25310.240692779247, 25328.0, 25347.746522534537, 45666.71666416599, 47461.28808067951, 47774.5222547784, 47924.5207547934, 48776.07343559398, 38107.329362580516, 38987.80506097451, 39337.80331098326, 40118.799406002785, 40780.38829417502, 38515.807420963836, 39002.804985974886, 39038.4144237831, 40641.796791015855, 40771.1845763089, 38097.23805523929, 38398.0, 38730.4190437138, 39057.218855623294, 39058.0, 33951.49072763861, 34434.65565344415, 34592.82703586466, 35087.0, 35138.12154696153, 25320.746792531838, 25702.0, 25797.484050319264, 25905.0, 26268.0], "value": 20253.08671845272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.68699544400926, 378.6251610905204, 381.1880694121519, 388.23517670189733, 412.1612518524803, 15048.473303434383, 15090.849091509095, 18028.369007084737, 20642.174313027463, 20751.273705420277, 19924.0, 20023.799762002374, 20635.793642063574, 20721.689174662355, 20723.171073157093, 5517.089680202762, 5806.390329015435, 5844.883102337962, 6095.3599872013465, 6095.390460953891, 5218.425973142951, 5887.499562537189, 6072.180255665495, 6084.665343406111, 6093.055576385667, 5713.542916566665, 5833.125031245305, 5881.794137205198, 6033.185519954794, 6038.48672862805, 5924.58527903047, 5937.1984782054515, 5939.584229103964, 5952.136940143677, 5961.552883533731, 4996.475370086125, 5109.0, 5114.846554603368, 5169.870753231162, 5186.222066690027, 24617.63073553898, 25520.36199095019, 25719.0, 25785.871070644713, 25831.35421614456, 2398.069677521427, 2412.1075202175134, 2423.7212720537186, 2511.3470497670555, 3102.0685452247635, 10159.695209143738, 12565.371731413485, 13070.477180912752, 14670.339834707356, 15623.0, 1882.1718443884647, 1893.1764682363216, 1908.236705317884, 1933.0721253798256, 1942.8931408772512, 91955.0, 116041.0, 118437.40781296039, 119852.40073799662, 120720.0, 11185.720356990978, 11234.371016202605, 11330.490127944262, 11428.771424571461, 11450.828237576443, 14339.283035848166, 14384.928075359556, 14394.640133996734, 14397.78403323951, 14408.42366305336, 8516.957415212884, 8628.22345988864, 8641.697540586048, 8684.305255579538, 8760.123987601317, 7378.114626244777, 8641.870371944426, 8671.479711217347, 8815.603297851483, 8819.647214111492, 4337.869863904025, 4461.643068554507, 4492.05666809967, 4492.573205545468, 4544.0457503924545, 1867.327762005677, 1908.265317852609, 1918.6642337590865, 1922.0774028466415, 1924.7401600783714, 824.3528829868644, 939.8966113727485, 944.4427787605208, 961.990380096204, 1001.6093723447862, 17891.910540447476, 19411.2235510578, 19842.0, 20551.79448205499, 20717.0, 908.8591268353416, 925.3106435705442, 933.7992331648728, 936.3071327217809, 941.4445477168504, 10267.486625668687, 10557.47212639365, 10691.946540267249, 10777.515011824487, 10795.676129716121, 547296.0, 549058.0, 550354.0, 559870.0, 563276.0, 114113.0, 117515.8248417522, 119217.40391297988, 124902.0, 126345.0, 952.7094236258008, 953.0897992417086, 954.1365064616533, 990.3661656539821, 995.0, 15062.794976402081, 16961.66076678435, 17349.0, 18145.818541814413, 18495.815041849408, 52786.472135278156, 53433.931321372576, 54079.45920540902, 54360.0, 55383.78464861522, 74414.2558574429, 75039.0, 75453.11367215864, 76253.0, 76405.0, 6252.280987686474, 6865.27914568963, 6981.895271571032, 7198.280171982759, 7263.745768898063, 7747.0, 11981.76036479248, 12460.87539124597, 12824.679383015125, 13123.671908202372, 10937.398443085707, 11125.109991200847, 11250.66248012561, 11400.771984560428, 11552.191346605658, 11060.723481913017, 11129.165312601426, 11272.210945233755, 11381.658550243506, 11483.770324593628, 11180.888191117985, 11391.487383067617, 11729.589464368706, 11894.286342819458, 11902.523899043941, 7151.141862976476, 7432.814179645552, 7500.437467189873, 7503.624818759149, 7592.658330375036, 9873.111419972238, 10892.18308626872, 10937.726556836144, 11335.319880807177, 11456.656300311004], "value": 9451.575797359254, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.2989680417786, 1468.2658670664664, 1506.6986602679463, 1684.418875487957, 1861.4787859399364, 7956.880646790296, 8413.116622754615, 8416.368772342068, 8423.326133909288, 8431.156884311573, 8206.343492520598, 8731.476111433318, 8942.0, 8944.418612790181, 8975.192232699055, 2379.7144342678857, 2412.372783076395, 2413.420779013033, 2415.4202991282054, 2416.178499310234, 2371.845830021043, 2402.231285988484, 2413.7706917842866, 2414.263649586875, 2419.1532963462823, 2380.2026321182425, 2398.2565404724505, 2407.626817843237, 2413.3604594782396, 2417.576924038295, 1976.2391479280436, 2379.9286021419384, 2394.5929192037306, 2394.844335118229, 2398.3524448399007, 2348.835581509295, 2372.8694921779297, 2380.5119950410126, 2381.988090059556, 2387.749286324928, 8811.77970550735, 8847.557622118868, 8936.8659470108, 8940.73177804667, 8947.731568052968, 5257.605679574047, 5319.228711836762, 5446.836594902159, 5452.345718513764, 5454.372747134091, 3673.1735359544155, 3737.794421306827, 3741.8129093545213, 3755.324041672498, 3769.6795772359383, 1097.6048622495896, 1113.788380207766, 1123.27548731068, 1125.9605913792977, 1137.0, 11751.353675547842, 11882.930536251779, 11968.82046769299, 11971.94014029933, 12151.0, 3939.7242193046786, 3954.3277642800795, 4330.328799036154, 4632.452151316762, 4697.271922851964, 9257.861132083024, 9259.67591134307, 9260.814783704289, 9263.722088337227, 9269.907300926905, 5299.39057008449, 5314.388845282765, 5314.5216930476445, 5315.893682126413, 5316.574674026146, 4437.29003359461, 4535.455745310584, 4931.7040977541465, 4956.157453232959, 4993.17612593918, 3751.756135851161, 3753.174301653632, 3849.3840985442193, 3856.1130939883983, 3881.7865017424315, 976.9218462522981, 1164.8136298192248, 1179.598936361641, 1180.5749930025183, 1183.3136780667191, 757.4167890724111, 846.8221673448645, 890.3366991591306, 912.6121398405651, 919.6735159018585, 5728.283964504437, 5737.569682273846, 5738.167965644958, 6037.516998640098, 6123.663198524035, 928.9535523223811, 946.1012038563392, 952.0859974424492, 964.1611797736015, 986.7483791633088, 3808.1622043151015, 3968.9603103969166, 4000.27994960904, 4061.268971585143, 4077.3068578341754, 10716.03555679977, 10926.945365273281, 11044.668659940215, 11071.944640276746, 11084.445777711244, 10616.416097114577, 10993.560257589606, 11009.2843965142, 11013.559457621606, 11021.504032318566, 7207.351338379466, 8367.790805229795, 8382.83234335322, 8386.664533418718, 8408.537530435884, 5710.2862142232225, 5738.340090889435, 5741.282339707536, 5897.734601942837, 5913.34953155144, 8779.780505487159, 10009.449480278654, 10154.847677284994, 10332.948335258276, 10358.637447689294, 9629.085236902483, 9822.705318840446, 9938.155256803253, 10143.695689129338, 10304.484775761332, 6932.930670693228, 7137.678804453708, 7157.498975071903, 7479.102507699111, 7540.359069479156, 7873.606319684108, 7913.248241417056, 7937.32532734724, 8134.87797683047, 8422.873656895274, 7444.292792184734, 7533.849323013399, 7564.167941526538, 7590.734324298623, 7712.9614351927885, 7281.708731650675, 7352.154502232312, 7374.225706300761, 7469.9915511407435, 7557.811054723676, 6925.376716095576, 7068.71725130989, 7070.823229419306, 7079.115110611174, 7100.751473698396, 4944.25593795447, 4956.355673762532, 5003.849884503471, 5007.874803129951, 5039.445660977216, 4837.685550439211, 4871.391076115486, 4906.215005599087, 5019.222020586815, 5031.245313203049], "value": 4569.337289945626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.57885802160916, 297.99255018624535, 307.6600356605951, 309.924068603192, 312.2739630359415, 4538.90922181557, 4829.468758436574, 5142.588592912567, 5182.844514664556, 5292.259083728281, 4940.481249468808, 4957.620342235729, 5032.949670503293, 5037.798488060483, 5184.922226166611, 4002.6597739192202, 4011.618896204856, 4016.8594099206534, 4024.678025757932, 4031.919361612766, 3316.950245746316, 3541.8583256669704, 3790.6019867913888, 3964.623360780721, 4036.475258216428, 3346.7322614190807, 3881.8835434936996, 3986.4219688145345, 3994.4208089826957, 4032.0927791247027, 3730.9440358394645, 4016.9397459038137, 4020.477337946063, 4021.0, 4043.5147782266317, 3342.699157075875, 3482.432905192648, 3518.683318501347, 3525.906968839668, 3539.0181498361, 5002.974985125087, 5065.569426598743, 5091.8981620367385, 5103.438621751604, 5114.820981265675, 4066.593340665939, 4076.694247931417, 4546.317862390936, 4576.679632425731, 4587.4036375271, 4513.413256276663, 5431.266778984826, 5485.917711234335, 5493.642913210629, 5579.572885794692, 3401.4727717203627, 3596.1369271374942, 3885.941710874339, 3887.3974533947285, 3909.061825161969, 4764.190087685032, 5252.553532949704, 5369.623756638366, 5377.838664840061, 5688.752942587655, 3794.430835374716, 3818.4463252828186, 3822.5604055533413, 3848.9807550962064, 3873.845046198177, 3900.7907548660005, 3914.119323152268, 3919.628130154423, 3919.9612102792785, 3933.724639275223, 4234.591154120901, 4520.52534483881, 4544.613892762739, 4554.772261386917, 4595.862124136214, 4615.861524154281, 4808.2547205183255, 5488.067028605146, 5575.358833734173, 5605.663660180402, 1088.1131877519797, 1295.3005377096451, 1343.751405989895, 1347.158026233604, 1349.7840345544862, 762.7376691575452, 832.5545832979327, 860.8206756743302, 924.7549399409162, 942.4580866002076, 5019.247112933016, 5086.287919691246, 5125.410577783528, 5165.14775062118, 5217.2695822584865, 5166.793328266827, 5301.363836339664, 5597.916031259534, 5645.661260324394, 5684.573656975744, 4527.864164075083, 4719.38647975761, 5067.41724701664, 5103.234514822806, 5145.794168233304, 2576.9226923192336, 2938.9566703820265, 2941.0, 2948.764098872085, 2949.985250073779, 4957.256411538226, 5479.150731636602, 5800.796972105956, 5819.73811178498, 5832.650040997553, 5105.366282789546, 5485.890282194334, 5527.861803454865, 5614.887702245932, 5744.253247077853, 5126.897462050738, 5224.373075230997, 5445.264889239981, 5532.197831314517, 5779.219805326311, 4406.523814522171, 4674.766261686834, 4859.854204373874, 5310.548603368757, 5656.953463609246, 5526.972365138148, 5534.557235421076, 5544.584156188222, 5549.889002220014, 5608.906263278622, 5076.390833100052, 5776.335721392094, 5792.420757924342, 5826.271716035496, 5849.612790407195, 3320.9501857471673, 3649.3978493548266, 3893.377059670439, 3902.8829135125993, 3918.7648741074486, 4655.4180727409075, 5585.676522469124, 5588.720563971867, 5598.888022239451, 5613.382527921844, 4371.868843934687, 5014.297998280171, 5437.429069947599, 5489.752961116679, 5559.833205003856, 4324.2648749712, 4988.759554378749, 5076.771545280398, 5376.623636345418, 5399.271098401666, 4367.432233809584, 4431.8670439886855, 5095.159298715818, 5176.171812509981, 5305.442928492453, 5237.659552129099, 5399.622026458111, 5410.621256512164, 5509.063459211863, 5524.392316845224, 5384.434634363335, 5410.891782164414, 5416.968636761215, 5418.45815418455, 5433.076377015996], "value": 3990.001176765238, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3235961117717, 719.1514013464111, 773.7523992322459, 774.4540099230044, 813.0, 15428.922855385721, 16485.258163382645, 16488.42290519832, 16540.255688494017, 16551.83448165518, 14804.777928331083, 14847.257637118155, 14863.108213507197, 14863.256837158126, 14922.477713280037, 678.6403206300669, 701.3337329536935, 707.2397173039004, 832.81261716114, 841.0622156295717, 859.2395729779159, 859.2610355094614, 873.5894129759004, 876.7939534209455, 878.8857448531681, 917.6329468212701, 919.797644518205, 920.282179899676, 920.4937284493535, 924.3945215883573, 716.44833478222, 736.9976831509143, 910.3081657939947, 912.4206129108031, 913.7167478081783, 656.6257233376977, 671.1979184874077, 674.7570874485182, 675.1864003875319, 676.610948704492, 13412.195268283935, 14432.711345773027, 14852.925735371255, 15388.230588470531, 15388.999715018488, 13139.34303284832, 13576.049676522647, 13662.726745465134, 13988.72022559543, 14072.22602756848, 12288.569900053455, 12592.937035314857, 12700.751729974629, 12973.021501997528, 13353.399097040656, 4540.591346778772, 4574.679772415932, 4628.995263769337, 4665.300204969248, 4748.978969521535, 117717.0, 118685.40657296659, 119586.0, 120197.39901300526, 120621.53229545247, 9423.90576094244, 10942.617008404668, 10987.450627468595, 11442.427878606037, 11451.541938322374, 21716.0, 22372.216972405888, 22423.88788056082, 22430.775692243194, 22511.0, 7551.395888328921, 7733.188015258429, 7744.535327880232, 7896.170902055316, 8073.6366863491285, 4213.4522512073845, 4278.44380230568, 4392.165488557164, 4402.427684401071, 4453.688241823042, 3455.4125798614295, 3573.0352804742574, 3574.5889222739197, 3577.713782897362, 3579.2483578448296, 631.8957372033562, 633.6514916795836, 638.1034646321925, 658.8517583543664, 662.9303923088103, 502.52762403340745, 518.8287865004539, 584.41040370193, 680.9080774095434, 700.8072779985545, 8710.695125670698, 9547.952260238655, 9688.12806847373, 9794.608215671293, 9858.654947076819, 631.9178506794179, 633.0535848905915, 638.5274896576593, 649.5875119299279, 686.4028295383049, 4255.638270747021, 4636.304554316812, 4754.405699287589, 4867.367242258484, 5074.949250507521, 114956.0, 151234.0, 153905.23047384692, 157688.21155894146, 160361.0, 129422.0, 131348.0, 131583.0, 133517.0, 137976.0, 116726.0, 117711.2343314851, 118509.99999999827, 120213.0, 120637.39681301537, 9990.450525221182, 10125.179683756789, 10173.796524069625, 10184.847227291448, 10233.385996840214, 47411.52588474071, 49100.75449622729, 65823.67088164529, 66411.0, 68715.0, 54382.0, 56666.7166664164, 63978.3602163991, 63998.0, 82906.58546707469, 13109.541166059142, 13218.537351192663, 13283.535076272285, 13373.53192638253, 13863.722725545635, 14889.106653600818, 14907.850921490646, 14911.32899019525, 14917.701645967238, 14932.253387330808, 11649.650510484698, 13110.672233194246, 13464.192148471124, 13524.661883452993, 13952.16287022782, 12875.0, 13538.390772415461, 13736.725265494833, 13876.375563099886, 13879.861201387857, 13114.0, 13338.733225335633, 13668.65828354299, 14253.429862805371, 14278.500252491112, 11145.331280123219, 11495.310281383145, 11848.52605895789, 11993.580224692094, 12037.398130093285, 11201.159913006393, 11512.481938312963, 11669.76660466769, 11737.823932641188, 11769.0], "value": 7862.632186276652, "unit": "score"}], "name": "dromaeo_css", "value": 7332.575244104642, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 115.0, 113.0, 114.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 107.0, 140.0, 109.0, 108.0, 107.0, 112.0, 170.0, 112.0], "value": 121.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 182.0, 186.0, 183.0, 182.0, 179.0, 184.0, 186.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 94.0, 86.0, 81.0, 59.0, 58.0, 82.0, 57.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 70.0, 67.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 85.0, 84.0, 88.0, 85.0, 89.0, 129.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 93.0, 92.0, 93.0, 93.0, 109.0, 148.0, 147.0], "value": 105.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 87.0, 102.0, 142.0, 84.0, 84.0, 84.0, 85.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 55.0, 55.0, 57.0, 59.0, 60.0, 58.0, 56.0, 58.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 63.0, 75.0, 71.0, 69.0, 68.0, 70.0, 71.0, 72.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 81.0, 80.0, 71.0, 93.0, 92.0, 99.0, 89.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 139.0, 144.0, 146.0, 139.0, 141.0, 139.0, 172.0, 137.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 166.0, 162.0, 161.0, 163.0, 161.0, 163.0, 160.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 77.0, 83.0, 82.0, 83.0, 83.0, 81.0, 72.0], "value": 76.4, "unit": "score"}], "name": "kraken", "value": 1449.4, "alertThreshold": 2.0}]} 04:02:13 INFO - Return code: 0 04:02:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:13 INFO - # TBPL SUCCESS # 04:02:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:02:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:02:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:02:13 INFO - 2016-10-12 04:02:13.855 screenresolution[1967:11440] starting screenresolution argv=screenresolution get 04:02:13 INFO - 2016-10-12 04:02:13.858 screenresolution[1967:11440] Display 0: 1600x1200x32@60 04:02:13 INFO - 2016-10-12 04:02:13.864 screenresolution[1968:11443] starting screenresolution argv=screenresolution list 04:02:13 INFO - Available Modes on Display 0 04:02:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:02:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:02:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:02:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:02:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:02:14 INFO - Intel Iris: 04:02:14 INFO - Chipset Model: Intel Iris 04:02:14 INFO - Type: GPU 04:02:14 INFO - Bus: Built-In 04:02:14 INFO - VRAM (Dynamic, Max): 1536 MB 04:02:14 INFO - Vendor: Intel (0x8086) 04:02:14 INFO - Device ID: 0x0a2e 04:02:14 INFO - Revision ID: 0x0009 04:02:14 INFO - Displays: 04:02:14 INFO - Display: 04:02:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:02:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:02:14 INFO - Display Serial Number: 1600x1200 60 04:02:14 INFO - Main Display: Yes 04:02:14 INFO - Mirror: Off 04:02:14 INFO - Online: Yes 04:02:14 INFO - Rotation: Supported 04:02:14 INFO - Return code: 0 04:02:14 INFO - Running post-action listener: _resource_record_post_action 04:02:14 INFO - [mozharness: 2016-10-12 11:02:14.099580Z] Finished run-tests step (success) 04:02:14 INFO - Running post-run listener: _resource_record_post_run 04:02:14 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 2486272; Write bytes: 664939008; Read time: 24; Write time: 1915 04:02:14 INFO - TinderboxPrint: CPU usage
53.4% 04:02:14 INFO - TinderboxPrint: I/O read bytes / time
2,486,272 / 24 04:02:14 INFO - TinderboxPrint: I/O write bytes / time
664,939,008 / 1,915 04:02:14 INFO - TinderboxPrint: CPU idle
2,253.1 (46.6%) 04:02:14 INFO - TinderboxPrint: CPU system
967.6 (20.0%) 04:02:14 INFO - TinderboxPrint: CPU user
1,616.9 (33.4%) 04:02:14 INFO - TinderboxPrint: Swap in / out
365,805,568 / 0 04:02:14 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355914240; Write bytes: 357718016; Read time: 27325; Write time: 761 04:02:14 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1650688; Write bytes: 296198656; Read time: 21; Write time: 1119 04:02:14 INFO - Running post-run listener: _upload_blobber_files 04:02:14 INFO - Blob upload gear active. 04:02:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:14 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 04:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:15 INFO - (blobuploader) - INFO - Done attempting. 04:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:16 INFO - (blobuploader) - INFO - Done attempting. 04:02:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:19 INFO - (blobuploader) - INFO - Done attempting. 04:02:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:19 INFO - Return code: 0 04:02:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac853c6a736f5139a2605167201900ea0ee815be31eed9be050da76c3ad31b81c7f8d681a309d554814f9da7021187f8910a84eb067766221cdb59532c776cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/520cdd7d350b2735d96930fa4f58bc54be40f1087f176c09f21d064853a48b8e07a1dce2013a7d785fb94ae3970afeaa37c19dc95446f789c469ec7815d27cb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7f4867e04b0097dfbaea60c9b8dd509ee0665d2d85b6dd4dd77c14f74108a6ee3632e5fa7b03bf36c64a5ee0fcbe549f4b6dbf03ed09f5851d532b2b3862beb"} 04:02:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:19 INFO - Contents: 04:02:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac853c6a736f5139a2605167201900ea0ee815be31eed9be050da76c3ad31b81c7f8d681a309d554814f9da7021187f8910a84eb067766221cdb59532c776cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/520cdd7d350b2735d96930fa4f58bc54be40f1087f176c09f21d064853a48b8e07a1dce2013a7d785fb94ae3970afeaa37c19dc95446f789c469ec7815d27cb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7f4867e04b0097dfbaea60c9b8dd509ee0665d2d85b6dd4dd77c14f74108a6ee3632e5fa7b03bf36c64a5ee0fcbe549f4b6dbf03ed09f5851d532b2b3862beb"} 04:02:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:19 INFO - Copying logs to upload dir... 04:02:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.192949 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-12 04:02:19.860287) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:02:19.863762) ========= 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.DGCZBn7th1/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.74ZhcmemId/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac853c6a736f5139a2605167201900ea0ee815be31eed9be050da76c3ad31b81c7f8d681a309d554814f9da7021187f8910a84eb067766221cdb59532c776cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/520cdd7d350b2735d96930fa4f58bc54be40f1087f176c09f21d064853a48b8e07a1dce2013a7d785fb94ae3970afeaa37c19dc95446f789c469ec7815d27cb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7f4867e04b0097dfbaea60c9b8dd509ee0665d2d85b6dd4dd77c14f74108a6ee3632e5fa7b03bf36c64a5ee0fcbe549f4b6dbf03ed09f5851d532b2b3862beb"} build_url:https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011050 build_url: 'https://queue.taskcluster.net/v1/task/KW2pax2vQEyyPed6aZbYZg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac853c6a736f5139a2605167201900ea0ee815be31eed9be050da76c3ad31b81c7f8d681a309d554814f9da7021187f8910a84eb067766221cdb59532c776cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/520cdd7d350b2735d96930fa4f58bc54be40f1087f176c09f21d064853a48b8e07a1dce2013a7d785fb94ae3970afeaa37c19dc95446f789c469ec7815d27cb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7f4867e04b0097dfbaea60c9b8dd509ee0665d2d85b6dd4dd77c14f74108a6ee3632e5fa7b03bf36c64a5ee0fcbe549f4b6dbf03ed09f5851d532b2b3862beb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:02:19.903723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:02:19.904262) ========= 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.DGCZBn7th1/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.74ZhcmemId/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.005405 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:02:19.953394) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:02:19.953706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:02:19.954043) ========= ========= Total master_lag: 0.80 =========