builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0211 starttime: 1486030662.15 results: success (0) buildid: 20170202004013 builduid: e660ace11c1a4a7b9a4afd1e3a1e1441 revision: d06f2bf30b22a04b03e2046d5c148adedd6777c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.147060) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.147576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.147908) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.174498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.174966) ========= 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.45BPINLLIu/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.lDP92XqJWz/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-02 02:17:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-02-02 02:17:42 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195794 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.395544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.395985) ========= 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.45BPINLLIu/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.lDP92XqJWz/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.030757 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:42.450088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 02:17:42.450484) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d06f2bf30b22a04b03e2046d5c148adedd6777c1 --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 d06f2bf30b22a04b03e2046d5c148adedd6777c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.45BPINLLIu/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.lDP92XqJWz/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-02 02:17:42,642 truncating revision to first 12 chars 2017-02-02 02:17:42,642 Setting DEBUG logging. 2017-02-02 02:17:42,643 attempt 1/10 2017-02-02 02:17:42,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d06f2bf30b22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 02:17:44,705 unpacking tar archive at: mozilla-aurora-d06f2bf30b22/testing/mozharness/ program finished with exit code 0 elapsedTime=2.326694 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 02:17:44.800765) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:44.801102) ========= script_repo_revision: d06f2bf30b22a04b03e2046d5c148adedd6777c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:44.801527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:44.801792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 02:17:44.821318) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-02-02 02:17:44.821699) ========= /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.45BPINLLIu/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.lDP92XqJWz/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:17:45 INFO - MultiFileLogger online at 20170202 02:17:45 in /builds/slave/test 02:17:45 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 02:17:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:45 INFO - {'append_to_log': False, 02:17:45 INFO - 'base_work_dir': '/builds/slave/test', 02:17:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:17:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:45 INFO - 'branch': 'Mozilla-Aurora', 02:17:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:45 INFO - 'config_files': ('talos/mac_config.py',), 02:17:45 INFO - 'default_actions': ('clobber', 02:17:45 INFO - 'read-buildbot-config', 02:17:45 INFO - 'download-and-extract', 02:17:45 INFO - 'populate-webroot', 02:17:45 INFO - 'create-virtualenv', 02:17:45 INFO - 'install', 02:17:45 INFO - 'run-tests'), 02:17:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:45 INFO - 'download_minidump_stackwalk': True, 02:17:45 INFO - 'download_symbols': 'ondemand', 02:17:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:45 INFO - 'installer_path': 'installer.exe', 02:17:45 INFO - 'log_level': 'info', 02:17:45 INFO - 'log_name': 'talos', 02:17:45 INFO - 'log_to_console': True, 02:17:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:17:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:17:45 INFO - 'opt_config_files': (), 02:17:45 INFO - 'pip_index': False, 02:17:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:17:45 INFO - 'cmd': ('bash', 02:17:45 INFO - '-c', 02:17:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:17:45 INFO - 'enabled': True, 02:17:45 INFO - 'halt_on_failure': False, 02:17:45 INFO - 'name': 'check_screen_resolution'},), 02:17:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:17:45 INFO - 'cmd': ('bash', 02:17:45 INFO - '-c', 02:17:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:17:45 INFO - 'enabled': True, 02:17:45 INFO - 'halt_on_failure': False, 02:17:45 INFO - 'name': 'check_screen_resolution'},), 02:17:45 INFO - 'run_cmd_checks_enabled': True, 02:17:45 INFO - 'sps_profile': False, 02:17:45 INFO - 'sps_profile_interval': 0, 02:17:45 INFO - 'suite': 'dromaeojs', 02:17:45 INFO - 'system_bits': '32', 02:17:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:45 INFO - 'title': 't-yosemite-r7-0211', 02:17:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:45 INFO - 'use_talos_json': True, 02:17:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:45 INFO - 'work_dir': 'build'} 02:17:45 INFO - [mozharness: 2017-02-02 10:17:45.120536Z] Running clobber step. 02:17:45 INFO - Running pre-action listener: _resource_record_pre_action 02:17:45 INFO - Running main action method: clobber 02:17:45 INFO - rmtree: /builds/slave/test/build 02:17:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:47 INFO - Running post-action listener: _resource_record_post_action 02:17:47 INFO - [mozharness: 2017-02-02 10:17:47.498588Z] Finished clobber step (success) 02:17:47 INFO - [mozharness: 2017-02-02 10:17:47.498817Z] Running read-buildbot-config step. 02:17:47 INFO - Running pre-action listener: _resource_record_pre_action 02:17:47 INFO - Running main action method: read_buildbot_config 02:17:47 INFO - Using buildbot properties: 02:17:47 INFO - { 02:17:47 INFO - "project": "", 02:17:47 INFO - "product": "firefox", 02:17:47 INFO - "script_repo_revision": "production", 02:17:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:17:47 INFO - "repository": "", 02:17:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:17:47 INFO - "buildid": "20170202004013", 02:17:47 INFO - "stage_platform": "macosx64", 02:17:47 INFO - "basedir": "/builds/slave/test", 02:17:47 INFO - "nightly_build": "True", 02:17:47 INFO - "buildnumber": 8, 02:17:47 INFO - "slavename": "t-yosemite-r7-0211", 02:17:47 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:17:47 INFO - "platform": "yosemite_r7", 02:17:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:17:47 INFO - "branch": "mozilla-aurora", 02:17:47 INFO - "repo_path": "releases/mozilla-aurora", 02:17:47 INFO - "revision": "d06f2bf30b22a04b03e2046d5c148adedd6777c1", 02:17:47 INFO - "pgo_build": "False", 02:17:47 INFO - "builduid": "e660ace11c1a4a7b9a4afd1e3a1e1441", 02:17:47 INFO - "slavebuilddir": "test" 02:17:47 INFO - } 02:17:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:17:47 INFO - Running post-action listener: _resource_record_post_action 02:17:47 INFO - [mozharness: 2017-02-02 10:17:47.504851Z] Finished read-buildbot-config step (success) 02:17:47 INFO - [mozharness: 2017-02-02 10:17:47.505061Z] Running download-and-extract step. 02:17:47 INFO - Running pre-action listener: _resource_record_pre_action 02:17:47 INFO - Running main action method: download_and_extract 02:17:47 INFO - mkdir: /builds/slave/test/build/tests 02:17:47 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')]} 02:17:47 INFO - trying https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:17:47 INFO - Downloading https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:17:49 INFO - Downloaded 1199 bytes. 02:17:49 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:17:49 INFO - Using the following test package requirements: 02:17:49 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:17:49 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:17:49 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:17:49 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'jsshell-mac.zip'], 02:17:49 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:17:49 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:17:49 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:17:49 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:17:49 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:17:49 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:17:49 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:17:49 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:17:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:17:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:17:49 INFO - Fetch https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:17:52 INFO - Expected file size: 16356155 02:17:52 INFO - Obtained file size: 16356155 02:17:58 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:17:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:17:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:17:58 INFO - Fetch https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:17:59 INFO - Expected file size: 16356155 02:17:59 INFO - Obtained file size: 16356155 02:18:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:18:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:18:05 INFO - Fetch https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:18:12 INFO - Expected file size: 14403485 02:18:12 INFO - Obtained file size: 14403485 02:18: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')]} 02:18:12 INFO - trying https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:18:12 INFO - Downloading https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:18:21 INFO - Downloaded 73953977 bytes. 02:18:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:18:21 INFO - mkdir: /builds/slave/test/properties 02:18:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:18:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:18:21 INFO - Contents: 02:18:21 INFO - build_url:https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:18:22 INFO - Running post-action listener: _resource_record_post_action 02:18:22 INFO - Running post-action listener: set_extra_try_arguments 02:18:22 INFO - [mozharness: 2017-02-02 10:18:22.183835Z] Finished download-and-extract step (success) 02:18:22 INFO - [mozharness: 2017-02-02 10:18:22.183968Z] Running populate-webroot step. 02:18:22 INFO - Running pre-action listener: _resource_record_pre_action 02:18:22 INFO - Running main action method: populate_webroot 02:18:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:18:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:18:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:18:22 INFO - '--tppagecycles', 02:18:22 INFO - '7'], 02:18:22 INFO - 'tests': ['tsvgm']}}, 02:18:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:18:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:18:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:18:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:18:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:18:22 INFO - 'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:18:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:18:22 INFO - 'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['damp', 'tps']}, 02:18:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:18:22 INFO - 'tests': ['damp', 'tps']}, 02:18:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['dromaeo_dom']}, 02:18:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:18:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['basic_compositor_video']}, 02:18:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:18:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['a11yr', 02:18:22 INFO - 'ts_paint', 02:18:22 INFO - 'tpaint', 02:18:22 INFO - 'sessionrestore', 02:18:22 INFO - 'sessionrestore_no_auto_restore', 02:18:22 INFO - 'tabpaint']}, 02:18:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:18:22 INFO - 'ts_paint', 02:18:22 INFO - 'tpaint', 02:18:22 INFO - 'sessionrestore', 02:18:22 INFO - 'sessionrestore_no_auto_restore', 02:18:22 INFO - 'tabpaint']}, 02:18:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:18:22 INFO - 'ts_paint', 02:18:22 INFO - 'tpaint', 02:18:22 INFO - 'sessionrestore', 02:18:22 INFO - 'sessionrestore_no_auto_restore', 02:18:22 INFO - 'tabpaint']}, 02:18:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:18:22 INFO - 'ts_paint', 02:18:22 INFO - 'tpaint', 02:18:22 INFO - 'sessionrestore', 02:18:22 INFO - 'sessionrestore_no_auto_restore', 02:18:22 INFO - 'tabpaint']}, 02:18:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['a11yr', 02:18:22 INFO - 'ts_paint', 02:18:22 INFO - 'tpaint', 02:18:22 INFO - 'sessionrestore', 02:18:22 INFO - 'sessionrestore_no_auto_restore', 02:18:22 INFO - 'tabpaint']}, 02:18:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['a11yr', 02:18:22 INFO - 'ts_paint', 02:18:22 INFO - 'tpaint', 02:18:22 INFO - 'sessionrestore', 02:18:22 INFO - 'sessionrestore_no_auto_restore', 02:18:22 INFO - 'tabpaint']}, 02:18:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['tsvgx', 02:18:22 INFO - 'tsvgr_opacity', 02:18:22 INFO - 'tart', 02:18:22 INFO - 'tscrollx', 02:18:22 INFO - 'cart', 02:18:22 INFO - 'tsvg_static']}, 02:18:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:18:22 INFO - 'tsvgr_opacity', 02:18:22 INFO - 'tart', 02:18:22 INFO - 'tscrollx', 02:18:22 INFO - 'cart', 02:18:22 INFO - 'tsvg_static']}, 02:18:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:18:22 INFO - 'talos_options': ['--disable-e10s'], 02:18:22 INFO - 'tests': ['tp5o']}, 02:18:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:18:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:18:22 INFO - 'talos_options': ['--disable-e10s', 02:18:22 INFO - '--xperf_path', 02:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:22 INFO - 'tests': ['tp5n']}, 02:18:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:18:22 INFO - 'talos_options': ['--xperf_path', 02:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:18:22 INFO - 'tests': ['tp5n']}}, 02:18:22 INFO - 'talos.zip': {'path': '', 02:18:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:18:22 INFO - Running post-action listener: _resource_record_post_action 02:18:22 INFO - [mozharness: 2017-02-02 10:18:22.202353Z] Finished populate-webroot step (success) 02:18:22 INFO - [mozharness: 2017-02-02 10:18:22.202471Z] Running create-virtualenv step. 02:18:22 INFO - Running pre-action listener: _resource_record_pre_action 02:18:22 INFO - Running main action method: create_virtualenv 02:18:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:18:22 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 02:18:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:18:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:18:22 INFO - Using real prefix '/tools/python27' 02:18:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:18:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:18:25 INFO - Installing pip.................done. 02:18:25 INFO - Return code: 0 02:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:18:26 INFO - Reading from file tmpfile_stdout 02:18:26 INFO - Output received: 02:18:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:18:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:18:26 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')]} 02:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:26 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')]} 02:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:18:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:26 INFO - 'HOME': '/Users/cltbld', 02:18:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:26 INFO - 'LOGNAME': 'cltbld', 02:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:26 INFO - 'MOZ_NO_REMOTE': '1', 02:18:26 INFO - 'NO_EM_RESTART': '1', 02:18:26 INFO - 'PAGER': '/bin/cat', 02:18:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:26 INFO - 'PWD': '/builds/slave/test', 02:18:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:26 INFO - 'SHELL': '/bin/bash', 02:18:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:26 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:26 INFO - 'USER': 'cltbld', 02:18:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:26 INFO - 'XPC_FLAGS': '0x0', 02:18:26 INFO - 'XPC_SERVICE_NAME': '0', 02:18:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:26 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 02:18:26 INFO - Cleaning up... 02:18:26 INFO - Return code: 0 02:18:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:18:26 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')]} 02:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:26 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')]} 02:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:18:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:26 INFO - 'HOME': '/Users/cltbld', 02:18:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:26 INFO - 'LOGNAME': 'cltbld', 02:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:26 INFO - 'MOZ_NO_REMOTE': '1', 02:18:26 INFO - 'NO_EM_RESTART': '1', 02:18:26 INFO - 'PAGER': '/bin/cat', 02:18:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:26 INFO - 'PWD': '/builds/slave/test', 02:18:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:26 INFO - 'SHELL': '/bin/bash', 02:18:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:26 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:26 INFO - 'USER': 'cltbld', 02:18:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:26 INFO - 'XPC_FLAGS': '0x0', 02:18:26 INFO - 'XPC_SERVICE_NAME': '0', 02:18:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:27 INFO - Downloading/unpacking psutil>=3.1.1 02:18:27 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 02:18:27 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 02:18:27 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 02:18:27 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 02:18:27 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 02:18:27 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 02:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:18:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:30 INFO - Installing collected packages: psutil 02:18:30 INFO - Running setup.py install for psutil 02:18:31 INFO - building 'psutil._psutil_osx' extension 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 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 02:18:31 INFO - building 'psutil._psutil_posix' extension 02:18:31 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 02:18:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:18:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:18:31 INFO - ^ 02:18:31 INFO - 1 warning generated. 02:18:31 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 02:18:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:18:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:18:32 INFO - Successfully installed psutil 02:18:32 INFO - Cleaning up... 02:18:32 INFO - Return code: 0 02:18:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:32 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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:32 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 02:18:32 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 02:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:32 INFO - 'HOME': '/Users/cltbld', 02:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:32 INFO - 'LOGNAME': 'cltbld', 02:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:32 INFO - 'MOZ_NO_REMOTE': '1', 02:18:32 INFO - 'NO_EM_RESTART': '1', 02:18:32 INFO - 'PAGER': '/bin/cat', 02:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:32 INFO - 'PWD': '/builds/slave/test', 02:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:32 INFO - 'SHELL': '/bin/bash', 02:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:32 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:32 INFO - 'USER': 'cltbld', 02:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:32 INFO - 'XPC_FLAGS': '0x0', 02:18:32 INFO - 'XPC_SERVICE_NAME': '0', 02:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:18:35 INFO - Installing collected packages: mozsystemmonitor 02:18:35 INFO - Running setup.py install for mozsystemmonitor 02:18:36 INFO - Successfully installed mozsystemmonitor 02:18:36 INFO - Cleaning up... 02:18:36 INFO - Return code: 0 02:18:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:18:36 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')]} 02:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:36 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')]} 02:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:36 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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:36 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 02:18:36 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 02:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:36 INFO - 'HOME': '/Users/cltbld', 02:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:36 INFO - 'LOGNAME': 'cltbld', 02:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:36 INFO - 'MOZ_NO_REMOTE': '1', 02:18:36 INFO - 'NO_EM_RESTART': '1', 02:18:36 INFO - 'PAGER': '/bin/cat', 02:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:36 INFO - 'PWD': '/builds/slave/test', 02:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:36 INFO - 'SHELL': '/bin/bash', 02:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:36 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:36 INFO - 'USER': 'cltbld', 02:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:36 INFO - 'XPC_FLAGS': '0x0', 02:18:36 INFO - 'XPC_SERVICE_NAME': '0', 02:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:36 INFO - Downloading/unpacking jsonschema==2.5.1 02:18:36 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 02:18:36 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 02:18:36 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 02:18:36 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 02:18:36 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 02:18:36 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 02:18:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:18:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:18:39 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 02:18:39 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 02:18:39 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 02:18:39 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 02:18:39 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 02:18:39 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 02:18:40 INFO - Downloading functools32-3.2.3-2.tar.gz 02:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:18:40 INFO - warning: no files found matching '*.txt' 02:18:40 INFO - no previously-included directories found matching 'build' 02:18:40 INFO - no previously-included directories found matching 'dist' 02:18:40 INFO - no previously-included directories found matching '.git*' 02:18:40 INFO - Installing collected packages: jsonschema, functools32 02:18:40 INFO - Running setup.py install for functools32 02:18:40 INFO - warning: no files found matching '*.txt' 02:18:40 INFO - no previously-included directories found matching 'build' 02:18:40 INFO - no previously-included directories found matching 'dist' 02:18:40 INFO - no previously-included directories found matching '.git*' 02:18:40 INFO - Successfully installed jsonschema functools32 02:18:40 INFO - Cleaning up... 02:18:40 INFO - Return code: 0 02:18:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:41 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')]} 02:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:41 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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:41 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 02:18:41 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 02:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:41 INFO - 'HOME': '/Users/cltbld', 02:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:41 INFO - 'LOGNAME': 'cltbld', 02:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:41 INFO - 'MOZ_NO_REMOTE': '1', 02:18:41 INFO - 'NO_EM_RESTART': '1', 02:18:41 INFO - 'PAGER': '/bin/cat', 02:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:41 INFO - 'PWD': '/builds/slave/test', 02:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:41 INFO - 'SHELL': '/bin/bash', 02:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:41 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:41 INFO - 'USER': 'cltbld', 02:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:41 INFO - 'XPC_FLAGS': '0x0', 02:18:41 INFO - 'XPC_SERVICE_NAME': '0', 02:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:18:41 INFO - Cleaning up... 02:18:41 INFO - Return code: 0 02:18:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:18:41 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')]} 02:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:41 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')]} 02:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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', '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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:18: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 blobuploader==1.2.4 02:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:42 INFO - 'HOME': '/Users/cltbld', 02:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:42 INFO - 'LOGNAME': 'cltbld', 02:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:42 INFO - 'MOZ_NO_REMOTE': '1', 02:18:42 INFO - 'NO_EM_RESTART': '1', 02:18:42 INFO - 'PAGER': '/bin/cat', 02:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:42 INFO - 'PWD': '/builds/slave/test', 02:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:42 INFO - 'SHELL': '/bin/bash', 02:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:42 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:42 INFO - 'USER': 'cltbld', 02:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:42 INFO - 'XPC_FLAGS': '0x0', 02:18:42 INFO - 'XPC_SERVICE_NAME': '0', 02:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:45 INFO - Downloading blobuploader-1.2.4.tar.gz 02:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:18:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:18:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:18:46 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 02:18:46 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 02:18:46 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 02:18:46 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 02:18:46 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 02:18:46 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 02:18:46 INFO - Downloading docopt-0.6.1.tar.gz 02:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:18:46 INFO - Installing collected packages: blobuploader, requests, docopt 02:18:46 INFO - Running setup.py install for blobuploader 02:18:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:18:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:18:47 INFO - Running setup.py install for requests 02:18:47 INFO - Running setup.py install for docopt 02:18:47 INFO - Successfully installed blobuploader requests docopt 02:18:47 INFO - Cleaning up... 02:18:47 INFO - Return code: 0 02:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:47 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')]} 02:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:47 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')]} 02:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:47 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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:47 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 02:18:47 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 02:18:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:47 INFO - 'HOME': '/Users/cltbld', 02:18:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:47 INFO - 'LOGNAME': 'cltbld', 02:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:47 INFO - 'MOZ_NO_REMOTE': '1', 02:18:47 INFO - 'NO_EM_RESTART': '1', 02:18:47 INFO - 'PAGER': '/bin/cat', 02:18:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:47 INFO - 'PWD': '/builds/slave/test', 02:18:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:47 INFO - 'SHELL': '/bin/bash', 02:18:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:47 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:47 INFO - 'USER': 'cltbld', 02:18:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:47 INFO - 'XPC_FLAGS': '0x0', 02:18:47 INFO - 'XPC_SERVICE_NAME': '0', 02:18:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-6YagqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-wHVWbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Qhw298-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-BuTkpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-CoaDRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-5So7dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-7DYAZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-4pklQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:48 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-8w7V_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-cR02SG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-dG3D9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-SkIY7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-r1O12c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Qs4IzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-cLIN5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-TYUvgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:49 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-rkYpgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:18:49 INFO - Running setup.py install for manifestparser 02:18:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:18:50 INFO - Running setup.py install for mozcrash 02:18:50 INFO - Running setup.py install for mozdebug 02:18:50 INFO - Running setup.py install for mozdevice 02:18:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:18:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:18:50 INFO - Running setup.py install for mozfile 02:18:50 INFO - Running setup.py install for mozhttpd 02:18:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:18:50 INFO - Running setup.py install for mozinfo 02:18:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:18:50 INFO - Running setup.py install for mozInstall 02:18:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Running setup.py install for mozleak 02:18:51 INFO - Running setup.py install for mozlog 02:18:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Running setup.py install for moznetwork 02:18:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Running setup.py install for mozprocess 02:18:51 INFO - Running setup.py install for mozprofile 02:18:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:18:51 INFO - Running setup.py install for mozrunner 02:18:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:18:52 INFO - Running setup.py install for mozscreenshot 02:18:52 INFO - Running setup.py install for moztest 02:18:52 INFO - Running setup.py install for mozversion 02:18:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:52 INFO - Cleaning up... 02:18:52 INFO - Return code: 0 02:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:52 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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:52 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 02:18:52 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 02:18:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:52 INFO - 'HOME': '/Users/cltbld', 02:18:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:52 INFO - 'LOGNAME': 'cltbld', 02:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:52 INFO - 'MOZ_NO_REMOTE': '1', 02:18:52 INFO - 'NO_EM_RESTART': '1', 02:18:52 INFO - 'PAGER': '/bin/cat', 02:18:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:52 INFO - 'PWD': '/builds/slave/test', 02:18:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:52 INFO - 'SHELL': '/bin/bash', 02:18:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:52 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:52 INFO - 'USER': 'cltbld', 02:18:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:52 INFO - 'XPC_FLAGS': '0x0', 02:18:52 INFO - 'XPC_SERVICE_NAME': '0', 02:18:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-l5IMEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:52 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)) 02:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-yQEfIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:52 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ltFfuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-dSMYwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-5d0WZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-SmcSwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-UdMNH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-kJ1koO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-OYEA7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-VJRnXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-7YvuMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:53 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)) 02:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:53 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-rhcWsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 02:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:54 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Dy2qbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:54 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)) 02:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:54 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-tiWlVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:54 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-EAnpzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:54 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)) 02:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:54 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-GNpfbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:54 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-1DE1Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:54 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)) 02:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:54 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)) 02:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18:54 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 02:18:54 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 02:18:54 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 02:18:54 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 02:18:54 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 02:18:54 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 02:18:57 INFO - Downloading blessings-1.6.tar.gz 02:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:57 INFO - Installing collected packages: blessings 02:18:57 INFO - Running setup.py install for blessings 02:18:57 INFO - Successfully installed blessings 02:18:57 INFO - Cleaning up... 02:18:57 INFO - Return code: 0 02:18:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:57 INFO - Reading from file tmpfile_stdout 02:18:57 INFO - Current package versions: 02:18:57 INFO - blessings == 1.6 02:18:57 INFO - blobuploader == 1.2.4 02:18:57 INFO - docopt == 0.6.1 02:18:57 INFO - functools32 == 3.2.3-2 02:18:57 INFO - jsonschema == 2.5.1 02:18:57 INFO - manifestparser == 1.1 02:18:57 INFO - mozInstall == 1.12 02:18:57 INFO - mozcrash == 1.0 02:18:57 INFO - mozdebug == 0.1 02:18:57 INFO - mozdevice == 0.49 02:18:57 INFO - mozfile == 1.2 02:18:57 INFO - mozhttpd == 0.7 02:18:57 INFO - mozinfo == 0.9 02:18:57 INFO - mozleak == 0.1 02:18:57 INFO - mozlog == 3.4 02:18:57 INFO - moznetwork == 0.27 02:18:57 INFO - mozprocess == 0.24 02:18:57 INFO - mozprofile == 0.28 02:18:57 INFO - mozrunner == 6.13 02:18:57 INFO - mozscreenshot == 0.1 02:18:57 INFO - mozsystemmonitor == 0.3 02:18:57 INFO - moztest == 0.8 02:18:57 INFO - mozversion == 1.4 02:18:57 INFO - psutil == 3.1.1 02:18:57 INFO - requests == 1.2.3 02:18:57 INFO - wsgiref == 0.1.2 02:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:57 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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:57 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 02:18:57 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 02:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:57 INFO - 'HOME': '/Users/cltbld', 02:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:57 INFO - 'LOGNAME': 'cltbld', 02:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:57 INFO - 'MOZ_NO_REMOTE': '1', 02:18:57 INFO - 'NO_EM_RESTART': '1', 02:18:57 INFO - 'PAGER': '/bin/cat', 02:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:57 INFO - 'PWD': '/builds/slave/test', 02:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:57 INFO - 'SHELL': '/bin/bash', 02:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:57 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:57 INFO - 'USER': 'cltbld', 02:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:57 INFO - 'XPC_FLAGS': '0x0', 02:18:57 INFO - 'XPC_SERVICE_NAME': '0', 02:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 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)) 02:18:58 INFO - Cleaning up... 02:18:58 INFO - Return code: 0 02:18:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:58 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 0x10f97fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f982768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf78d24780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, '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.45BPINLLIu/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.lDP92XqJWz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 02:18:58 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 02:18:58 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 02:18:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:18:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:18:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:18:58 INFO - 'HOME': '/Users/cltbld', 02:18:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:18:58 INFO - 'LOGNAME': 'cltbld', 02:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:58 INFO - 'MOZ_NO_REMOTE': '1', 02:18:58 INFO - 'NO_EM_RESTART': '1', 02:18:58 INFO - 'PAGER': '/bin/cat', 02:18:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:58 INFO - 'PWD': '/builds/slave/test', 02:18:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:18:58 INFO - 'SHELL': '/bin/bash', 02:18:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:18:58 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:18:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:18:58 INFO - 'USER': 'cltbld', 02:18:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:18:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:58 INFO - 'XPC_FLAGS': '0x0', 02:18:58 INFO - 'XPC_SERVICE_NAME': '0', 02:18:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:18:58 INFO - Cleaning up... 02:18:58 INFO - Return code: 0 02:18:58 INFO - Running post-action listener: _resource_record_post_action 02:18:58 INFO - Running post-action listener: _start_resource_monitoring 02:18:58 INFO - Starting resource monitoring. 02:18:58 INFO - [mozharness: 2017-02-02 10:18:58.508351Z] Finished create-virtualenv step (success) 02:18:58 INFO - [mozharness: 2017-02-02 10:18:58.509290Z] Running install step. 02:18:58 INFO - Running pre-action listener: _resource_record_pre_action 02:18:58 INFO - Running main action method: install 02:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:58 INFO - Reading from file tmpfile_stdout 02:18:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:58 INFO - Reading from file tmpfile_stdout 02:18:58 INFO - Output received: 02:18:58 INFO - Usage: mozinstall [options] installer 02:18:58 INFO - Options: 02:18:58 INFO - -h, --help show this help message and exit 02:18:58 INFO - -d DEST, --destination=DEST 02:18:58 INFO - Directory to install application into. [default: 02:18:58 INFO - "/builds/slave/test"] 02:18:58 INFO - --app=APP Application being installed. [default: firefox] 02:18:58 INFO - mkdir: /builds/slave/test/build/application 02:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:19:19 INFO - Reading from file tmpfile_stdout 02:19:19 INFO - Output received: 02:19:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:19:19 INFO - Running post-action listener: _resource_record_post_action 02:19:19 INFO - [mozharness: 2017-02-02 10:19:19.174932Z] Finished install step (success) 02:19:19 INFO - [mozharness: 2017-02-02 10:19:19.175119Z] Running run-tests step. 02:19:19 INFO - Running pre-action listener: _resource_record_pre_action 02:19:19 INFO - Running main action method: run_tests 02:19:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:19:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:19:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:19:19 INFO - 2017-02-02 02:19:19.189 screenresolution[1626:7596] starting screenresolution argv=screenresolution get 02:19:19 INFO - 2017-02-02 02:19:19.192 screenresolution[1626:7596] Display 0: 1600x1200x32@60 02:19:19 INFO - 2017-02-02 02:19:19.198 screenresolution[1627:7598] starting screenresolution argv=screenresolution list 02:19:19 INFO - Available Modes on Display 0 02:19:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:19:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:19:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:19:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:19:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:19:19 INFO - Intel Iris: 02:19:19 INFO - Chipset Model: Intel Iris 02:19:19 INFO - Type: GPU 02:19:19 INFO - Bus: Built-In 02:19:19 INFO - VRAM (Dynamic, Max): 1536 MB 02:19:19 INFO - Vendor: Intel (0x8086) 02:19:19 INFO - Device ID: 0x0a2e 02:19:19 INFO - Revision ID: 0x0009 02:19:19 INFO - Displays: 02:19:19 INFO - Display: 02:19:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:19:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:19:19 INFO - Display Serial Number: 1600x1200 60 02:19:19 INFO - Main Display: Yes 02:19:19 INFO - Mirror: Off 02:19:19 INFO - Online: Yes 02:19:19 INFO - Rotation: Supported 02:19:19 INFO - Return code: 0 02:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:19 INFO - Python 2.7.3 02:19:19 INFO - Return code: 0 02:19:19 INFO - grabbing minidump binary from tooltool 02:19:19 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')]} 02:19:19 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 0x10f75dd30>, '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 0x10f684db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f752be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:19 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 02:19:19 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 02:19:19 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 02:19:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:19 INFO - Return code: 0 02:19:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:19:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:19:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:19 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/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 02:19:19 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/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0211 --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 02:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.45BPINLLIu/Render', 02:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:19:19 INFO - 'HOME': '/Users/cltbld', 02:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:19:19 INFO - 'LOGNAME': 'cltbld', 02:19:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:19 INFO - 'MOZ_NO_REMOTE': '1', 02:19:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:19 INFO - 'NO_EM_RESTART': '1', 02:19:19 INFO - 'PAGER': '/bin/cat', 02:19:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:19 INFO - 'PWD': '/builds/slave/test', 02:19:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:19:19 INFO - 'SHELL': '/bin/bash', 02:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lDP92XqJWz/Listeners', 02:19:19 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 02:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:19:19 INFO - 'USER': 'cltbld', 02:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:19 INFO - 'XPC_FLAGS': '0x0', 02:19:19 INFO - 'XPC_SERVICE_NAME': '0', 02:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:19:19 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/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 02:19:19 INFO - mozversion application_buildid: 20170202004013 02:19:19 INFO - mozversion application_changeset: d06f2bf30b22a04b03e2046d5c148adedd6777c1 02:19:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:19:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:19 INFO - mozversion application_name: Firefox 02:19:19 INFO - mozversion application_remotingname: firefox-dev 02:19:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:19:19 INFO - mozversion application_vendor: Mozilla 02:19:19 INFO - mozversion application_version: 53.0a2 02:19:19 INFO - mozversion platform_buildid: 20170202004013 02:19:19 INFO - mozversion platform_changeset: d06f2bf30b22a04b03e2046d5c148adedd6777c1 02:19:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:19:19 INFO - mozversion platform_version: 53.0a2 02:19:19 INFO - using testdate: 1486030759 02:19:19 INFO - actual date: 1486030759 02:19:19 INFO - starting webserver on 'localhost:49243' 02:19:19 INFO - SUITE-START | Running 2 tests 02:19:19 INFO - TEST-START | dromaeo_css 02:19:19 INFO - operating with platform_type : mac_ 02:19:19 INFO - Initialising browser for dromaeo_css test... 02:19:19 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpe9KrZ5/profile http://localhost:49243/getInfo.html) 02:19:22 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 02:19:22 INFO - PROCESS | 1637 | colorDepth:24 02:19:22 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 02:19:22 INFO - PROCESS | 1637 | __metrics 02:19:22 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:19:22 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:19:23 INFO - TEST-INFO | 1637: exit 0 02:19:23 INFO - Browser initialized. 02:19:23 INFO - Running cycle 1/1 for dromaeo_css test... 02:19:23 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpe9KrZ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:35 INFO - PROCESS | 1640 | RSS: Main: 212946944 02:19:35 INFO - PROCESS | 1640 | 02:22:38 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 02:22:40 INFO - PROCESS | 1640 | RSS: Main: 365010944 02:22:40 INFO - PROCESS | 1640 | 02:24:24 INFO - PROCESS | 1640 | ************************* 02:24:24 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 02:24:24 INFO - PROCESS | 1640 | 02:24:24 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:24:24 INFO - PROCESS | 1640 | Full stack: 02:24:24 INFO - PROCESS | 1640 | ************************* 02:25:43 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 02:25:43 INFO - PROCESS | 1640 | RSS: Main: 352096256 02:25:43 INFO - PROCESS | 1640 | 02:28:46 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 02:28:46 INFO - PROCESS | 1640 | RSS: Main: 319975424 02:28:46 INFO - PROCESS | 1640 | 02:31:49 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 02:31:49 INFO - PROCESS | 1640 | RSS: Main: 325836800 02:31:49 INFO - PROCESS | 1640 | 02:34:53 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 02:34:53 INFO - PROCESS | 1640 | RSS: Main: 315658240 02:34:53 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 02:37:57 INFO - PROCESS | 1640 | RSS: Main: 394665984 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | __start_tp_report 02:37:57 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 02:37:57 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 02:37:57 INFO - PROCESS | 1640 | |i|pagename|runs| 02:37:57 INFO - PROCESS | 1640 | |0;dojo.html;3345.297487527619;3352.591911397213;3353.664633536646;3359.2273777031296;3415.453527435611;5697.544196464283;5746.39662835402;5812.564057695668;5829.621074630146;5849.327327357355;5677.517411020058;5690.829275121742;5717.828465146042;5735.827925162242;5768.942310576893;5200.791968321272;5204.661696989683;5271.815486457975;5284.2866213061125;5328.520433161015;5173.611979101583;5181.870453238662;5201.297824793661;5317.654352467097;5319.760610772505;5201.219817027439;5258.789648414059;5278.577713782888;5280.973595132019;5326.2543243945875;5303.337082864642;5328.3605967284175;5339.679619222859;5342.706151161704;5366.597505187126;5047.823326183603;5148.279240906276;5251.212318152269;5265.315508983807;5290.735463226823;5633.985882541141;5710.914336284959;5711.742971566248;5715.199872017921;5813.79651712188;6213.937860621426;6221.253449586034;6255.687215639246;6257.280412752546;6273.843153921189;5236.371635403738;6253.749850005995;6263.342349053375;6283.088952101965;6294.0558916162945;5706.857328566819;5715.457031582035;5760.107183386582;5810;5813.854653633608;6191.00943848982;6219.129321894939;6236.563440559117;6244.625322480575;6261.123442718023;6152.169457123231;6228.22147231596;6239.532035097295;6239.625622462667;6252.781152659635;6221.844453888599;6268.968655156695;6272.874542509125;6275.121482992385;6276.529260305495;5035.269885866529;6131.69422353494;6145.156453064063;6278.121063051177;6294.527910406738;6174.104754810527;6211.565190436717;6237.1891654084675;6268.62388256697;6273.780417685451;4966.1309270877455;5001.824936127218;5004.9499505005215;5015.097282489187;5033.7734801934;4458.417261872054;4463.553644635575;4466.2407390743;4477.126960242721;4491.685582009228;5723.370429252779;5791.82624521265;5801.767929282782;5875.706214689249;5938.524918006636;6220.657863817533;6231.875362492816;6237.068577768532;6244.2819075806865;6256.499480041586;5967.8209653710455;5977.462028417463;5987.221661184019;5991.430814072656;6012.338642749294;5372.140457526777;5420.945790542044;5433.157860531624;5447.155690867922;5505.064139096363;6267.6866156691985;6270.31026587075;6304;6377.330380310001;6390;5303.628745987744;6204.790065937099;6230.034344676583;6236.563440559117;6240.53196010292;6172.969135154295;6297.1813664223355;6328.398802113792;6367.968160159169;6374.617522948638;6142.959235178615;6165.136880836597;6173.228346456693;6210.5652604317265;6272.905906411316;6181.752729890754;6217.222847144107;6224.906626400698;6237.095621135;6237.407446292595;6143.18154655188;6192.690365481618;6195.411435913581;6196.597221180609;6205.348438414082;6013.458788709037;6074.362191969956;6128.571000029955;6132.6920582337325;6135.722664536972;6100.664463454553;6102.0541816018585;6106.480949119375;6108.083787431743;6118.418750218722;5923.911141332969;5992.310884248367;5993.101034844808;6183.96908015457;6201.410865967726;5722.198892155185;5850.64896106235;5886;5914.733836977261;5930.318013428511 02:37:57 INFO - PROCESS | 1640 | |1;ext.html;449.243025502029;481.9084772989182;493.2330226497797;495.9305697202392;515.7215103843924;26049.869750651244;37839.81080094603;39628.20743585127;39694.603053969455;39741;41477.79261103698;41939.37090943638;41948;41962.16075678492;42019.94950126248;8331.375146863978;9238.307126965488;9446.574904129331;9448.622055117787;9462.053794620551;8396.83206335873;8572.22849943505;8578.099299573549;8583.18459746323;11202.66392008241;11198.552057917674;11457.197996140274;11466.426678666076;11481.311121332747;11483.65549033526;11399.601013964513;11469.483873225683;11472.827907581393;11473.311601303865;11476.311421314747;8351.24838764508;8571.271441927443;11089.667309980714;11288.548458061668;11391.145664075228;33372.99881003574;39274.41088383648;40460.79769601133;40481.79759101215;40619.59380406188;3995.200959808021;4029.9395509067094;4030.1738143680477;4042.514898212204;4278.358246263055;28168.29579260535;28954;29155.562666560018;29845.850770746223;30985.69014309873;3206.1663967368654;3212.951805722916;3334;3370.0900756795772;3394.6944774970125;442390.7880460577;446861;450803.4919650827;451097;456380;58529.414705852396;58838.705806470694;58854;58857;58905.70547147237;61539.6923015391;61753.69123154446;61785.69107154435;61822;61930.071048934304;16017.279222434785;16125.032498050154;16414.26135823891;16720;16772.077535735407;12777.297248651414;12867.742645147231;12869.22784632925;12877.613671589866;12891.419886105148;13978.930105349407;14365.712685746226;14384.35270412834;15749.527514174593;15755.921220393824;6272.40412160844;6990.231074581792;7256.2743725627015;7306.123265208209;7409.665955224087;894.789724414762;896.7489103051156;901.8376692195468;904.9502277374676;928.5264515097214;29642.40715185684;29663.110106696833;29694.851525742666;30134.849325753232;30196.54705179424;923.787528868364;1082.4533610526635;1111.916606254518;1131.8585176852894;1194.832723418722;15358.232088395536;15425.305861236271;15477.303521341566;15650.37398504047;15767.369305227892;608753;611389;612060;612228.9388553118;613369;57873.42126578765;57877.42122578804;57913.4208657908;57985.420145798846;58022.129668055015;1355.8508564058143;1446.320229492158;1458.1688437590471;1481.9036762610397;1486.9776953345709;26371.60442593324;29387.706122938496;29409.411811764072;29466.705332946396;30034.84982575073;45257;49312;49367.753161233966;49401;49524.25713614371;496169;499827.50086249335;500117;500158;503274;38230.42654360131;39155.60844391634;39528.604713953646;39554;39618.60381396265;44833.93915251731;44951.550484494735;45516;45840.64513871177;46508;36974.63025369712;37501;37653.62346376501;38685;38723.22553548857;37517.81241093777;37809.810950945066;38086.23827523489;38416;39217.411738824514;36649.90050298495;36795.08012299607;37483.43774843325;37527.68653097129;37802;25790.355241119123;29515.40969180647;31776.95034758648;33833.66166338305;34427;20845.17680733084;22777.772222277566;23471.64792528079;23552.764472355742;25212.873935630203 02:37:57 INFO - PROCESS | 1640 | |2;jquery.html;369.27437585145185;386.80273060739023;387.86037026670374;398.1638559026045;416.9103642716817;15362.385504579817;15381.769273460894;18651.906740466296;20942.685859712117;21187.36437906865;19761.901190494063;20563;21540.784592154112;22102.557948841015;22368.55262894741;5870.501007414375;5966.761329546813;5970.164177015221;6000.33996260411;6138;4647.465541462741;4922.680025798311;6002.249718785152;6013.338532761392;6013.54898382623;4131.277026520362;4383.3863259143745;4420.580044895746;5986;6627.933720662804;6659.267480577157;6681.164854393201;6684.598924064571;6685.298043705414;6696.263411024784;7361.263873612649;7678.500897441704;7742.729004484816;7748.961255193744;7879.054513458422;28612.284692882637;30211.546826797614;30211.942582009742;30323.848380758176;30500.77996880122;2970.970290297091;3008.8796448142048;3047.9847600761855;3049.085274417688;3054.8930787422555;14816.3332650031;16644.001359918442;17152;17178;17484.650306993917;1665.4753752567901;1943.2227109156308;2000.6298834715624;2018.4550171453625;2021.0198053943825;155576;162066.1896690509;165400;165993.17003415027;166533;23428.765712343;23588.461730740182;23959.880200598884;24092.7590724094;24129.879350603136;41921;42060.789696051324;42715.009949303254;42954;43192.56807431948;8419.579021048923;8630.180132887366;8904.910950890408;8951.239144672776;9013.77465563353;8706.216440520384;8719.084496127942;8746.300295976307;8889.511076890833;8899.822003559893;4776.808927642925;4836.443808961944;4850.902981940412;4918.55732984026;4921.409430868247;2001.5396458814555;2030.8273796727149;2037.4906273431643;2045.693146028078;2047.1606641277303;1015.4313584392763;1058.332505217129;1061.7823346214007;1075.7471994081384;1091.49245600796;21660.56678866414;21885.562288754136;22097.226597069024;22240.666390004164;22267;1076.9192310576582;1078.1267173589417;1090.7491277006334;1093.4150229627112;1119.44027986007;11261.943690281496;11515.30908145514;11557.47991340375;11651.825222621497;11665.708357291136;673801;679549;691869;734832;739399;153635;154596.10860810892;154683;156617;160765.19617402073;1048.114343379843;1068.6740544134113;1091.3779145886926;1096.4079397125463;1097.6706987903597;18740.812591873906;19108.33120840764;19276.42170734824;19374.321898733477;19697.606047878675;50656.98686026185;53453;59783.402165977786;60547.39452605417;61101;80001;81394;82103;82752.58623706843;82869.75695364454;8284.502929823988;8368.20502052304;8443.493390396596;8516.977962644274;8677.26243269304;10943.890561094606;12725.872741272839;13158;13564.72870542564;13572.389242483914;11149.665510034712;11274.549018039186;11279.436028198394;11379.601713939972;11705.531778728755;10100.595976161165;10858.565657373932;11104.056155226895;11294.209405341548;11721.472533736172;9360.625574977197;9966.900330996597;11418.771624567296;11641.243319184226;11871.76256474883;7398.149212840377;7521.05986751656;7663.770086897402;7844.137144914169;8596.957015214884;10045.799084018132;11430.485628146587;11472.65582032507;11627.767444651228;11638.767224655629 02:37:57 INFO - PROCESS | 1640 | |3;mootools.html;1336.746018256532;1417.0859795431948;1468.5520916120581;1470.5000299898034;1482.4663121276342;7258.745943891965;7974.561399123046;8364.539950302738;8450.408471407003;8461.703840365588;7000.774864398735;7159.928400715991;7390.076240469942;8007.959960200191;8255.339572834175;2287.2337766848127;2346.1319311854554;2349.0721165139757;2356.670066190735;2359.8112151027876;2336.778006089419;2369.9052037918464;2383.368407372048;2384.070212617081;2387.403149212697;2052.5381789097482;2135.487483004076;2262.1290803040865;2314.4792421705065;2327.359976006595;2335.9065637374483;2351.1183306260154;2352.2472808701223;2352.8117750579913;2361.940951476227;2309.099451214011;2352.447174913894;2368.3842201027683;2386.997461066356;2390.521895620883;8395.454295470774;8431.578421078983;8441.746747597583;8453.915460845436;8461.746147615582;5041.571466425358;5215.921761173586;5216.608754343401;5219.660722053054;5225.137852254374;3112.206387371206;3335.4329763939945;3375.206826395795;3382.408078586262;3405.1487128217946;1114.7213196700825;1116.7598966222301;1179.7994340962057;1181.4978634080567;1186.685528334992;10992;10999.450027498673;11010.614628488045;11039.668809935714;11066.225364224507;4549.658775591778;4665.440147182292;4730.834420795256;4752.097101550694;4760.500147484534;9703.272254580934;9712.22302215821;9717.271204659537;9721.659741909;9742.269329800294;5292.655977361459;5296.788128474895;5300.1254792958725;5304.628675992721;5304.734763261821;4627.745473998963;4690.484046754923;4759.6668233223345;4793.209120495079;4810.927836082462;3335.69978701918;3892.3772196449;3902.570717221103;3917.9608203918165;3955.4857868476915;1262.450833887262;1262.50762202741;1264.9810252846214;1279.4754150798128;1282.6921538830613;782.4757412533617;802.9759107226793;902.7788191893028;921.5254144115786;923.3398120343986;5583.246261754693;5588.329400471969;5615.803446879339;5862.618929769551;5892.941070589325;956.4787190980932;997.9900200998043;999.3354419311077;1001.1040119093516;1034.0796690945065;3683.3001729671278;3737.8691745788765;3740.6446387593137;3853.537575490903;3858.9228215435533;9805.509724513746;9929.553170107363;10009.249306302056;10123.240756943258;10165.390076595428;10064;10066.295359324777;10066.59733610662;10076.395416275047;10087.798244035079;7423.369013633794;7757.961210194026;7791.220877912164;7899.921000790034;7917.920820791718;5714.3999880012;5730.971345143247;5889.116632505158;5929.584929054925;5937.050071988461;8683;8966.282697384064;9033.819323613623;9211.078892110736;9223.354365194373;7293.781186564412;9251.629934802533;9300.441973481613;9405.85891211646;9406.670766523139;7151.642417879189;7300.488965772345;7302.34278914879;7310.561366318038;7328.963355183403;7613.467057305936;7749.496282741604;7835.059792824897;7841.255080767318;7873.133955265031;7026.508144429841;7045.295470452914;7116.074910261633;7126.216116227107;7233.746818861315;6246.312905580474;6817.897731533932;6964.582125072512;7023.578585284899;7056.964715176391;6228.34602366745;6367.745290188341;6377.2984971654005;6420.55056146084;6459.612423254432;4878.975605121952;4926.679765815211;5003.374578177728;5093.261477085876;5181.948180518147;4987.825426110068;5039.21892106724;5082.491750824888;5151.562117220078;5253.422123566481 02:37:57 INFO - PROCESS | 1640 | |4;prototype.html;308.84338153614715;351.49209392427946;360.5079067073444;367.5369035015879;371.5207382476605;4714.76426178691;5096.847094587159;5375.569954403648;5396.973015134919;5446.945530544694;4433.534478879719;4433.733975961444;4609.308603709445;4707.070101258485;5231.372235331765;4022.798860057;4196.538380778112;4243.978780106095;4255;4263.786810659454;3356.7314614830875;3957.1887763008513;4217.746935183899;4235.2800023996;4239.173361194568;3718.3678774608384;4077.510698716158;4194.496660400741;4222;4225.302825033866;3980.6218409251073;4151.086760912594;4197.91604167918;4210.305299625574;4230.555791641895;3130.812151270931;3322.7674062815613;3683.852645894161;3710.257948410329;3722.497462842509;4817.879553011167;5021.57316628087;5066.923996140061;5089.745512724386;5214.270002199695;3914.549826769901;4016.7790771507557;4670.649701272384;4902.460729319772;4917.041176970492;5085.770535709814;5646.548276137899;5656.462636049569;5668.659880407147;5719.227904232958;3462.6191118976894;3577.069961809948;4105.44576482174;4114.107510545153;4143.70994030418;4845.806167753321;5273.541884149887;5984.640921544721;5989.940100599026;6042.8187154385;4177.770222637723;4210.789460526961;4220.5146408163455;4230.302000169938;4237.6821738369745;3752.2870654575545;4261.2542805009;4263.914721705549;4284.935725964113;4307.956920430818;4058.370952502367;4451.77741112943;4630.768461576908;4829.66192366531;4878.390201224847;5572.9905850840905;5673.943260567424;5690.573207009491;5724.341700704389;5745.701719312225;1089.6894385100368;1282.9550965716155;1291.031726205346;1300.3498250874563;1394.9232792196526;907.7276816954887;912.9726108216764;945.9195968342768;954.4464210757744;958.9520523973773;4281.507626622916;4829.782659780319;4995.450500444948;5017.54842064216;5019.071471777733;4627.791749371287;4770.356001939763;5085.949140508622;5099.566536844335;5437.45625437461;4279.251131052053;4319.892002699895;4498.887527811831;4985.601151907838;5045.68812108847;2594.364380726734;2637.6834779826545;2861.957070643942;2886.4371447567523;2899.7680185585104;5350.973245133828;5643.294588176478;5654.293213348332;5713.285839270091;5725.570582206351;4850.5149485051215;4926.989967056745;5396.676199427969;5646.317998950466;5754.942450575524;4927.28554359623;5142.6400151989;5564.636664017261;5701.543876489871;5759.968022384348;4269.957300426956;4622.976885115553;4946.307516947558;5250.291210686509;5553.222548843246;4289.270823959871;5000.374953130859;5032.773525191302;5358.678479291255;5406.4591591396265;5067.263677614194;5117.0342984187555;5335.879465312172;5490.368607610176;5661.339170589817;3676.04078716625;3912.158885839558;3918.8040597969416;3976.681865450699;3992.940105898356;5828.53371730269;5877.000909845422;5885.498663068093;5924.170616113834;5933.465988061095;4813.711177329372;5675.091985282335;5718.885622287614;5742.310922689304;5762.740676669476;4932.679375840702;5443.673379597237;5634.4365563443325;5657.981563318642;5758.568107391879;5018.322526459027;5291.312129423304;5352.598555108305;5377.784888604412;5394.271773310553;5367.624266301477;5503.944960550343;5628.763461009854;5643.88712225745;5822.737976791139;5574.665520068809;5588.233824257019;5592.692401917933;5599.776008959596;5661.57538184646 02:37:57 INFO - PROCESS | 1640 | |5;yui.html;718.414492188866;768;819.3672223351965;829.6142293833366;840.10109183174;15175.696486070286;15636.765448518252;15659;15709.214539273033;15787.605309867246;13449.865501344984;14374.568762937128;14467;14505.274736263198;14506.927465362685;679.6533767778419;702.7399862051049;707.2715103443461;836.69042454292;845.1295165979036;850.4897061762955;854.9230569248766;870.3994243971671;870.9259712924409;871.3464901324007;910.9772255693628;911.3301723233418;912.1289168843772;913.3834661603424;914.3919293669735;716.3910675925474;739.2755100001974;911.5214512380986;911.9635214591408;912.1471424218344;660.8810414125455;674.3997841920694;680.2823021712092;682.0008687273119;682.4335801284922;15010.62473438162;15183;15197.848021519754;15213.61965950849;15221.923890380478;13829.861701383059;13830.654233644138;13838.584842454742;13856.445742170301;14038.157710537298;12217.877821221762;12315.4458049388;12407.131500794949;12753.489860405572;13274.46902123914;4286.292761694317;4347.847825326098;4473.552644735533;4611.746353950532;4620.330052142421;94325.58511622332;101332.49333753358;101579.4763078547;102503.48748256285;102716.48641756819;9955.950220248853;10618.77884043345;10836.403997780199;11010.174236932262;11254.662360129045;21338.893305533373;22005.559888802134;22126.672399656072;22131.889340553516;22186.778132218795;7385.741499047507;7393.852122957618;7780.844383112306;7829.882551761728;7843.215678432225;4120.958790412117;4267.701260911768;4349.499807522112;4388.824447022147;4390.034192477649;3316.9170770730443;3412.1981334386896;3435.0210190095704;3440.3291358185415;3445.2937147884622;618.0821480102045;628.6919409489317;651.4755621724463;659.7756762700609;661.9040239165294;547.5209191957038;554.4815597416429;567.8722287485283;570.6005795942857;577.719805894141;8205.753827385188;8545.529995850287;10305.74235644115;10345.689629311133;10353.689389318333;571.2117278156118;600.9639421634716;603.4116736182187;608.1698481572621;714.8570285942728;4774.188387974053;4925.926111108336;4931.926021109686;4944.406671199479;4971.37857767779;81454.59272703598;87627.56186219155;97023;97589.51205243928;97989;75381.62309188419;79920.60039699764;81272.59363703143;83450.90667293347;87329;64358.356416436174;77556.44887102339;78676;79416;79434.01414964673;9824.115829575087;9829;9846.704598862045;9859.063388978035;9874.259430542594;36779.81610091932;43319.9170020752;45161.38708903346;46214.76892615516;48551.75724121357;55541;63853.3614663866;63887.68056159689;65432.34567654262;66418;12047.75904481923;12532;12578.371081446074;12697.98416126726;12890.67773305675;13814.447422103405;14225;14349.713005739617;14707.852921470649;14852.554423367315;10818.67543973682;13118;13284.800727988895;13585.728285434434;13900.813403540127;11227.494762735532;12629.621111366674;13404.597862064154;13466;13475.46098156102;12776.169548979287;13525.985551083511;13566.660833479242;13744.762971332628;13757.656058598615;10862.456877156268;11301.547938082385;11324.263922844988;11748.941255293668;11997.460114294703;10176.185905127424;10541.631042913461;10816.891831081588;10854.837177442187;10885.129189664965 02:37:57 INFO - PROCESS | 1640 | __end_tp_report 02:37:57 INFO - PROCESS | 1640 | __start_cc_report 02:37:57 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1609 02:37:57 INFO - PROCESS | 1640 | __end_cc_report 02:37:57 INFO - PROCESS | 1640 | __startTimestamp1486031877618__endTimestamp 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | ------- Summary: start ------- 02:37:57 INFO - PROCESS | 1640 | Number of tests: 6 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5765.08 Median:5991.43 stddev:632.49 (10.6%) stddev-sans-first:605.27 02:37:57 INFO - PROCESS | 1640 | Values: 3345.3 3352.6 3353.7 3359.2 3415.5 5697.5 5746.4 5812.6 5829.6 5849.3 5677.5 5690.8 5717.8 5735.8 5768.9 5200.8 5204.7 5271.8 5284.3 5328.5 5173.6 5181.9 5201.3 5317.7 5319.8 5201.2 5258.8 5278.6 5281.0 5326.3 5303.3 5328.4 5339.7 5342.7 5366.6 5047.8 5148.3 5251.2 5265.3 5290.7 5634.0 5710.9 5711.7 5715.2 5813.8 6213.9 6221.3 6255.7 6257.3 6273.8 5236.4 6253.7 6263.3 6283.1 6294.1 5706.9 5715.5 5760.1 5810.0 5813.9 6191.0 6219.1 6236.6 6244.6 6261.1 6152.2 6228.2 6239.5 6239.6 6252.8 6221.8 6269.0 6272.9 6275.1 6276.5 5035.3 6131.7 6145.2 6278.1 6294.5 6174.1 6211.6 6237.2 6268.6 6273.8 4966.1 5001.8 5004.9 5015.1 5033.8 4458.4 4463.6 4466.2 4477.1 4491.7 5723.4 5791.8 5801.8 5875.7 5938.5 6220.7 6231.9 6237.1 6244.3 6256.5 5967.8 5977.5 5987.2 5991.4 6012.3 5372.1 5420.9 5433.2 5447.2 5505.1 6267.7 6270.3 6304.0 6377.3 6390.0 5303.6 6204.8 6230.0 6236.6 6240.5 6173.0 6297.2 6328.4 6368.0 6374.6 6143.0 6165.1 6173.2 6210.6 6272.9 6181.8 6217.2 6224.9 6237.1 6237.4 6143.2 6192.7 6195.4 6196.6 6205.3 6013.5 6074.4 6128.6 6132.7 6135.7 6100.7 6102.1 6106.5 6108.1 6118.4 5923.9 5992.3 5993.1 6184.0 6201.4 5722.2 5850.6 5886.0 5914.7 5930.3 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:65977.64 Median:38939.42 stddev:139876.19 (359.2%) stddev-sans-first:140182.06 02:37:57 INFO - PROCESS | 1640 | Values: 449.2 481.9 493.2 495.9 515.7 26049.9 37839.8 39628.2 39694.6 39741.0 41477.8 41939.4 41948.0 41962.2 42019.9 8331.4 9238.3 9446.6 9448.6 9462.1 8396.8 8572.2 8578.1 8583.2 11202.7 11198.6 11457.2 11466.4 11481.3 11483.7 11399.6 11469.5 11472.8 11473.3 11476.3 8351.2 8571.3 11089.7 11288.5 11391.1 33373.0 39274.4 40460.8 40481.8 40619.6 3995.2 4029.9 4030.2 4042.5 4278.4 28168.3 28954.0 29155.6 29845.9 30985.7 3206.2 3213.0 3334.0 3370.1 3394.7 442390.8 446861.0 450803.5 451097.0 456380.0 58529.4 58838.7 58854.0 58857.0 58905.7 61539.7 61753.7 61785.7 61822.0 61930.1 16017.3 16125.0 16414.3 16720.0 16772.1 12777.3 12867.7 12869.2 12877.6 12891.4 13978.9 14365.7 14384.4 15749.5 15755.9 6272.4 6990.2 7256.3 7306.1 7409.7 894.8 896.7 901.8 905.0 928.5 29642.4 29663.1 29694.9 30134.8 30196.5 923.8 1082.5 1111.9 1131.9 1194.8 15358.2 15425.3 15477.3 15650.4 15767.4 608753.0 611389.0 612060.0 612228.9 613369.0 57873.4 57877.4 57913.4 57985.4 58022.1 1355.9 1446.3 1458.2 1481.9 1487.0 26371.6 29387.7 29409.4 29466.7 30034.8 45257.0 49312.0 49367.8 49401.0 49524.3 496169.0 499827.5 500117.0 500158.0 503274.0 38230.4 39155.6 39528.6 39554.0 39618.6 44833.9 44951.6 45516.0 45840.6 46508.0 36974.6 37501.0 37653.6 38685.0 38723.2 37517.8 37809.8 38086.2 38416.0 39217.4 36649.9 36795.1 37483.4 37527.7 37802.0 25790.4 29515.4 31777.0 33833.7 34427.0 20845.2 22777.8 23471.6 23552.8 25212.9 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:41804.46 Median:24026.32 stddev:118275.51 (492.3%) stddev-sans-first:118566.38 02:37:57 INFO - PROCESS | 1640 | Values: 369.3 386.8 387.9 398.2 416.9 15362.4 15381.8 18651.9 20942.7 21187.4 19761.9 20563.0 21540.8 22102.6 22368.6 5870.5 5966.8 5970.2 6000.3 6138.0 4647.5 4922.7 6002.2 6013.3 6013.5 4131.3 4383.4 4420.6 5986.0 6627.9 6659.3 6681.2 6684.6 6685.3 6696.3 7361.3 7678.5 7742.7 7749.0 7879.1 28612.3 30211.5 30211.9 30323.8 30500.8 2971.0 3008.9 3048.0 3049.1 3054.9 14816.3 16644.0 17152.0 17178.0 17484.7 1665.5 1943.2 2000.6 2018.5 2021.0 155576.0 162066.2 165400.0 165993.2 166533.0 23428.8 23588.5 23959.9 24092.8 24129.9 41921.0 42060.8 42715.0 42954.0 43192.6 8419.6 8630.2 8904.9 8951.2 9013.8 8706.2 8719.1 8746.3 8889.5 8899.8 4776.8 4836.4 4850.9 4918.6 4921.4 2001.5 2030.8 2037.5 2045.7 2047.2 1015.4 1058.3 1061.8 1075.7 1091.5 21660.6 21885.6 22097.2 22240.7 22267.0 1076.9 1078.1 1090.7 1093.4 1119.4 11261.9 11515.3 11557.5 11651.8 11665.7 673801.0 679549.0 691869.0 734832.0 739399.0 153635.0 154596.1 154683.0 156617.0 160765.2 1048.1 1068.7 1091.4 1096.4 1097.7 18740.8 19108.3 19276.4 19374.3 19697.6 50657.0 53453.0 59783.4 60547.4 61101.0 80001.0 81394.0 82103.0 82752.6 82869.8 8284.5 8368.2 8443.5 8517.0 8677.3 10943.9 12725.9 13158.0 13564.7 13572.4 11149.7 11274.5 11279.4 11379.6 11705.5 10100.6 10858.6 11104.1 11294.2 11721.5 9360.6 9966.9 11418.8 11641.2 11871.8 7398.1 7521.1 7663.8 7844.1 8597.0 10045.8 11430.5 11472.7 11627.8 11638.8 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5440.13 Median:5216.27 stddev:2948.02 (56.5%) stddev-sans-first:2940.16 02:37:57 INFO - PROCESS | 1640 | Values: 1336.7 1417.1 1468.6 1470.5 1482.5 7258.7 7974.6 8364.5 8450.4 8461.7 7000.8 7159.9 7390.1 8008.0 8255.3 2287.2 2346.1 2349.1 2356.7 2359.8 2336.8 2369.9 2383.4 2384.1 2387.4 2052.5 2135.5 2262.1 2314.5 2327.4 2335.9 2351.1 2352.2 2352.8 2361.9 2309.1 2352.4 2368.4 2387.0 2390.5 8395.5 8431.6 8441.7 8453.9 8461.7 5041.6 5215.9 5216.6 5219.7 5225.1 3112.2 3335.4 3375.2 3382.4 3405.1 1114.7 1116.8 1179.8 1181.5 1186.7 10992.0 10999.5 11010.6 11039.7 11066.2 4549.7 4665.4 4730.8 4752.1 4760.5 9703.3 9712.2 9717.3 9721.7 9742.3 5292.7 5296.8 5300.1 5304.6 5304.7 4627.7 4690.5 4759.7 4793.2 4810.9 3335.7 3892.4 3902.6 3918.0 3955.5 1262.5 1262.5 1265.0 1279.5 1282.7 782.5 803.0 902.8 921.5 923.3 5583.2 5588.3 5615.8 5862.6 5892.9 956.5 998.0 999.3 1001.1 1034.1 3683.3 3737.9 3740.6 3853.5 3858.9 9805.5 9929.6 10009.2 10123.2 10165.4 10064.0 10066.3 10066.6 10076.4 10087.8 7423.4 7758.0 7791.2 7899.9 7917.9 5714.4 5731.0 5889.1 5929.6 5937.1 8683.0 8966.3 9033.8 9211.1 9223.4 7293.8 9251.6 9300.4 9405.9 9406.7 7151.6 7300.5 7302.3 7310.6 7329.0 7613.5 7749.5 7835.1 7841.3 7873.1 7026.5 7045.3 7116.1 7126.2 7233.7 6246.3 6817.9 6964.6 7023.6 7057.0 6228.3 6367.7 6377.3 6420.6 6459.6 4879.0 4926.7 5003.4 5093.3 5181.9 4987.8 5039.2 5082.5 5151.6 5253.4 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4494.35 Median:4929.98 stddev:1338.24 (27.1%) stddev-sans-first:1304.60 02:37:57 INFO - PROCESS | 1640 | Values: 308.8 351.5 360.5 367.5 371.5 4714.8 5096.8 5375.6 5397.0 5446.9 4433.5 4433.7 4609.3 4707.1 5231.4 4022.8 4196.5 4244.0 4255.0 4263.8 3356.7 3957.2 4217.7 4235.3 4239.2 3718.4 4077.5 4194.5 4222.0 4225.3 3980.6 4151.1 4197.9 4210.3 4230.6 3130.8 3322.8 3683.9 3710.3 3722.5 4817.9 5021.6 5066.9 5089.7 5214.3 3914.5 4016.8 4670.6 4902.5 4917.0 5085.8 5646.5 5656.5 5668.7 5719.2 3462.6 3577.1 4105.4 4114.1 4143.7 4845.8 5273.5 5984.6 5989.9 6042.8 4177.8 4210.8 4220.5 4230.3 4237.7 3752.3 4261.3 4263.9 4284.9 4308.0 4058.4 4451.8 4630.8 4829.7 4878.4 5573.0 5673.9 5690.6 5724.3 5745.7 1089.7 1283.0 1291.0 1300.3 1394.9 907.7 913.0 945.9 954.4 959.0 4281.5 4829.8 4995.5 5017.5 5019.1 4627.8 4770.4 5085.9 5099.6 5437.5 4279.3 4319.9 4498.9 4985.6 5045.7 2594.4 2637.7 2862.0 2886.4 2899.8 5351.0 5643.3 5654.3 5713.3 5725.6 4850.5 4927.0 5396.7 5646.3 5754.9 4927.3 5142.6 5564.6 5701.5 5760.0 4270.0 4623.0 4946.3 5250.3 5553.2 4289.3 5000.4 5032.8 5358.7 5406.5 5067.3 5117.0 5335.9 5490.4 5661.3 3676.0 3912.2 3918.8 3976.7 3992.9 5828.5 5877.0 5885.5 5924.2 5933.5 4813.7 5675.1 5718.9 5742.3 5762.7 4932.7 5443.7 5634.4 5658.0 5758.6 5018.3 5291.3 5352.6 5377.8 5394.3 5367.6 5503.9 5628.8 5643.9 5822.7 5574.7 5588.2 5592.7 5599.8 5661.6 02:37:57 INFO - PROCESS | 1640 | 02:37:57 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19458.47 Median:24817.47 stddev:27213.13 (109.7%) stddev-sans-first:27253.09 02:37:57 INFO - PROCESS | 1640 | Values: 718.4 768.0 819.4 829.6 840.1 15175.7 15636.8 15659.0 15709.2 15787.6 13449.9 14374.6 14467.0 14505.3 14506.9 679.7 702.7 707.3 836.7 845.1 850.5 854.9 870.4 870.9 871.3 911.0 911.3 912.1 913.4 914.4 716.4 739.3 911.5 912.0 912.1 660.9 674.4 680.3 682.0 682.4 15010.6 15183.0 15197.8 15213.6 15221.9 13829.9 13830.7 13838.6 13856.4 14038.2 12217.9 12315.4 12407.1 12753.5 13274.5 4286.3 4347.8 4473.6 4611.7 4620.3 94325.6 101332.5 101579.5 102503.5 102716.5 9956.0 10618.8 10836.4 11010.2 11254.7 21338.9 22005.6 22126.7 22131.9 22186.8 7385.7 7393.9 7780.8 7829.9 7843.2 4121.0 4267.7 4349.5 4388.8 4390.0 3316.9 3412.2 3435.0 3440.3 3445.3 618.1 628.7 651.5 659.8 661.9 547.5 554.5 567.9 570.6 577.7 8205.8 8545.5 10305.7 10345.7 10353.7 571.2 601.0 603.4 608.2 714.9 4774.2 4925.9 4931.9 4944.4 4971.4 81454.6 87627.6 97023.0 97589.5 97989.0 75381.6 79920.6 81272.6 83450.9 87329.0 64358.4 77556.4 78676.0 79416.0 79434.0 9824.1 9829.0 9846.7 9859.1 9874.3 36779.8 43319.9 45161.4 46214.8 48551.8 55541.0 63853.4 63887.7 65432.3 66418.0 12047.8 12532.0 12578.4 12698.0 12890.7 13814.4 14225.0 14349.7 14707.9 14852.6 10818.7 13118.0 13284.8 13585.7 13900.8 11227.5 12629.6 13404.6 13466.0 13475.5 12776.2 13526.0 13566.7 13744.8 13757.7 10862.5 11301.5 11324.3 11748.9 11997.5 10176.2 10541.6 10816.9 10854.8 10885.1 02:37:57 INFO - PROCESS | 1640 | -------- Summary: end -------- 02:37:57 INFO - PROCESS | 1640 | 02:37:58 INFO - TEST-INFO | 1640: exit 0 02:37:58 INFO - TEST-OK | dromaeo_css | took 1118448ms 02:37:58 INFO - TEST-START | kraken 02:37:58 INFO - operating with platform_type : mac_ 02:37:58 INFO - Initialising browser for kraken test... 02:37:58 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpoaAtKl/profile http://localhost:49243/getInfo.html) 02:38:00 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 02:38:00 INFO - PROCESS | 1647 | colorDepth:24 02:38:00 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 02:38:00 INFO - PROCESS | 1647 | __metrics 02:38:00 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:38:00 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:38:01 INFO - TEST-INFO | 1647: exit 0 02:38:01 INFO - Browser initialized. 02:38:01 INFO - Running cycle 1/1 for kraken test... 02:38:01 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpoaAtKl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:13 INFO - PROCESS | 1649 | RSS: Main: 212611072 02:38:13 INFO - PROCESS | 1649 | 02:38:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:17 INFO - PROCESS | 1649 | RSS: Main: 265314304 02:38:17 INFO - PROCESS | 1649 | 02:38:19 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 02:38:20 INFO - PROCESS | 1649 | RSS: Main: 274272256 02:38:20 INFO - PROCESS | 1649 | 02:38:23 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 02:38:24 INFO - PROCESS | 1649 | RSS: Main: 371671040 02:38:24 INFO - PROCESS | 1649 | 02:38:26 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 02:38:26 INFO - PROCESS | 1649 | RSS: Main: 275341312 02:38:26 INFO - PROCESS | 1649 | 02:38:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:38:29 INFO - PROCESS | 1649 | RSS: Main: 277983232 02:38:29 INFO - PROCESS | 1649 | 02:38:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:32 INFO - PROCESS | 1649 | RSS: Main: 317263872 02:38:32 INFO - PROCESS | 1649 | 02:38:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:36 INFO - PROCESS | 1649 | RSS: Main: 318705664 02:38:36 INFO - PROCESS | 1649 | 02:38:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 02:38:39 INFO - PROCESS | 1649 | RSS: Main: 316571648 02:38:39 INFO - PROCESS | 1649 | 02:38:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:38:41 INFO - PROCESS | 1649 | RSS: Main: 293556224 02:38:41 INFO - PROCESS | 1649 | 02:38:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:38:44 INFO - PROCESS | 1649 | RSS: Main: 296472576 02:38:44 INFO - PROCESS | 1649 | 02:38:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:38:47 INFO - PROCESS | 1649 | RSS: Main: 306532352 02:38:47 INFO - PROCESS | 1649 | 02:38:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:50 INFO - PROCESS | 1649 | RSS: Main: 319492096 02:38:50 INFO - PROCESS | 1649 | 02:38:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:54 INFO - PROCESS | 1649 | RSS: Main: 312672256 02:38:54 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 02:38:56 INFO - PROCESS | 1649 | RSS: Main: 356683776 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | __start_tp_report 02:38:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 02:38:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 02:38:56 INFO - PROCESS | 1649 | |i|pagename|runs| 02:38:56 INFO - PROCESS | 1649 | |0;ai-astar;117;115;114;115;115;114;114;114;114;114 02:38:56 INFO - PROCESS | 1649 | |1;audio-beat-detection;138;116;135;169;110;111;109;106;127;109 02:38:56 INFO - PROCESS | 1649 | |2;audio-dft;185;181;181;184;185;182;184;185;180;181 02:38:56 INFO - PROCESS | 1649 | |3;audio-fft;82;58;59;89;60;59;59;59;74;58 02:38:56 INFO - PROCESS | 1649 | |4;audio-oscillator;91;69;86;69;68;70;83;67;69;82 02:38:56 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;86;93;128;114;86;89;86;90;85 02:38:56 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;94;95;96;94;94;94;93;93;95 02:38:56 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;88;87;87;85;85;87;85;85;85 02:38:56 INFO - PROCESS | 1649 | |8;json-parse-financial;55;54;53;54;55;57;57;57;57;57 02:38:56 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;63;65;74;75;72;69;68;69;75;100 02:38:56 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;88;84;87;84;86;86;83;83;92;90 02:38:56 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;145;144;150;136;136;135;139;142;189;142 02:38:56 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;167;171;168;210;167;167;169;167;168;172 02:38:56 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;66;69;82;82;83;85;82;81;66;75 02:38:56 INFO - PROCESS | 1649 | __end_tp_report 02:38:56 INFO - PROCESS | 1649 | __start_cc_report 02:38:56 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2035 02:38:56 INFO - PROCESS | 1649 | __end_cc_report 02:38:56 INFO - PROCESS | 1649 | __startTimestamp1486031936649__endTimestamp 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | ------- Summary: start ------- 02:38:56 INFO - PROCESS | 1649 | Number of tests: 14 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:0.97 (0.8%) stddev-sans-first:0.50 02:38:56 INFO - PROCESS | 1649 | Values: 117.0 115.0 114.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:121.50 stddev:19.84 (16.3%) stddev-sans-first:20.29 02:38:56 INFO - PROCESS | 1649 | Values: 138.0 116.0 135.0 169.0 110.0 111.0 109.0 106.0 127.0 109.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:182.80 Median:184.00 stddev:1.99 (1.1%) stddev-sans-first:1.94 02:38:56 INFO - PROCESS | 1649 | Values: 185.0 181.0 181.0 184.0 185.0 182.0 184.0 185.0 180.0 181.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:65.70 Median:59.50 stddev:11.59 (19.5%) stddev-sans-first:10.68 02:38:56 INFO - PROCESS | 1649 | Values: 82.0 58.0 59.0 89.0 60.0 59.0 59.0 59.0 74.0 58.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.00 stddev:9.03 (11.9%) stddev-sans-first:7.62 02:38:56 INFO - PROCESS | 1649 | Values: 91.0 69.0 86.0 69.0 68.0 70.0 83.0 67.0 69.0 82.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:87.50 stddev:14.50 (16.6%) stddev-sans-first:15.24 02:38:56 INFO - PROCESS | 1649 | Values: 89.0 86.0 93.0 128.0 114.0 86.0 89.0 86.0 90.0 85.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 02:38:56 INFO - PROCESS | 1649 | Values: 94.0 94.0 95.0 96.0 94.0 94.0 94.0 93.0 93.0 95.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.15 (1.3%) stddev-sans-first:1.22 02:38:56 INFO - PROCESS | 1649 | Values: 86.0 88.0 87.0 87.0 85.0 85.0 87.0 85.0 85.0 85.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:1.58 (2.8%) stddev-sans-first:1.66 02:38:56 INFO - PROCESS | 1649 | Values: 55.0 54.0 53.0 54.0 55.0 57.0 57.0 57.0 57.0 57.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:70.50 stddev:10.33 (14.6%) stddev-sans-first:10.30 02:38:56 INFO - PROCESS | 1649 | Values: 63.0 65.0 74.0 75.0 72.0 69.0 68.0 69.0 75.0 100.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:3.02 (3.5%) stddev-sans-first:3.14 02:38:56 INFO - PROCESS | 1649 | Values: 88.0 84.0 87.0 84.0 86.0 86.0 83.0 83.0 92.0 90.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:143.00 stddev:15.89 (11.1%) stddev-sans-first:16.85 02:38:56 INFO - PROCESS | 1649 | Values: 145.0 144.0 150.0 136.0 136.0 135.0 139.0 142.0 189.0 142.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:168.50 stddev:13.26 (7.9%) stddev-sans-first:13.91 02:38:56 INFO - PROCESS | 1649 | Values: 167.0 171.0 168.0 210.0 167.0 167.0 169.0 167.0 168.0 172.0 02:38:56 INFO - PROCESS | 1649 | 02:38:56 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:82.00 stddev:7.46 (9.1%) stddev-sans-first:6.75 02:38:56 INFO - PROCESS | 1649 | Values: 66.0 69.0 82.0 82.0 83.0 85.0 82.0 81.0 66.0 75.0 02:38:56 INFO - PROCESS | 1649 | -------- Summary: end -------- 02:38:56 INFO - PROCESS | 1649 | 02:38:57 INFO - TEST-INFO | 1649: exit 0 02:38:57 INFO - TEST-OK | kraken | took 59307ms 02:38:57 INFO - SUITE-END | took 1177s 02:38:57 INFO - Completed test suite (00:19:38) 02:38:57 INFO - javascript benchmark 02:38:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.297487527619, 3352.591911397213, 3353.664633536646, 3359.2273777031296, 3415.453527435611, 5697.544196464283, 5746.39662835402, 5812.564057695668, 5829.621074630146, 5849.327327357355, 5677.517411020058, 5690.829275121742, 5717.828465146042, 5735.827925162242, 5768.942310576893, 5200.791968321272, 5204.661696989683, 5271.815486457975, 5284.2866213061125, 5328.520433161015, 5173.611979101583, 5181.870453238662, 5201.297824793661, 5317.654352467097, 5319.760610772505, 5201.219817027439, 5258.789648414059, 5278.577713782888, 5280.973595132019, 5326.2543243945875, 5303.337082864642, 5328.3605967284175, 5339.679619222859, 5342.706151161704, 5366.597505187126, 5047.823326183603, 5148.279240906276, 5251.212318152269, 5265.315508983807, 5290.735463226823, 5633.985882541141, 5710.914336284959, 5711.742971566248, 5715.199872017921, 5813.79651712188, 6213.937860621426, 6221.253449586034, 6255.687215639246, 6257.280412752546, 6273.843153921189, 5236.371635403738, 6253.749850005995, 6263.342349053375, 6283.088952101965, 6294.0558916162945, 5706.857328566819, 5715.457031582035, 5760.107183386582, 5810.0, 5813.854653633608, 6191.00943848982, 6219.129321894939, 6236.563440559117, 6244.625322480575, 6261.123442718023, 6152.169457123231, 6228.22147231596, 6239.532035097295, 6239.625622462667, 6252.781152659635, 6221.844453888599, 6268.968655156695, 6272.874542509125, 6275.121482992385, 6276.529260305495, 5035.269885866529, 6131.69422353494, 6145.156453064063, 6278.121063051177, 6294.527910406738, 6174.104754810527, 6211.565190436717, 6237.1891654084675, 6268.62388256697, 6273.780417685451, 4966.1309270877455, 5001.824936127218, 5004.9499505005215, 5015.097282489187, 5033.7734801934, 4458.417261872054, 4463.553644635575, 4466.2407390743, 4477.126960242721, 4491.685582009228, 5723.370429252779, 5791.82624521265, 5801.767929282782, 5875.706214689249, 5938.524918006636, 6220.657863817533, 6231.875362492816, 6237.068577768532, 6244.2819075806865, 6256.499480041586, 5967.8209653710455, 5977.462028417463, 5987.221661184019, 5991.430814072656, 6012.338642749294, 5372.140457526777, 5420.945790542044, 5433.157860531624, 5447.155690867922, 5505.064139096363, 6267.6866156691985, 6270.31026587075, 6304.0, 6377.330380310001, 6390.0, 5303.628745987744, 6204.790065937099, 6230.034344676583, 6236.563440559117, 6240.53196010292, 6172.969135154295, 6297.1813664223355, 6328.398802113792, 6367.968160159169, 6374.617522948638, 6142.959235178615, 6165.136880836597, 6173.228346456693, 6210.5652604317265, 6272.905906411316, 6181.752729890754, 6217.222847144107, 6224.906626400698, 6237.095621135, 6237.407446292595, 6143.18154655188, 6192.690365481618, 6195.411435913581, 6196.597221180609, 6205.348438414082, 6013.458788709037, 6074.362191969956, 6128.571000029955, 6132.6920582337325, 6135.722664536972, 6100.664463454553, 6102.0541816018585, 6106.480949119375, 6108.083787431743, 6118.418750218722, 5923.911141332969, 5992.310884248367, 5993.101034844808, 6183.96908015457, 6201.410865967726, 5722.198892155185, 5850.64896106235, 5886.0, 5914.733836977261, 5930.318013428511], "value": 5725.380337178041, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.243025502029, 481.9084772989182, 493.2330226497797, 495.9305697202392, 515.7215103843924, 26049.869750651244, 37839.81080094603, 39628.20743585127, 39694.603053969455, 39741.0, 41477.79261103698, 41939.37090943638, 41948.0, 41962.16075678492, 42019.94950126248, 8331.375146863978, 9238.307126965488, 9446.574904129331, 9448.622055117787, 9462.053794620551, 8396.83206335873, 8572.22849943505, 8578.099299573549, 8583.18459746323, 11202.66392008241, 11198.552057917674, 11457.197996140274, 11466.426678666076, 11481.311121332747, 11483.65549033526, 11399.601013964513, 11469.483873225683, 11472.827907581393, 11473.311601303865, 11476.311421314747, 8351.24838764508, 8571.271441927443, 11089.667309980714, 11288.548458061668, 11391.145664075228, 33372.99881003574, 39274.41088383648, 40460.79769601133, 40481.79759101215, 40619.59380406188, 3995.200959808021, 4029.9395509067094, 4030.1738143680477, 4042.514898212204, 4278.358246263055, 28168.29579260535, 28954.0, 29155.562666560018, 29845.850770746223, 30985.69014309873, 3206.1663967368654, 3212.951805722916, 3334.0, 3370.0900756795772, 3394.6944774970125, 442390.7880460577, 446861.0, 450803.4919650827, 451097.0, 456380.0, 58529.414705852396, 58838.705806470694, 58854.0, 58857.0, 58905.70547147237, 61539.6923015391, 61753.69123154446, 61785.69107154435, 61822.0, 61930.071048934304, 16017.279222434785, 16125.032498050154, 16414.26135823891, 16720.0, 16772.077535735407, 12777.297248651414, 12867.742645147231, 12869.22784632925, 12877.613671589866, 12891.419886105148, 13978.930105349407, 14365.712685746226, 14384.35270412834, 15749.527514174593, 15755.921220393824, 6272.40412160844, 6990.231074581792, 7256.2743725627015, 7306.123265208209, 7409.665955224087, 894.789724414762, 896.7489103051156, 901.8376692195468, 904.9502277374676, 928.5264515097214, 29642.40715185684, 29663.110106696833, 29694.851525742666, 30134.849325753232, 30196.54705179424, 923.787528868364, 1082.4533610526635, 1111.916606254518, 1131.8585176852894, 1194.832723418722, 15358.232088395536, 15425.305861236271, 15477.303521341566, 15650.37398504047, 15767.369305227892, 608753.0, 611389.0, 612060.0, 612228.9388553118, 613369.0, 57873.42126578765, 57877.42122578804, 57913.4208657908, 57985.420145798846, 58022.129668055015, 1355.8508564058143, 1446.320229492158, 1458.1688437590471, 1481.9036762610397, 1486.9776953345709, 26371.60442593324, 29387.706122938496, 29409.411811764072, 29466.705332946396, 30034.84982575073, 45257.0, 49312.0, 49367.753161233966, 49401.0, 49524.25713614371, 496169.0, 499827.50086249335, 500117.0, 500158.0, 503274.0, 38230.42654360131, 39155.60844391634, 39528.604713953646, 39554.0, 39618.60381396265, 44833.93915251731, 44951.550484494735, 45516.0, 45840.64513871177, 46508.0, 36974.63025369712, 37501.0, 37653.62346376501, 38685.0, 38723.22553548857, 37517.81241093777, 37809.810950945066, 38086.23827523489, 38416.0, 39217.411738824514, 36649.90050298495, 36795.08012299607, 37483.43774843325, 37527.68653097129, 37802.0, 25790.355241119123, 29515.40969180647, 31776.95034758648, 33833.66166338305, 34427.0, 20845.17680733084, 22777.772222277566, 23471.64792528079, 23552.764472355742, 25212.873935630203], "value": 19850.480107382595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.27437585145185, 386.80273060739023, 387.86037026670374, 398.1638559026045, 416.9103642716817, 15362.385504579817, 15381.769273460894, 18651.906740466296, 20942.685859712117, 21187.36437906865, 19761.901190494063, 20563.0, 21540.784592154112, 22102.557948841015, 22368.55262894741, 5870.501007414375, 5966.761329546813, 5970.164177015221, 6000.33996260411, 6138.0, 4647.465541462741, 4922.680025798311, 6002.249718785152, 6013.338532761392, 6013.54898382623, 4131.277026520362, 4383.3863259143745, 4420.580044895746, 5986.0, 6627.933720662804, 6659.267480577157, 6681.164854393201, 6684.598924064571, 6685.298043705414, 6696.263411024784, 7361.263873612649, 7678.500897441704, 7742.729004484816, 7748.961255193744, 7879.054513458422, 28612.284692882637, 30211.546826797614, 30211.942582009742, 30323.848380758176, 30500.77996880122, 2970.970290297091, 3008.8796448142048, 3047.9847600761855, 3049.085274417688, 3054.8930787422555, 14816.3332650031, 16644.001359918442, 17152.0, 17178.0, 17484.650306993917, 1665.4753752567901, 1943.2227109156308, 2000.6298834715624, 2018.4550171453625, 2021.0198053943825, 155576.0, 162066.1896690509, 165400.0, 165993.17003415027, 166533.0, 23428.765712343, 23588.461730740182, 23959.880200598884, 24092.7590724094, 24129.879350603136, 41921.0, 42060.789696051324, 42715.009949303254, 42954.0, 43192.56807431948, 8419.579021048923, 8630.180132887366, 8904.910950890408, 8951.239144672776, 9013.77465563353, 8706.216440520384, 8719.084496127942, 8746.300295976307, 8889.511076890833, 8899.822003559893, 4776.808927642925, 4836.443808961944, 4850.902981940412, 4918.55732984026, 4921.409430868247, 2001.5396458814555, 2030.8273796727149, 2037.4906273431643, 2045.693146028078, 2047.1606641277303, 1015.4313584392763, 1058.332505217129, 1061.7823346214007, 1075.7471994081384, 1091.49245600796, 21660.56678866414, 21885.562288754136, 22097.226597069024, 22240.666390004164, 22267.0, 1076.9192310576582, 1078.1267173589417, 1090.7491277006334, 1093.4150229627112, 1119.44027986007, 11261.943690281496, 11515.30908145514, 11557.47991340375, 11651.825222621497, 11665.708357291136, 673801.0, 679549.0, 691869.0, 734832.0, 739399.0, 153635.0, 154596.10860810892, 154683.0, 156617.0, 160765.19617402073, 1048.114343379843, 1068.6740544134113, 1091.3779145886926, 1096.4079397125463, 1097.6706987903597, 18740.812591873906, 19108.33120840764, 19276.42170734824, 19374.321898733477, 19697.606047878675, 50656.98686026185, 53453.0, 59783.402165977786, 60547.39452605417, 61101.0, 80001.0, 81394.0, 82103.0, 82752.58623706843, 82869.75695364454, 8284.502929823988, 8368.20502052304, 8443.493390396596, 8516.977962644274, 8677.26243269304, 10943.890561094606, 12725.872741272839, 13158.0, 13564.72870542564, 13572.389242483914, 11149.665510034712, 11274.549018039186, 11279.436028198394, 11379.601713939972, 11705.531778728755, 10100.595976161165, 10858.565657373932, 11104.056155226895, 11294.209405341548, 11721.472533736172, 9360.625574977197, 9966.900330996597, 11418.771624567296, 11641.243319184226, 11871.76256474883, 7398.149212840377, 7521.05986751656, 7663.770086897402, 7844.137144914169, 8596.957015214884, 10045.799084018132, 11430.485628146587, 11472.65582032507, 11627.767444651228, 11638.767224655629], "value": 10864.958777885597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.746018256532, 1417.0859795431948, 1468.5520916120581, 1470.5000299898034, 1482.4663121276342, 7258.745943891965, 7974.561399123046, 8364.539950302738, 8450.408471407003, 8461.703840365588, 7000.774864398735, 7159.928400715991, 7390.076240469942, 8007.959960200191, 8255.339572834175, 2287.2337766848127, 2346.1319311854554, 2349.0721165139757, 2356.670066190735, 2359.8112151027876, 2336.778006089419, 2369.9052037918464, 2383.368407372048, 2384.070212617081, 2387.403149212697, 2052.5381789097482, 2135.487483004076, 2262.1290803040865, 2314.4792421705065, 2327.359976006595, 2335.9065637374483, 2351.1183306260154, 2352.2472808701223, 2352.8117750579913, 2361.940951476227, 2309.099451214011, 2352.447174913894, 2368.3842201027683, 2386.997461066356, 2390.521895620883, 8395.454295470774, 8431.578421078983, 8441.746747597583, 8453.915460845436, 8461.746147615582, 5041.571466425358, 5215.921761173586, 5216.608754343401, 5219.660722053054, 5225.137852254374, 3112.206387371206, 3335.4329763939945, 3375.206826395795, 3382.408078586262, 3405.1487128217946, 1114.7213196700825, 1116.7598966222301, 1179.7994340962057, 1181.4978634080567, 1186.685528334992, 10992.0, 10999.450027498673, 11010.614628488045, 11039.668809935714, 11066.225364224507, 4549.658775591778, 4665.440147182292, 4730.834420795256, 4752.097101550694, 4760.500147484534, 9703.272254580934, 9712.22302215821, 9717.271204659537, 9721.659741909, 9742.269329800294, 5292.655977361459, 5296.788128474895, 5300.1254792958725, 5304.628675992721, 5304.734763261821, 4627.745473998963, 4690.484046754923, 4759.6668233223345, 4793.209120495079, 4810.927836082462, 3335.69978701918, 3892.3772196449, 3902.570717221103, 3917.9608203918165, 3955.4857868476915, 1262.450833887262, 1262.50762202741, 1264.9810252846214, 1279.4754150798128, 1282.6921538830613, 782.4757412533617, 802.9759107226793, 902.7788191893028, 921.5254144115786, 923.3398120343986, 5583.246261754693, 5588.329400471969, 5615.803446879339, 5862.618929769551, 5892.941070589325, 956.4787190980932, 997.9900200998043, 999.3354419311077, 1001.1040119093516, 1034.0796690945065, 3683.3001729671278, 3737.8691745788765, 3740.6446387593137, 3853.537575490903, 3858.9228215435533, 9805.509724513746, 9929.553170107363, 10009.249306302056, 10123.240756943258, 10165.390076595428, 10064.0, 10066.295359324777, 10066.59733610662, 10076.395416275047, 10087.798244035079, 7423.369013633794, 7757.961210194026, 7791.220877912164, 7899.921000790034, 7917.920820791718, 5714.3999880012, 5730.971345143247, 5889.116632505158, 5929.584929054925, 5937.050071988461, 8683.0, 8966.282697384064, 9033.819323613623, 9211.078892110736, 9223.354365194373, 7293.781186564412, 9251.629934802533, 9300.441973481613, 9405.85891211646, 9406.670766523139, 7151.642417879189, 7300.488965772345, 7302.34278914879, 7310.561366318038, 7328.963355183403, 7613.467057305936, 7749.496282741604, 7835.059792824897, 7841.255080767318, 7873.133955265031, 7026.508144429841, 7045.295470452914, 7116.074910261633, 7126.216116227107, 7233.746818861315, 6246.312905580474, 6817.897731533932, 6964.582125072512, 7023.578585284899, 7056.964715176391, 6228.34602366745, 6367.745290188341, 6377.2984971654005, 6420.55056146084, 6459.612423254432, 4878.975605121952, 4926.679765815211, 5003.374578177728, 5093.261477085876, 5181.948180518147, 4987.825426110068, 5039.21892106724, 5082.491750824888, 5151.562117220078, 5253.422123566481], "value": 4431.999374443824, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.84338153614715, 351.49209392427946, 360.5079067073444, 367.5369035015879, 371.5207382476605, 4714.76426178691, 5096.847094587159, 5375.569954403648, 5396.973015134919, 5446.945530544694, 4433.534478879719, 4433.733975961444, 4609.308603709445, 4707.070101258485, 5231.372235331765, 4022.798860057, 4196.538380778112, 4243.978780106095, 4255.0, 4263.786810659454, 3356.7314614830875, 3957.1887763008513, 4217.746935183899, 4235.2800023996, 4239.173361194568, 3718.3678774608384, 4077.510698716158, 4194.496660400741, 4222.0, 4225.302825033866, 3980.6218409251073, 4151.086760912594, 4197.91604167918, 4210.305299625574, 4230.555791641895, 3130.812151270931, 3322.7674062815613, 3683.852645894161, 3710.257948410329, 3722.497462842509, 4817.879553011167, 5021.57316628087, 5066.923996140061, 5089.745512724386, 5214.270002199695, 3914.549826769901, 4016.7790771507557, 4670.649701272384, 4902.460729319772, 4917.041176970492, 5085.770535709814, 5646.548276137899, 5656.462636049569, 5668.659880407147, 5719.227904232958, 3462.6191118976894, 3577.069961809948, 4105.44576482174, 4114.107510545153, 4143.70994030418, 4845.806167753321, 5273.541884149887, 5984.640921544721, 5989.940100599026, 6042.8187154385, 4177.770222637723, 4210.789460526961, 4220.5146408163455, 4230.302000169938, 4237.6821738369745, 3752.2870654575545, 4261.2542805009, 4263.914721705549, 4284.935725964113, 4307.956920430818, 4058.370952502367, 4451.77741112943, 4630.768461576908, 4829.66192366531, 4878.390201224847, 5572.9905850840905, 5673.943260567424, 5690.573207009491, 5724.341700704389, 5745.701719312225, 1089.6894385100368, 1282.9550965716155, 1291.031726205346, 1300.3498250874563, 1394.9232792196526, 907.7276816954887, 912.9726108216764, 945.9195968342768, 954.4464210757744, 958.9520523973773, 4281.507626622916, 4829.782659780319, 4995.450500444948, 5017.54842064216, 5019.071471777733, 4627.791749371287, 4770.356001939763, 5085.949140508622, 5099.566536844335, 5437.45625437461, 4279.251131052053, 4319.892002699895, 4498.887527811831, 4985.601151907838, 5045.68812108847, 2594.364380726734, 2637.6834779826545, 2861.957070643942, 2886.4371447567523, 2899.7680185585104, 5350.973245133828, 5643.294588176478, 5654.293213348332, 5713.285839270091, 5725.570582206351, 4850.5149485051215, 4926.989967056745, 5396.676199427969, 5646.317998950466, 5754.942450575524, 4927.28554359623, 5142.6400151989, 5564.636664017261, 5701.543876489871, 5759.968022384348, 4269.957300426956, 4622.976885115553, 4946.307516947558, 5250.291210686509, 5553.222548843246, 4289.270823959871, 5000.374953130859, 5032.773525191302, 5358.678479291255, 5406.4591591396265, 5067.263677614194, 5117.0342984187555, 5335.879465312172, 5490.368607610176, 5661.339170589817, 3676.04078716625, 3912.158885839558, 3918.8040597969416, 3976.681865450699, 3992.940105898356, 5828.53371730269, 5877.000909845422, 5885.498663068093, 5924.170616113834, 5933.465988061095, 4813.711177329372, 5675.091985282335, 5718.885622287614, 5742.310922689304, 5762.740676669476, 4932.679375840702, 5443.673379597237, 5634.4365563443325, 5657.981563318642, 5758.568107391879, 5018.322526459027, 5291.312129423304, 5352.598555108305, 5377.784888604412, 5394.271773310553, 5367.624266301477, 5503.944960550343, 5628.763461009854, 5643.88712225745, 5822.737976791139, 5574.665520068809, 5588.233824257019, 5592.692401917933, 5599.776008959596, 5661.57538184646], "value": 4082.4786903464737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.414492188866, 768.0, 819.3672223351965, 829.6142293833366, 840.10109183174, 15175.696486070286, 15636.765448518252, 15659.0, 15709.214539273033, 15787.605309867246, 13449.865501344984, 14374.568762937128, 14467.0, 14505.274736263198, 14506.927465362685, 679.6533767778419, 702.7399862051049, 707.2715103443461, 836.69042454292, 845.1295165979036, 850.4897061762955, 854.9230569248766, 870.3994243971671, 870.9259712924409, 871.3464901324007, 910.9772255693628, 911.3301723233418, 912.1289168843772, 913.3834661603424, 914.3919293669735, 716.3910675925474, 739.2755100001974, 911.5214512380986, 911.9635214591408, 912.1471424218344, 660.8810414125455, 674.3997841920694, 680.2823021712092, 682.0008687273119, 682.4335801284922, 15010.62473438162, 15183.0, 15197.848021519754, 15213.61965950849, 15221.923890380478, 13829.861701383059, 13830.654233644138, 13838.584842454742, 13856.445742170301, 14038.157710537298, 12217.877821221762, 12315.4458049388, 12407.131500794949, 12753.489860405572, 13274.46902123914, 4286.292761694317, 4347.847825326098, 4473.552644735533, 4611.746353950532, 4620.330052142421, 94325.58511622332, 101332.49333753358, 101579.4763078547, 102503.48748256285, 102716.48641756819, 9955.950220248853, 10618.77884043345, 10836.403997780199, 11010.174236932262, 11254.662360129045, 21338.893305533373, 22005.559888802134, 22126.672399656072, 22131.889340553516, 22186.778132218795, 7385.741499047507, 7393.852122957618, 7780.844383112306, 7829.882551761728, 7843.215678432225, 4120.958790412117, 4267.701260911768, 4349.499807522112, 4388.824447022147, 4390.034192477649, 3316.9170770730443, 3412.1981334386896, 3435.0210190095704, 3440.3291358185415, 3445.2937147884622, 618.0821480102045, 628.6919409489317, 651.4755621724463, 659.7756762700609, 661.9040239165294, 547.5209191957038, 554.4815597416429, 567.8722287485283, 570.6005795942857, 577.719805894141, 8205.753827385188, 8545.529995850287, 10305.74235644115, 10345.689629311133, 10353.689389318333, 571.2117278156118, 600.9639421634716, 603.4116736182187, 608.1698481572621, 714.8570285942728, 4774.188387974053, 4925.926111108336, 4931.926021109686, 4944.406671199479, 4971.37857767779, 81454.59272703598, 87627.56186219155, 97023.0, 97589.51205243928, 97989.0, 75381.62309188419, 79920.60039699764, 81272.59363703143, 83450.90667293347, 87329.0, 64358.356416436174, 77556.44887102339, 78676.0, 79416.0, 79434.01414964673, 9824.115829575087, 9829.0, 9846.704598862045, 9859.063388978035, 9874.259430542594, 36779.81610091932, 43319.9170020752, 45161.38708903346, 46214.76892615516, 48551.75724121357, 55541.0, 63853.3614663866, 63887.68056159689, 65432.34567654262, 66418.0, 12047.75904481923, 12532.0, 12578.371081446074, 12697.98416126726, 12890.67773305675, 13814.447422103405, 14225.0, 14349.713005739617, 14707.852921470649, 14852.554423367315, 10818.67543973682, 13118.0, 13284.800727988895, 13585.728285434434, 13900.813403540127, 11227.494762735532, 12629.621111366674, 13404.597862064154, 13466.0, 13475.46098156102, 12776.169548979287, 13525.985551083511, 13566.660833479242, 13744.762971332628, 13757.656058598615, 10862.456877156268, 11301.547938082385, 11324.263922844988, 11748.941255293668, 11997.460114294703, 10176.185905127424, 10541.631042913461, 10816.891831081588, 10854.837177442187, 10885.129189664965], "value": 7349.985459806704, "unit": "score"}], "name": "dromaeo_css", "value": 7400.205175578315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 116.0, 135.0, 169.0, 110.0, 111.0, 109.0, 106.0, 127.0, 109.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 181.0, 184.0, 185.0, 182.0, 184.0, 185.0, 180.0, 181.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 89.0, 60.0, 59.0, 59.0, 59.0, 74.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 86.0, 69.0, 68.0, 70.0, 83.0, 67.0, 69.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 93.0, 128.0, 114.0, 86.0, 89.0, 86.0, 90.0, 85.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0, 93.0, 93.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 87.0, 87.0, 85.0, 85.0, 87.0, 85.0, 85.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 55.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 74.0, 75.0, 72.0, 69.0, 68.0, 69.0, 75.0, 100.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 84.0, 86.0, 86.0, 83.0, 83.0, 92.0, 90.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 150.0, 136.0, 136.0, 135.0, 139.0, 142.0, 189.0, 142.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 168.0, 210.0, 167.0, 167.0, 169.0, 167.0, 168.0, 172.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 82.0, 82.0, 83.0, 85.0, 82.0, 81.0, 66.0, 75.0], "value": 77.1, "unit": "score"}], "name": "kraken", "value": 1446.6999999999998, "alertThreshold": 2.0}]} 02:38:57 INFO - Return code: 0 02:38:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:38:57 ERROR - # TBPL SUCCESS # 02:38:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:38:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:38:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:38:57 INFO - 2017-02-02 02:38:57.936 screenresolution[1653:9962] starting screenresolution argv=screenresolution get 02:38:57 INFO - 2017-02-02 02:38:57.940 screenresolution[1653:9962] Display 0: 1600x1200x32@60 02:38:57 INFO - 2017-02-02 02:38:57.946 screenresolution[1654:9965] starting screenresolution argv=screenresolution list 02:38:57 INFO - Available Modes on Display 0 02:38:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:38:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:38:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:38:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:38:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:38:58 INFO - Intel Iris: 02:38:58 INFO - Chipset Model: Intel Iris 02:38:58 INFO - Type: GPU 02:38:58 INFO - Bus: Built-In 02:38:58 INFO - VRAM (Dynamic, Max): 1536 MB 02:38:58 INFO - Vendor: Intel (0x8086) 02:38:58 INFO - Device ID: 0x0a2e 02:38:58 INFO - Revision ID: 0x0009 02:38:58 INFO - Displays: 02:38:58 INFO - Display: 02:38:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:38:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:38:58 INFO - Display Serial Number: 1600x1200 60 02:38:58 INFO - Main Display: Yes 02:38:58 INFO - Mirror: Off 02:38:58 INFO - Online: Yes 02:38:58 INFO - Rotation: Supported 02:38:58 INFO - Return code: 0 02:38:58 INFO - Running post-action listener: _resource_record_post_action 02:38:58 INFO - [mozharness: 2017-02-02 10:38:58.180744Z] Finished run-tests step (success) 02:38:58 INFO - Running post-run listener: _resource_record_post_run 02:38:58 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 38061056; Write bytes: 508436992; Read time: 247; Write time: 1575 02:38:58 INFO - TinderboxPrint: CPU usage
53.5% 02:38:58 INFO - TinderboxPrint: I/O read bytes / time
38,061,056 / 247 02:38:58 INFO - TinderboxPrint: I/O write bytes / time
508,436,992 / 1,575 02:38:58 INFO - TinderboxPrint: CPU idle
2,232.0 (46.5%) 02:38:58 INFO - TinderboxPrint: CPU system
955.3 (19.9%) 02:38:58 INFO - TinderboxPrint: CPU user
1,610.5 (33.6%) 02:38:58 INFO - TinderboxPrint: Swap in / out
244,617,216 / 0 02:38:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205520896; Write bytes: 198807552; Read time: 15620; Write time: 424 02:38:58 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30911488; Write bytes: 298942976; Read time: 184; Write time: 1115 02:38:58 INFO - Running post-run listener: _upload_blobber_files 02:38:58 INFO - Blob upload gear active. 02:38:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38:58 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 02:38:58 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'] 02:38:58 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 02:38:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:00 INFO - (blobuploader) - INFO - Done attempting. 02:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:01 INFO - (blobuploader) - INFO - Done attempting. 02:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:02 INFO - (blobuploader) - INFO - Done attempting. 02:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:04 INFO - (blobuploader) - INFO - Done attempting. 02:39:04 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:04 INFO - Return code: 0 02:39:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41f116c7f7bc90e2f32bd64994e3ba078ab1aa5e0c37faa31aec495eb5734bcbee88a9ebf5fb2b3787feba30e6029c751f272b5809d202e86eec523e3bd6a7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30c9124139286dcfd3d1ddb098e88d326eeb396a305bb9efad3476b3d3a295d0d52cc3653180bcea0b9033fcbcfb3dc877dbf0fb51ab52bc67d8fd853e31d40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4619e5154944f6f5a1daa5b103cd7cb4197b1c7fe66b617f56562ce47cfb8ce0fdaecd7c27f0427af207470decef0f26eea514945fedc5dd2f069351e2eac6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4958d8a8764556e6c6b3cdd99f53563b148b55d3dc2d3fa3399d0b81d92b84c9c692c5f225256464afe3052dba08e906567a68a5a4950a4844dd493cd4132923"} 02:39:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:04 INFO - Contents: 02:39:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41f116c7f7bc90e2f32bd64994e3ba078ab1aa5e0c37faa31aec495eb5734bcbee88a9ebf5fb2b3787feba30e6029c751f272b5809d202e86eec523e3bd6a7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30c9124139286dcfd3d1ddb098e88d326eeb396a305bb9efad3476b3d3a295d0d52cc3653180bcea0b9033fcbcfb3dc877dbf0fb51ab52bc67d8fd853e31d40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4619e5154944f6f5a1daa5b103cd7cb4197b1c7fe66b617f56562ce47cfb8ce0fdaecd7c27f0427af207470decef0f26eea514945fedc5dd2f069351e2eac6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4958d8a8764556e6c6b3cdd99f53563b148b55d3dc2d3fa3399d0b81d92b84c9c692c5f225256464afe3052dba08e906567a68a5a4950a4844dd493cd4132923"} 02:39:04 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:04 INFO - Copying logs to upload dir... 02:39:04 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.403607 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-02-02 02:39:04.321235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 02:39:04.325385) ========= 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.45BPINLLIu/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.lDP92XqJWz/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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/41f116c7f7bc90e2f32bd64994e3ba078ab1aa5e0c37faa31aec495eb5734bcbee88a9ebf5fb2b3787feba30e6029c751f272b5809d202e86eec523e3bd6a7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30c9124139286dcfd3d1ddb098e88d326eeb396a305bb9efad3476b3d3a295d0d52cc3653180bcea0b9033fcbcfb3dc877dbf0fb51ab52bc67d8fd853e31d40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4619e5154944f6f5a1daa5b103cd7cb4197b1c7fe66b617f56562ce47cfb8ce0fdaecd7c27f0427af207470decef0f26eea514945fedc5dd2f069351e2eac6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4958d8a8764556e6c6b3cdd99f53563b148b55d3dc2d3fa3399d0b81d92b84c9c692c5f225256464afe3052dba08e906567a68a5a4950a4844dd493cd4132923"} build_url:https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/dH6OrbBjRaOeKvMBX_AP1A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41f116c7f7bc90e2f32bd64994e3ba078ab1aa5e0c37faa31aec495eb5734bcbee88a9ebf5fb2b3787feba30e6029c751f272b5809d202e86eec523e3bd6a7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30c9124139286dcfd3d1ddb098e88d326eeb396a305bb9efad3476b3d3a295d0d52cc3653180bcea0b9033fcbcfb3dc877dbf0fb51ab52bc67d8fd853e31d40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4619e5154944f6f5a1daa5b103cd7cb4197b1c7fe66b617f56562ce47cfb8ce0fdaecd7c27f0427af207470decef0f26eea514945fedc5dd2f069351e2eac6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4958d8a8764556e6c6b3cdd99f53563b148b55d3dc2d3fa3399d0b81d92b84c9c692c5f225256464afe3052dba08e906567a68a5a4950a4844dd493cd4132923"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 02:39:04.360720) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:39:04.361120) ========= 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.45BPINLLIu/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.lDP92XqJWz/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.005194 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:39:04.410420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 02:39:04.410853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 02:39:04.411290) ========= ========= Total master_lag: 0.24 =========