builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0099 starttime: 1478256433.07 results: success (0) buildid: 20161104004016 builduid: d4326d5f2bfc4f0f8d2912acef6958e9 revision: ffae4aede5a1ed6c8374af2b443b701714576119 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.075071) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.076078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.076778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.103536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.104268) ========= 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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-04 03:47:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2016-11-04 03:47:13 (135 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098889 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.231622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.231935) ========= 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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.026837 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:13.283413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-04 03:47:13.283740) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ffae4aede5a1ed6c8374af2b443b701714576119 --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 ffae4aede5a1ed6c8374af2b443b701714576119 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F88bWLCzFe/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.Jm4IxY8TGH/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-04 03:47:13,398 truncating revision to first 12 chars 2016-11-04 03:47:13,398 Setting DEBUG logging. 2016-11-04 03:47:13,398 attempt 1/10 2016-11-04 03:47:13,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ffae4aede5a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 03:47:14,910 unpacking tar archive at: mozilla-aurora-ffae4aede5a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.797324 ========= master_lag: 1.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-04 03:47:16.206335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:16.206661) ========= script_repo_revision: ffae4aede5a1ed6c8374af2b443b701714576119 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:16.207074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:16.207363) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 03:47:16.227793) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-04 03:47:16.228212) ========= /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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:47:16 INFO - MultiFileLogger online at 20161104 03:47:16 in /builds/slave/test 03:47:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:47:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:16 INFO - {'append_to_log': False, 03:47:16 INFO - 'base_work_dir': '/builds/slave/test', 03:47:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:47:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:16 INFO - 'branch': 'Mozilla-Aurora', 03:47:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:16 INFO - 'config_files': ('talos/mac_config.py',), 03:47:16 INFO - 'default_actions': ('clobber', 03:47:16 INFO - 'read-buildbot-config', 03:47:16 INFO - 'download-and-extract', 03:47:16 INFO - 'populate-webroot', 03:47:16 INFO - 'create-virtualenv', 03:47:16 INFO - 'install', 03:47:16 INFO - 'run-tests'), 03:47:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:16 INFO - 'download_minidump_stackwalk': True, 03:47:16 INFO - 'download_symbols': 'ondemand', 03:47:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:16 INFO - 'installer_path': 'installer.exe', 03:47:16 INFO - 'log_level': 'info', 03:47:16 INFO - 'log_name': 'talos', 03:47:16 INFO - 'log_to_console': True, 03:47:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:47:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:47:16 INFO - 'opt_config_files': (), 03:47:16 INFO - 'pip_index': False, 03:47:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:47:16 INFO - 'cmd': ('bash', 03:47:16 INFO - '-c', 03:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:47:16 INFO - 'enabled': True, 03:47:16 INFO - 'halt_on_failure': False, 03:47:16 INFO - 'name': 'check_screen_resolution'},), 03:47:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:47:16 INFO - 'cmd': ('bash', 03:47:16 INFO - '-c', 03:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:47:16 INFO - 'enabled': True, 03:47:16 INFO - 'halt_on_failure': False, 03:47:16 INFO - 'name': 'check_screen_resolution'},), 03:47:16 INFO - 'run_cmd_checks_enabled': True, 03:47:16 INFO - 'sps_profile': False, 03:47:16 INFO - 'sps_profile_interval': 0, 03:47:16 INFO - 'suite': 'dromaeojs', 03:47:16 INFO - 'system_bits': '32', 03:47:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:16 INFO - 'title': 't-yosemite-r7-0099', 03:47:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:16 INFO - 'use_talos_json': True, 03:47:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:16 INFO - 'work_dir': 'build'} 03:47:16 INFO - [mozharness: 2016-11-04 10:47:16.468835Z] Running clobber step. 03:47:16 INFO - Running pre-action listener: _resource_record_pre_action 03:47:16 INFO - Running main action method: clobber 03:47:16 INFO - rmtree: /builds/slave/test/build 03:47:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:18 INFO - Running post-action listener: _resource_record_post_action 03:47:18 INFO - [mozharness: 2016-11-04 10:47:18.730079Z] Finished clobber step (success) 03:47:18 INFO - [mozharness: 2016-11-04 10:47:18.730206Z] Running read-buildbot-config step. 03:47:18 INFO - Running pre-action listener: _resource_record_pre_action 03:47:18 INFO - Running main action method: read_buildbot_config 03:47:18 INFO - Using buildbot properties: 03:47:18 INFO - { 03:47:18 INFO - "project": "", 03:47:18 INFO - "product": "firefox", 03:47:18 INFO - "script_repo_revision": "production", 03:47:18 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:47:18 INFO - "repository": "", 03:47:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:47:18 INFO - "buildid": "20161104004016", 03:47:18 INFO - "stage_platform": "macosx64", 03:47:18 INFO - "basedir": "/builds/slave/test", 03:47:18 INFO - "nightly_build": "True", 03:47:18 INFO - "buildnumber": 16, 03:47:18 INFO - "slavename": "t-yosemite-r7-0099", 03:47:18 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:47:18 INFO - "platform": "yosemite_r7", 03:47:18 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:47:18 INFO - "branch": "mozilla-aurora", 03:47:18 INFO - "repo_path": "releases/mozilla-aurora", 03:47:18 INFO - "revision": "ffae4aede5a1ed6c8374af2b443b701714576119", 03:47:18 INFO - "pgo_build": "False", 03:47:18 INFO - "builduid": "d4326d5f2bfc4f0f8d2912acef6958e9", 03:47:18 INFO - "slavebuilddir": "test" 03:47:18 INFO - } 03:47:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:47:18 INFO - Running post-action listener: _resource_record_post_action 03:47:18 INFO - [mozharness: 2016-11-04 10:47:18.733579Z] Finished read-buildbot-config step (success) 03:47:18 INFO - [mozharness: 2016-11-04 10:47:18.733708Z] Running download-and-extract step. 03:47:18 INFO - Running pre-action listener: _resource_record_pre_action 03:47:18 INFO - Running main action method: download_and_extract 03:47:18 INFO - mkdir: /builds/slave/test/build/tests 03:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:18 INFO - trying https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:47:18 INFO - Downloading https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:47:19 INFO - Downloaded 1199 bytes. 03:47:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:47:19 INFO - Using the following test package requirements: 03:47:19 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:47:19 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:47:19 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:47:19 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'jsshell-mac.zip'], 03:47:19 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:47:19 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:47:19 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:47:19 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:47:19 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:47:19 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:47:19 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:47:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:47:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:47:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:47:19 INFO - Fetch https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:47:20 INFO - Expected file size: 16421595 03:47:27 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:47:27 INFO - Expected file size: 16421595 03:47:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:47:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:47:34 INFO - Fetch https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:47:35 INFO - Expected file size: 14414089 03:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:35 INFO - trying https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:47:35 INFO - Downloading https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:47:38 INFO - Downloaded 115513441 bytes. 03:47:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:47:38 INFO - mkdir: /builds/slave/test/properties 03:47:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:38 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:38 INFO - Contents: 03:47:38 INFO - build_url:https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:47:39 INFO - Running post-action listener: _resource_record_post_action 03:47:39 INFO - Running post-action listener: set_extra_try_arguments 03:47:39 INFO - [mozharness: 2016-11-04 10:47:39.477095Z] Finished download-and-extract step (success) 03:47:39 INFO - [mozharness: 2016-11-04 10:47:39.477215Z] Running populate-webroot step. 03:47:39 INFO - Running pre-action listener: _resource_record_pre_action 03:47:39 INFO - Running main action method: populate_webroot 03:47:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:39 INFO - '--tppagecycles', 03:47:39 INFO - '7'], 03:47:39 INFO - 'tests': ['tsvgm']}}, 03:47:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:47:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:47:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:47:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['damp', 'tps']}, 03:47:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'tests': ['damp', 'tps']}, 03:47:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['dromaeo_dom']}, 03:47:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['basic_compositor_video']}, 03:47:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:47:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['a11yr', 03:47:39 INFO - 'ts_paint', 03:47:39 INFO - 'tpaint', 03:47:39 INFO - 'sessionrestore', 03:47:39 INFO - 'sessionrestore_no_auto_restore', 03:47:39 INFO - 'tabpaint']}, 03:47:39 INFO - 'other-e10s': {'tests': ['a11yr', 03:47:39 INFO - 'ts_paint', 03:47:39 INFO - 'tpaint', 03:47:39 INFO - 'sessionrestore', 03:47:39 INFO - 'sessionrestore_no_auto_restore', 03:47:39 INFO - 'tabpaint']}, 03:47:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:47:39 INFO - 'ts_paint', 03:47:39 INFO - 'tpaint', 03:47:39 INFO - 'sessionrestore', 03:47:39 INFO - 'sessionrestore_no_auto_restore', 03:47:39 INFO - 'tabpaint']}, 03:47:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:47:39 INFO - 'ts_paint', 03:47:39 INFO - 'tpaint', 03:47:39 INFO - 'sessionrestore', 03:47:39 INFO - 'sessionrestore_no_auto_restore', 03:47:39 INFO - 'tabpaint']}, 03:47:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['a11yr', 03:47:39 INFO - 'ts_paint', 03:47:39 INFO - 'tpaint', 03:47:39 INFO - 'sessionrestore', 03:47:39 INFO - 'sessionrestore_no_auto_restore', 03:47:39 INFO - 'tabpaint']}, 03:47:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['a11yr', 03:47:39 INFO - 'ts_paint', 03:47:39 INFO - 'tpaint', 03:47:39 INFO - 'sessionrestore', 03:47:39 INFO - 'sessionrestore_no_auto_restore', 03:47:39 INFO - 'tabpaint']}, 03:47:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['tsvgx', 03:47:39 INFO - 'tsvgr_opacity', 03:47:39 INFO - 'tart', 03:47:39 INFO - 'tscrollx', 03:47:39 INFO - 'cart']}, 03:47:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:47:39 INFO - 'tsvgr_opacity', 03:47:39 INFO - 'tart', 03:47:39 INFO - 'tscrollx', 03:47:39 INFO - 'cart']}, 03:47:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'talos_options': ['--disable-e10s'], 03:47:39 INFO - 'tests': ['tp5o']}, 03:47:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'tests': ['tp5o']}, 03:47:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'talos_options': ['--disable-e10s', 03:47:39 INFO - '--xperf_path', 03:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:39 INFO - 'tests': ['tp5n']}, 03:47:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:39 INFO - 'talos_options': ['--xperf_path', 03:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:39 INFO - 'tests': ['tp5n']}}, 03:47:39 INFO - 'talos.zip': {'path': '', 03:47:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:39 INFO - Running post-action listener: _resource_record_post_action 03:47:39 INFO - [mozharness: 2016-11-04 10:47:39.495549Z] Finished populate-webroot step (success) 03:47:39 INFO - [mozharness: 2016-11-04 10:47:39.495686Z] Running create-virtualenv step. 03:47:39 INFO - Running pre-action listener: _resource_record_pre_action 03:47:39 INFO - Running main action method: create_virtualenv 03:47:39 INFO - Creating virtualenv /builds/slave/test/build/venv 03:47:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:47:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:47:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:39 INFO - Using real prefix '/tools/python27' 03:47:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:47:40 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:43 INFO - Installing pip.................done. 03:47:43 INFO - Return code: 0 03:47:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:43 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:43 INFO - 'HOME': '/Users/cltbld', 03:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:43 INFO - 'LOGNAME': 'cltbld', 03:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:43 INFO - 'MOZ_NO_REMOTE': '1', 03:47:43 INFO - 'NO_EM_RESTART': '1', 03:47:43 INFO - 'PAGER': '/bin/cat', 03:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:43 INFO - 'PWD': '/builds/slave/test', 03:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:43 INFO - 'SHELL': '/bin/bash', 03:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:47:43 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:43 INFO - 'USER': 'cltbld', 03:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:43 INFO - 'XPC_FLAGS': '0x0', 03:47:43 INFO - 'XPC_SERVICE_NAME': '0', 03:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:47:43 INFO - Cleaning up... 03:47:43 INFO - Return code: 0 03:47:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:43 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:43 INFO - 'HOME': '/Users/cltbld', 03:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:43 INFO - 'LOGNAME': 'cltbld', 03:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:43 INFO - 'MOZ_NO_REMOTE': '1', 03:47:43 INFO - 'NO_EM_RESTART': '1', 03:47:43 INFO - 'PAGER': '/bin/cat', 03:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:43 INFO - 'PWD': '/builds/slave/test', 03:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:43 INFO - 'SHELL': '/bin/bash', 03:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:47:43 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:43 INFO - 'USER': 'cltbld', 03:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:43 INFO - 'XPC_FLAGS': '0x0', 03:47:43 INFO - 'XPC_SERVICE_NAME': '0', 03:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:43 INFO - Downloading/unpacking psutil>=3.1.1 03:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:47 INFO - Installing collected packages: psutil 03:47:47 INFO - Running setup.py install for psutil 03:47:47 INFO - building 'psutil._psutil_osx' extension 03:47:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:47:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:47:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:47:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:47:48 INFO - building 'psutil._psutil_posix' extension 03:47:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:47:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:47:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:47:48 INFO - ^ 03:47:48 INFO - 1 warning generated. 03:47:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:47:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:48 INFO - Successfully installed psutil 03:47:48 INFO - Cleaning up... 03:47:48 INFO - Return code: 0 03:47:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:47:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:47:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:48 INFO - 'HOME': '/Users/cltbld', 03:47:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:48 INFO - 'LOGNAME': 'cltbld', 03:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:48 INFO - 'MOZ_NO_REMOTE': '1', 03:47:48 INFO - 'NO_EM_RESTART': '1', 03:47:48 INFO - 'PAGER': '/bin/cat', 03:47:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:48 INFO - 'PWD': '/builds/slave/test', 03:47:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:48 INFO - 'SHELL': '/bin/bash', 03:47:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:47:48 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:47:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:48 INFO - 'USER': 'cltbld', 03:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:48 INFO - 'XPC_FLAGS': '0x0', 03:47:48 INFO - 'XPC_SERVICE_NAME': '0', 03:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:47:51 INFO - Installing collected packages: mozsystemmonitor 03:47:51 INFO - Running setup.py install for mozsystemmonitor 03:47:51 INFO - Successfully installed mozsystemmonitor 03:47:51 INFO - Cleaning up... 03:47:51 INFO - Return code: 0 03:47:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:51 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:51 INFO - 'HOME': '/Users/cltbld', 03:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:51 INFO - 'LOGNAME': 'cltbld', 03:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:51 INFO - 'MOZ_NO_REMOTE': '1', 03:47:51 INFO - 'NO_EM_RESTART': '1', 03:47:51 INFO - 'PAGER': '/bin/cat', 03:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:51 INFO - 'PWD': '/builds/slave/test', 03:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:51 INFO - 'SHELL': '/bin/bash', 03:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:47:51 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:51 INFO - 'USER': 'cltbld', 03:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:51 INFO - 'XPC_FLAGS': '0x0', 03:47:51 INFO - 'XPC_SERVICE_NAME': '0', 03:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:54 INFO - warning: no files found matching '*.txt' 03:47:54 INFO - no previously-included directories found matching 'build' 03:47:54 INFO - no previously-included directories found matching 'dist' 03:47:54 INFO - no previously-included directories found matching '.git*' 03:47:54 INFO - Installing collected packages: jsonschema, functools32 03:47:54 INFO - Running setup.py install for functools32 03:47:54 INFO - warning: no files found matching '*.txt' 03:47:54 INFO - no previously-included directories found matching 'build' 03:47:54 INFO - no previously-included directories found matching 'dist' 03:47:54 INFO - no previously-included directories found matching '.git*' 03:47:54 INFO - Successfully installed jsonschema functools32 03:47:54 INFO - Cleaning up... 03:47:55 INFO - Return code: 0 03:47:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:55 INFO - 'HOME': '/Users/cltbld', 03:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:55 INFO - 'LOGNAME': 'cltbld', 03:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:55 INFO - 'MOZ_NO_REMOTE': '1', 03:47:55 INFO - 'NO_EM_RESTART': '1', 03:47:55 INFO - 'PAGER': '/bin/cat', 03:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:55 INFO - 'PWD': '/builds/slave/test', 03:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:55 INFO - 'SHELL': '/bin/bash', 03:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:47:55 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:55 INFO - 'USER': 'cltbld', 03:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:55 INFO - 'XPC_FLAGS': '0x0', 03:47:55 INFO - 'XPC_SERVICE_NAME': '0', 03:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:47:55 INFO - Cleaning up... 03:47:55 INFO - Return code: 0 03:47:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:55 INFO - 'HOME': '/Users/cltbld', 03:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:55 INFO - 'LOGNAME': 'cltbld', 03:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:55 INFO - 'MOZ_NO_REMOTE': '1', 03:47:55 INFO - 'NO_EM_RESTART': '1', 03:47:55 INFO - 'PAGER': '/bin/cat', 03:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:55 INFO - 'PWD': '/builds/slave/test', 03:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:55 INFO - 'SHELL': '/bin/bash', 03:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:47:55 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:55 INFO - 'USER': 'cltbld', 03:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:55 INFO - 'XPC_FLAGS': '0x0', 03:47:55 INFO - 'XPC_SERVICE_NAME': '0', 03:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:47:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:59 INFO - Downloading docopt-0.6.1.tar.gz 03:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:59 INFO - Running setup.py install for blobuploader 03:47:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:47:59 INFO - Running setup.py install for requests 03:48:00 INFO - Running setup.py install for docopt 03:48:00 INFO - Successfully installed blobuploader requests docopt 03:48:00 INFO - Cleaning up... 03:48:00 INFO - Return code: 0 03:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:00 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:00 INFO - 'HOME': '/Users/cltbld', 03:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:00 INFO - 'LOGNAME': 'cltbld', 03:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:00 INFO - 'MOZ_NO_REMOTE': '1', 03:48:00 INFO - 'NO_EM_RESTART': '1', 03:48:00 INFO - 'PAGER': '/bin/cat', 03:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:00 INFO - 'PWD': '/builds/slave/test', 03:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:00 INFO - 'SHELL': '/bin/bash', 03:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:48:00 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:00 INFO - 'USER': 'cltbld', 03:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:00 INFO - 'XPC_FLAGS': '0x0', 03:48:00 INFO - 'XPC_SERVICE_NAME': '0', 03:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-cZ5V1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-H4zXwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-57b6XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-r5EdhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-svVEHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-PbRdGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-OZ3WC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-k8S2h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-JN63ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-1YikPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-CBGxpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-qzTRGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-NIe13n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-t9EwIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-oqXlo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-MvudEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-qIlhC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:02 INFO - Running setup.py install for manifestparser 03:48:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:02 INFO - Running setup.py install for mozcrash 03:48:02 INFO - Running setup.py install for mozdebug 03:48:02 INFO - Running setup.py install for mozdevice 03:48:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:48:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:02 INFO - Running setup.py install for mozfile 03:48:03 INFO - Running setup.py install for mozhttpd 03:48:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozinfo 03:48:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozInstall 03:48:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozleak 03:48:03 INFO - Running setup.py install for mozlog 03:48:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for moznetwork 03:48:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozprocess 03:48:04 INFO - Running setup.py install for mozprofile 03:48:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:04 INFO - Running setup.py install for mozrunner 03:48:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:04 INFO - Running setup.py install for mozscreenshot 03:48:04 INFO - Running setup.py install for moztest 03:48:04 INFO - Running setup.py install for mozversion 03:48:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:04 INFO - Cleaning up... 03:48:04 INFO - Return code: 0 03:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:04 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:04 INFO - 'HOME': '/Users/cltbld', 03:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:04 INFO - 'LOGNAME': 'cltbld', 03:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:04 INFO - 'MOZ_NO_REMOTE': '1', 03:48:04 INFO - 'NO_EM_RESTART': '1', 03:48:04 INFO - 'PAGER': '/bin/cat', 03:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:04 INFO - 'PWD': '/builds/slave/test', 03:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:04 INFO - 'SHELL': '/bin/bash', 03:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:48:04 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:04 INFO - 'USER': 'cltbld', 03:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:04 INFO - 'XPC_FLAGS': '0x0', 03:48:04 INFO - 'XPC_SERVICE_NAME': '0', 03:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-j_fFF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-kSliWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-IRnYBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-p1NlG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-m1oVP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-qQMGAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-o5qOFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:05 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-zFD5aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-VP5WSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Y7cuz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-8zpFVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-MVNU92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-6UaY3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-pLYo1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-2zR6Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-eoYmr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-y6c7Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:09 INFO - Downloading blessings-1.6.tar.gz 03:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:09 INFO - Installing collected packages: blessings 03:48:09 INFO - Running setup.py install for blessings 03:48:09 INFO - Successfully installed blessings 03:48:09 INFO - Cleaning up... 03:48:09 INFO - Return code: 0 03:48:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:10 INFO - Reading from file tmpfile_stdout 03:48:10 INFO - Current package versions: 03:48:10 INFO - blessings == 1.6 03:48:10 INFO - blobuploader == 1.2.4 03:48:10 INFO - docopt == 0.6.1 03:48:10 INFO - functools32 == 3.2.3-2 03:48:10 INFO - jsonschema == 2.5.1 03:48:10 INFO - manifestparser == 1.1 03:48:10 INFO - mozInstall == 1.12 03:48:10 INFO - mozcrash == 0.17 03:48:10 INFO - mozdebug == 0.1 03:48:10 INFO - mozdevice == 0.48 03:48:10 INFO - mozfile == 1.2 03:48:10 INFO - mozhttpd == 0.7 03:48:10 INFO - mozinfo == 0.9 03:48:10 INFO - mozleak == 0.1 03:48:10 INFO - mozlog == 3.4 03:48:10 INFO - moznetwork == 0.27 03:48:10 INFO - mozprocess == 0.23 03:48:10 INFO - mozprofile == 0.28 03:48:10 INFO - mozrunner == 6.12 03:48:10 INFO - mozscreenshot == 0.1 03:48:10 INFO - mozsystemmonitor == 0.3 03:48:10 INFO - moztest == 0.7 03:48:10 INFO - mozversion == 1.4 03:48:10 INFO - psutil == 3.1.1 03:48:10 INFO - requests == 1.2.3 03:48:10 INFO - wsgiref == 0.1.2 03:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 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 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:10 INFO - 'HOME': '/Users/cltbld', 03:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:10 INFO - 'LOGNAME': 'cltbld', 03:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:10 INFO - 'MOZ_NO_REMOTE': '1', 03:48:10 INFO - 'NO_EM_RESTART': '1', 03:48:10 INFO - 'PAGER': '/bin/cat', 03:48:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:10 INFO - 'PWD': '/builds/slave/test', 03:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:10 INFO - 'SHELL': '/bin/bash', 03:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:48:10 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:10 INFO - 'USER': 'cltbld', 03:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:10 INFO - 'XPC_FLAGS': '0x0', 03:48:10 INFO - 'XPC_SERVICE_NAME': '0', 03:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:48:10 INFO - Cleaning up... 03:48:10 INFO - Return code: 0 03:48:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106543490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98bd66d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, '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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:10 INFO - 'HOME': '/Users/cltbld', 03:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:10 INFO - 'LOGNAME': 'cltbld', 03:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:10 INFO - 'MOZ_NO_REMOTE': '1', 03:48:10 INFO - 'NO_EM_RESTART': '1', 03:48:10 INFO - 'PAGER': '/bin/cat', 03:48:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:10 INFO - 'PWD': '/builds/slave/test', 03:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:10 INFO - 'SHELL': '/bin/bash', 03:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:48:10 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:10 INFO - 'USER': 'cltbld', 03:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:10 INFO - 'XPC_FLAGS': '0x0', 03:48:10 INFO - 'XPC_SERVICE_NAME': '0', 03:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:48:11 INFO - Cleaning up... 03:48:11 INFO - Return code: 0 03:48:11 INFO - Running post-action listener: _resource_record_post_action 03:48:11 INFO - Running post-action listener: _start_resource_monitoring 03:48:11 INFO - Starting resource monitoring. 03:48:11 INFO - [mozharness: 2016-11-04 10:48:11.153777Z] Finished create-virtualenv step (success) 03:48:11 INFO - [mozharness: 2016-11-04 10:48:11.154728Z] Running install step. 03:48:11 INFO - Running pre-action listener: _resource_record_pre_action 03:48:11 INFO - Running main action method: install 03:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:11 INFO - Reading from file tmpfile_stdout 03:48:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:11 INFO - Reading from file tmpfile_stdout 03:48:11 INFO - Output received: 03:48:11 INFO - Usage: mozinstall [options] installer 03:48:11 INFO - Options: 03:48:11 INFO - -h, --help show this help message and exit 03:48:11 INFO - -d DEST, --destination=DEST 03:48:11 INFO - Directory to install application into. [default: 03:48:11 INFO - "/builds/slave/test"] 03:48:11 INFO - --app=APP Application being installed. [default: firefox] 03:48:11 INFO - mkdir: /builds/slave/test/build/application 03:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:48:44 INFO - Reading from file tmpfile_stdout 03:48:44 INFO - Output received: 03:48:44 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:48:44 INFO - Running post-action listener: _resource_record_post_action 03:48:44 INFO - [mozharness: 2016-11-04 10:48:44.110319Z] Finished install step (success) 03:48:44 INFO - [mozharness: 2016-11-04 10:48:44.110453Z] Running run-tests step. 03:48:44 INFO - Running pre-action listener: _resource_record_pre_action 03:48:44 INFO - Running main action method: run_tests 03:48:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:48:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:48:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:48:44 INFO - 2016-11-04 03:48:44.124 screenresolution[1638:7586] starting screenresolution argv=screenresolution get 03:48:44 INFO - 2016-11-04 03:48:44.127 screenresolution[1638:7586] Display 0: 1600x1200x32@60 03:48:44 INFO - 2016-11-04 03:48:44.133 screenresolution[1639:7588] starting screenresolution argv=screenresolution list 03:48:44 INFO - Available Modes on Display 0 03:48:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:48:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:48:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:48:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:48:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:48:44 INFO - Intel Iris: 03:48:44 INFO - Chipset Model: Intel Iris 03:48:44 INFO - Type: GPU 03:48:44 INFO - Bus: Built-In 03:48:44 INFO - VRAM (Dynamic, Max): 1536 MB 03:48:44 INFO - Vendor: Intel (0x8086) 03:48:44 INFO - Device ID: 0x0a2e 03:48:44 INFO - Revision ID: 0x0009 03:48:44 INFO - Displays: 03:48:44 INFO - Display: 03:48:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:48:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:48:44 INFO - Display Serial Number: 1600x1200 60 03:48:44 INFO - Main Display: Yes 03:48:44 INFO - Mirror: Off 03:48:44 INFO - Online: Yes 03:48:44 INFO - Rotation: Supported 03:48:44 INFO - Return code: 0 03:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:44 INFO - Python 2.7.3 03:48:44 INFO - Return code: 0 03:48:44 INFO - grabbing minidump binary from tooltool 03:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:44 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 0x106357d30>, '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 0x1061bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:48:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:48:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:48:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:44 INFO - Return code: 0 03:48:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:48:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:48:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:44 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/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:48:44 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/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F88bWLCzFe/Render', 03:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:44 INFO - 'HOME': '/Users/cltbld', 03:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:44 INFO - 'LOGNAME': 'cltbld', 03:48:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:44 INFO - 'MOZ_NO_REMOTE': '1', 03:48:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:44 INFO - 'NO_EM_RESTART': '1', 03:48:44 INFO - 'PAGER': '/bin/cat', 03:48:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:44 INFO - 'PWD': '/builds/slave/test', 03:48:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:44 INFO - 'SHELL': '/bin/bash', 03:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jm4IxY8TGH/Listeners', 03:48:44 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 03:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:44 INFO - 'USER': 'cltbld', 03:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:44 INFO - 'XPC_FLAGS': '0x0', 03:48:44 INFO - 'XPC_SERVICE_NAME': '0', 03:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:44 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/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:48:44 INFO - mozversion application_buildid: 20161104004016 03:48:44 INFO - mozversion application_changeset: ffae4aede5a1ed6c8374af2b443b701714576119 03:48:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:48:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:44 INFO - mozversion application_name: Firefox 03:48:44 INFO - mozversion application_remotingname: firefox-dev 03:48:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:48:44 INFO - mozversion application_vendor: Mozilla 03:48:44 INFO - mozversion application_version: 51.0a2 03:48:44 INFO - mozversion platform_buildid: 20161104004016 03:48:44 INFO - mozversion platform_changeset: ffae4aede5a1ed6c8374af2b443b701714576119 03:48:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:48:44 INFO - mozversion platform_version: 51.0a2 03:48:44 INFO - using testdate: 1478256524 03:48:44 INFO - actual date: 1478256524 03:48:44 INFO - starting webserver on 'localhost:49266' 03:48:44 INFO - SUITE-START | Running 2 tests 03:48:44 INFO - TEST-START | dromaeo_css 03:48:44 INFO - operating with platform_type : mac_ 03:48:44 INFO - Initialising browser for dromaeo_css test... 03:48:44 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpa5IVek/profile http://localhost:49266/getInfo.html) 03:48:47 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 03:48:47 INFO - PROCESS | 1649 | colorDepth:24 03:48:47 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 03:48:47 INFO - PROCESS | 1649 | __metrics 03:48:47 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:48:47 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:48:48 INFO - TEST-INFO | 1649: exit 0 03:48:48 INFO - Browser initialized. 03:48:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:48 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpa5IVek/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:00 INFO - PROCESS | 1652 | RSS: Main: 219926528 03:49:00 INFO - PROCESS | 1652 | 03:49:51 INFO - PROCESS | 1652 | 1478256591350 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:52:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 03:52:04 INFO - PROCESS | 1652 | RSS: Main: 370765824 03:52:04 INFO - PROCESS | 1652 | 03:55:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 03:55:08 INFO - PROCESS | 1652 | RSS: Main: 353112064 03:55:08 INFO - PROCESS | 1652 | 03:58:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 03:58:11 INFO - PROCESS | 1652 | RSS: Main: 328069120 03:58:11 INFO - PROCESS | 1652 | 04:01:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 04:01:14 INFO - PROCESS | 1652 | RSS: Main: 318828544 04:01:14 INFO - PROCESS | 1652 | 04:04:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 04:04:18 INFO - PROCESS | 1652 | RSS: Main: 312782848 04:04:18 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 04:07:21 INFO - PROCESS | 1652 | RSS: Main: 370196480 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | __start_tp_report 04:07:21 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 04:07:21 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 04:07:21 INFO - PROCESS | 1652 | |i|pagename|runs| 04:07:21 INFO - PROCESS | 1652 | |0;dojo.html;3040.7415369693576;3307.1897385140646;3325.2185736351967;3346.4143774839413;3354.7483938704604;5666.546676265899;5705.77176912923;5724.313082430104;5747.626404283724;5760.913586296204;5662.6036177467595;5672.064109421951;5763.682997435139;5769.076947688371;5773.249477567911;5199.298094757216;5217.869553261161;5225.529702326789;5233.267342572043;5293.682379057269;5194.71429071401;5198;5299.867503312409;5326.707031113307;5348.759305831247;5206.349206349207;5246.108161612535;5260.447652996438;5272.815451459181;5287.709175995319;5249.842504724865;5303.54152608032;5307.548858347045;5308.522232999048;5325.041492531343;5171.482851714836;5230.947690523122;5252.107141785906;5257.447967963347;5283.577313814885;4796.808127674889;5606.971965140148;5649.604527683064;5674.687892165929;5684.232628595169;6150.077488376734;6199.907001394983;6238.1266622672865;6244.469220116295;6255.655938923357;5255.76349064293;6317.05244213367;6319.684015799237;6327.082573026932;6359.618422894641;5690.40250773667;5715.514181294637;5726.570507211975;5755.107958266475;5852.941470585282;5338;6275.090111933835;6361.4592759615025;6361.745530178833;6368.808935731936;6017.819465416044;6069.998450255658;6072.908906366408;6105.633661980295;6113.205283313141;5117.590592752571;6112.989854784112;6172.969135154295;6236.095766113979;6238.438540531374;6181.81454556364;6237.625742455467;6238.625682459067;6246.4378205960775;6286.811395658137;6209.658468784261;6235.812925612239;6285.937140628535;6295.18162638854;6301.905471417932;4848;4913.410390753133;4918.5573298403315;4941.25881117828;4944.9258261126115;4401;4453.087117140978;4485.484169320504;4490.371348011281;4531.614812740954;5813.7383817728305;5814.098814683731;5833.766649333979;5841.620294680833;5851.502622277154;6314.810555683337;6323.177986861679;6341.048842673636;6350.7777227796805;6354.142190804182;5639.915401268984;5645.040343141676;5716.542676585863;5746.454086861741;5808.448197421323;5410.97294513525;5417.241586177938;5419.566434685215;5442.619016668795;5446.400895901447;6293.811185664437;6306.432421082125;6306.432421082125;6307.873842523124;6310.305866354697;6119.8470038247615;6123.2652081750475;6260.593061450991;6331.9366806331345;6336.017917222838;6152.046432802923;6155.692215389302;6198.597091189239;6259.092431597302;6288.339724328879;4585.679002469795;6209.5032397409;6236.656983865931;6242.907491189115;6246.6876656167915;5869.882602348014;5972.492338151305;6144.754209831557;6275.874482510416;6345.746170153142;5978.103284507359;5981;6018.157457955802;6037.939620603738;6068.7269072892705;6057.242844644419;6071.51427885777;6089.604175728564;6089.634621922699;6101.206843110367;5867.618604790675;5878.706064696663;5882.970585147047;5886.293644762484;5887.087501437284;5926.318473375617;6063.363346848518;6070.605410648293;6103.725332359965;6141.477974372228;5373.247745315737;5527.5577953762795;5989.880202396015;6033.396660333931;6044.637321760709 04:07:21 INFO - PROCESS | 1652 | |1;ext.html;521.5436493068565;522.8144008876847;529.3489008519523;537.545773821121;556.9612672366038;29963.1011069668;31297.68702312976;32116.51825222618;32125.19687007826;32162.67837321632;32627.83686081572;33213.83393083031;41150.382744258786;42249.15501689964;42365.94085147873;9575.090366415197;9690.27322950778;9713.174380177694;9735.513224338754;9743.902560974406;9568.234541236685;9652.517374131301;9661;9665.226781857435;9666.081722236411;9642.951785241099;9706.174975127122;9718.173955213815;9718.65984690536;9740.561674724619;9611.855822162674;9665.420074795464;9684.56419461126;9700.805983880284;9705.175060119898;9615.567299471471;9663.806723865484;9682.080202380763;9702.320837541374;9702.757431064209;39673.20653586912;39895.60365387198;40085.79957100196;40087.19825603501;40285.39571906424;3218.4850423932294;3427.5715535558056;3761.4545890845948;3958.44581758554;3968.8809335719975;24617.876910615334;28828.567571486234;29288.853555732087;30349.089527314216;30813.229669258224;2959.1270575180374;2970.732634062923;3154.1956801015594;3161.9051428457183;3218.4045951499047;507014.99999999633;508695;508874;509907.9999999963;510167;56292;56714.7164264176;56730.99999999918;56737;56759.71620141873;59444.70277648671;59796;59800.40199597948;59904;59940.70029649824;16134.596635083983;16330;16361.754573681405;16384.0169589825;16391.91804040972;12904.290264035568;12968.546100886424;12983.221006739626;12990.220586764824;13001.349932503337;13455.86544134546;15220.238988050774;15236.923815381075;15242.466513671969;15416.383344666312;6677.76627818024;6831;6861.519693621399;6872.41584465316;6899.517033807686;735.5880706804206;761.2501685839444;806.3267171911402;827.995860020696;1011.5599714124379;28485;29645;29830;30140.54789178164;30141.397172056437;933.6358820060182;1047.8271085270997;1059.6026490066224;1099.0328510910347;1154.630518234174;14514.129152250687;14698.706025879423;15084.547463576111;15213.91304347826;15462;657115;660894;663869;664353;666504;55349.72325138429;55526.611834704454;55667.16499252515;55798.72100639552;55872.72063639656;1347.2926713475308;1377.4283672275894;1389.3192335755407;1391.5338361648758;1400.404827948118;26481.735182647928;26790.330241744112;28896.42207155803;29120.41759164847;29535.113946581638;47348.7632561835;47653.76173119112;47697.569072927865;47744.28383574318;47910.041799164515;609495;613413.9329303325;615221;616049;616146;25606.487870242865;26396.8680156598;38474.84575462741;38854.222915542094;38859.80570097244;46477.767611161726;46687.53312466832;46975.765121175544;47332.52667473281;47710.284345734144;33495.49756753602;37652.05869853275;37970.62029379671;38517.807410963884;38623.42064869085;37471.62528374681;38121;38596.80701596474;38726.41910371403;38747.806260968515;37108;37447.625523745504;37520.2495950074;37562.81218593999;37834.43248351222;32029.839850800596;33680.83159584186;34073.31853362869;34136.82931585426;34356.65643343634;24382.390440239134;24830.503389932463;25140.86866090994;25152;25299.747002530476 04:07:21 INFO - PROCESS | 1652 | |2;jquery.html;323.27586206896547;350.9894703158903;375.48933450507315;379.9012256813228;408.1673386291965;14875.851241487582;15534;15818.288177032033;19722.605547889034;20131.698024529644;19567.60864782707;19613.607727845436;20783;21027.264045758402;21234.57530849386;5739.770409183628;5872.265966754156;6007.4593286604195;6011.128386383972;6016.037434010559;4902.607791376681;6603.910354791454;6697.363750443725;6749.730010799587;6778.457723382117;5131.358580177478;5883.941160588403;6654.933450665504;6689.598624082546;6722.1261236039245;6220.098085777559;6246.094316324107;6246.843828904268;6251.531135164881;6259.0298503731765;5859.8535036624;6016.909746353808;6102.206713127265;6106.084087386883;6109.114178444145;13184.670383240496;13423.328833558284;13684.452621895112;23049.539009219723;25232.87383563089;2349.319265314663;2614.6993095794037;2723.931901702473;2749.3264150283308;3010.0518336723862;9768.169705575036;10044.447555384451;10168.44073575953;10181.236407269484;10328.741781455448;1770.1149425287356;1789.5347209725564;1853.7960824309316;1860.479065861561;1866.5426970392205;121942.17086743706;123775;126539;127335.99999999907;128581.35709321487;10248.795024099476;11583.710407239887;11640.534378624929;11709.765804683859;11857.466414011391;14720.705585888223;14722.852771472362;14730.189839558712;14753.704925901422;14767.04014239071;8487.193716596914;8500.362472814564;8603.913960860436;8605.612747426381;8712.259457946018;6823.420009299166;6981.2669669684965;8492.320614350838;8572.657093716307;8630.956845215735;4526.7510286933875;4530.320451932236;4535.501094879561;4537.727736335831;4604.424446944132;1870.5136664467063;1899.6010837723957;1910.646530391882;1920.8559358048203;1929.9035048247813;880.6873559886276;911.0980129671577;974.6198982396871;982.7199248214224;998.2213873178932;17744.46766597004;19554.217831286875;21076.156953721988;21091.367258982256;21207.15171393158;910.5674804467825;910.7677542226689;951.690700522333;954.9809003819885;1013.3869009249445;10432.5826966922;10904.34573925567;11125;11139.72150696239;11173.776524469627;604920.9507904864;612624;620071;627348;630800;129208;133768;135237;141461;145328;970.6360114956891;979.314479864098;994.9403035817729;995.835687111633;997.4364484066624;17420.73868891993;18100.637987240443;18690.252389904796;18701.906490468005;18792.624147517246;55655.44344556665;55821;57020.144697830394;57416.71291643515;57958;81538.18461815306;83115.5844220775;83677.58161209156;85342.57328713317;86480;7767.728129515666;8094.583447896477;8146.5519396433765;8323.916760832315;8346.165383461605;10361.378317300987;12947.287899165636;12969.610911672666;13062.34688265602;13349.466021359036;11058.723531911766;11191.944040279746;11401.372924489233;11553.942230288794;11583.710407239549;10115.342502737592;10414.687559373231;10692.786144277226;11189.496472658913;11418.029467495357;11294.717632059264;11386.658400248005;11427.657170284905;11441.027512661183;11817.468213930222;7163.892541611775;7437.293457121565;7607.847843043219;7753.961230193813;8258.669653213805;10064.597416103567;11229.989300962952;11231.4384280784;11735.23720958135;11789.587364442203 04:07:21 INFO - PROCESS | 1652 | |3;mootools.html;1344.5092541222446;1503.0831192972284;1527.289810238239;1705.6247625522387;1875.5311172206948;7744.26429489199;8231.135730748267;8523.531205783687;8834;8849.115088491148;8650.005249396321;8753.993290771563;8754.737357879274;8758.86861697075;8761.868571971425;2375.572396968545;2402.615581506959;2405.1101092595763;2409.168836751318;2410.3974006498374;2337.859728416292;2343.5195784864145;2349.142562964514;2365.6451532270125;2387;2363.1847012780563;2381.940451488709;2397.5324811661735;2398.4123889646976;2402.5555272274687;2041.652919003773;2368.8460250083776;2378.2984019714227;2379.7739214774656;2383.3803211165223;2317.9072837086665;2342.0982921575146;2343.6367363058753;2346.1084787780533;2348.894299756515;8656.437331573428;8728.083551227093;8738.650453981832;8847.424917380415;8876.822463550692;5216.087184742655;5425.972870135624;5426;5429.945700543023;5432.13085906257;3437.9312413751586;3477.3914564951033;3537.1510837399096;3545.18460754028;3546.4325707886874;1032.1072272484248;1057.228223396917;1722.2938595175917;1773.9911300443543;1831.9358822441284;11646.59236926712;11752.059835213247;11754.823677644843;11763.941180294043;11799.233049851819;4503.369528266046;4534.183846907522;4638.652101092432;4690.108879312919;4691.55430234134;9171.44971301724;9177.219936305355;9183.494907780003;9184.21934135606;9189.218916392048;5262.578993680497;5262.71055091966;5264.0261551613075;5264.473552644705;5267.499587539178;4116.711830171859;4400.44994375703;4557.1797076526545;4919.458859525449;4925.655204135748;3811.923761524754;3821.312163810541;3853.9036524087123;3910.569837317893;3928.4107383892647;1148.7530181011123;1159.3913195572222;1159.4260840883817;1171.619223752284;1173.4484792147678;765.5291995422775;839.3075712537182;851.9574021299035;926.8424367857481;933.7712260496222;5665;5673.262475878192;5836.095405212199;6025.879482410327;6186.81439556814;428.4173524007347;432.1033854751403;455.6969615205851;457.86492984569634;458.1524180266547;3686.746506187909;3765.736398452082;3980.5621381647998;4108.548059713429;4114.814833332507;10356.533955971849;10670.413127278074;10683.14534837211;10813.18901082422;10831.458427078614;10619.256652034283;10630.787384252271;10739.248252622241;10776.29954052984;10806.675799725863;7907.130215676271;8145.389095817837;8278.503289802631;8307.709230177035;8347.457415267989;5685.459881311269;5755.223044889054;5827.155062515827;5911.261092363455;5921.111833224878;9862.457564834003;9874.111329980049;10025.398476091457;10038.347507412287;10088.041636044563;9414.435133891988;9713.854292185482;9770.75573110678;10026.398416095057;10146.695599132037;6869.793906182623;7046.859062818612;7080.504364694422;7093.113360829896;7150.785476435715;8195.303399211134;8239.340852731886;8330.166983301622;8335.624896879533;8352.248297653241;7092.822679433056;7179.641017949186;7228.421726261781;7337.633118344168;7358.595277259802;6334.873302534015;7449.776506704808;7450.850982980419;7463.664135113824;7484;6941.861162776817;6964.721411143498;6987.6855541499735;7049.330313620198;7061.858762824818;4925.482824303396;4932.753362331798;4981.452040275639;5001.624878134082;5064.620153488577;4926.3349447824085;5016.372953380827;5052.8989420210655;5104.795808167781;5182.455842136521 04:07:21 INFO - PROCESS | 1652 | |4;prototype.html;298.8207075754547;303.2797106871181;307.9030105516763;313.4342511766261;314.64445176950045;4348.347747837822;5137.922931156031;5188.896222075561;5219.112750832358;5238.240455134003;5080.466551012146;5131.435542090377;5171.896562068766;5217;5259.8422047338545;3265.8693652253883;3281.7210537104374;3500.842462089199;3724.5344331958504;3761.4357846322996;3575.284943011395;3647.379945409287;3935.5867633898456;3937.8621748238816;4040;3299.7525185611057;3929.9214015719667;3988.880333589997;4019.5176578810583;4044.3933409988445;3003.717174947034;3284.1132894118573;3626.492291079251;3857.710671699606;3974.2448934702315;3464.4456886897974;3502.9474557881654;3524.7356448266482;3539.8938031859084;3550.5739311282555;4970.776315065831;5040.495950404967;5058.054717320496;5067.746612669352;5079.87300317495;4337.395163789387;4573.63410927125;4576.496585375606;4603.861884143481;4610.515895830957;4062.5531191568903;4865.7692980046595;4989.825356112555;5056.74716264189;5272.340957380327;3102.7672924530752;3803.2393521295853;3864.478295430109;3870.0069464225944;3890.1636148228267;5651.547876169855;5684.374718780972;5684.658920464785;5694.829155125353;5712.400197979236;3452.085197422685;3474.253035597308;3503.2993401319327;3693.8337774800198;3780.5085338905765;3437.759356845047;3830.7893065881085;3835.6931445484292;3847.941351377;3857.6913846892744;3761.9059523512133;4313.245182093184;4438.334249862546;4451.821927122944;4486.730796152241;5190.37715474138;5487.780488780404;5515.4760297771645;5547.805826796042;5553.72264379187;1138.5047504335641;1310.8754668306497;1312.1760752553957;1315.4409376015346;1316.367704046975;697.7231666051114;749.6027105634023;767.8146248066919;782.4327362662139;797.2943944609062;4629.976850115728;5115.130427827278;5117.923231151536;5130.563902068291;5133.050385678586;5327.866803329948;5496.120620700669;5517.2551705519245;5562.694051827108;5704.629199102045;5029.183657152006;5186.299849520266;5197.58419326453;5209.8639557781125;5216.7913283469;2441.7802397784285;2935.427591619614;2971.870689138114;2976.7618590512707;3013.5329024000876;5511.669299842022;5872.324682661549;5887.558433117533;5898.262717160355;5910.615809972338;5026.52248036436;5497.697626630574;5735.369109397963;5746.13807928814;5767.423257674283;5077.8730531737;5755.776765011607;5758.740856661377;5787.826365209051;5792.420757924258;4762.666613337033;4970.353853998957;5452.700101494456;5625.521830644441;5677.687727175045;5349.893002140013;5636.2954630671165;5636.689982051026;5644.915326270027;5661.745221464962;4658.99663144851;5873.765049398147;5904.61619994699;5907.054871220584;5920.911186332122;3292.1769557610596;3628.5282913221113;3814.1691987845434;3816.828242729139;3836.7506112102624;4698.906021879611;5042.9409823937385;5627.00241414292;5659.26429564154;5716.056850619601;5216.843494695166;5466.535344495604;5488.588355873246;5509.705219273547;5528.889422211614;5293.311869456946;5476.3702174250475;5481.917771233355;5513.669179849222;5520.227168196376;5387.703676297841;5420.620556561003;5420.620556561003;5427.3215848019;5434.619576629756;5259.737013149251;5454.509094181542;5477.972610137083;5483.725813709379;5542.418046105101;4934.484946274119;5186.703324168958;5297.390800058042;5372.785088596413;5463.48096930791 04:07:21 INFO - PROCESS | 1652 | |5;yui.html;706.6466766616688;738.468302821968;763.6563546404119;787.1577412168978;811.4279432999735;14866.47967321144;16045.598860028476;16051.598710032255;16091.275892584832;16112.597185070379;14347.56957291283;14537.273136343167;14568.417263309482;14602.488912888051;14619.707605847876;662.6322391072953;681.437813803614;684.8767221900056;685.9245482996866;807.055744778609;678.6945874356535;680.3298750730527;702.8242939265184;810.116972499975;835.4903508859591;886.6276164011099;887.8579427291635;891.6433426629335;891.7369376034086;891.8974317953421;881.1540920716056;881.7002219245423;881.9162179592928;883.231588517987;883.8099808541131;522.029026011618;538.5099559400966;539.0431983229798;541.301720780193;666.2870728320698;12447.190932589443;13904.096233744775;14434.350454229585;14471.78292325616;14747.55757327282;14106.153630782186;14482.637934051627;14518.92740536301;14535.927320363331;14545.200013999225;11436.142289328334;11657.242279251821;11895.762084758257;11906;11973.700657483632;3758.8684396046006;3832.540095188567;3845.3462911305146;3909.3745000799736;3927.9410808837893;109875.90124098737;113152.30271545933;115909;116965;117556;8952.418092823946;10433.478326083665;10841.945790271157;10851.674449766362;11194.384308862927;21272.893635531724;21413.357599272047;21554.353369398945;21555.814430206177;21689.67465488019;7887.290143887078;7934.246246606564;7936.246056624612;7961.562114083665;7973.0830954439825;4193.496780386373;4359.782010899442;4429.49060857999;4671.299305104261;4689.859304220879;3465.9826700866333;3588.1209103769743;3599.136207310227;3604.3692353837973;3607.206414588786;633.2369494758805;634.1027446163719;647.4755448087064;648.0700195219874;658.940695337422;591.899377105893;620.2835724737935;655.8817216645608;657.789507357641;677.4580335731396;8763.829340688897;9439.150476457151;9481.620735170654;9625.470599117116;9750.756231094138;617.9783707570214;647.2653538234044;659.8548319369731;660.8116686744255;690.6684791300204;4216.789160541961;4635.096156249499;5010.496572446194;5038.910700192759;5124.410692770304;77285.6135719329;130127;131610.34194828966;157687.21156394144;165995;118343.40828295803;130044.69955300515;133730.33134834265;136096;137449.62550374368;73578.63210684019;77427.61286193533;79528.87773517305;80356;80835.5958220205;8483.660653573788;9008.549572521479;9494.905050949403;9601.855972160563;10034.795824501107;67565.66217168883;67920.6603966977;68520;69057;70990;103823.4808825951;104361.47819261158;104751.4762426183;104904;107279;13164.60506184816;13431.395587198404;13914.373853176428;14029.508967186099;14047.648808779863;14083.084599501;14403.92798036045;14728.189949552878;15778.76331855046;15785.921070394574;13919;13984.720305593628;14102.36539355711;14653.780193297322;14671.193084380035;13584.728305433639;13682.863171368557;13862.86137138656;13979.161250325013;14462.85537144615;11206.271592346471;13400.128991615515;13414.530491432753;13503.054786164874;14124;11292.774144517229;11325;11567.652970410902;11892.345920974429;11991.700207494883;9913.355631883904;11465.31208127515;11520.193586448868;11589.304641721523;11750.412479375826 04:07:21 INFO - PROCESS | 1652 | __end_tp_report 04:07:21 INFO - PROCESS | 1652 | __start_cc_report 04:07:21 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1522 04:07:21 INFO - PROCESS | 1652 | __end_cc_report 04:07:21 INFO - PROCESS | 1652 | __startTimestamp1478257641594__endTimestamp 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | ------- Summary: start ------- 04:07:21 INFO - PROCESS | 1652 | Number of tests: 6 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5714.75 Median:5869.88 stddev:648.45 (11.0%) stddev-sans-first:615.58 04:07:21 INFO - PROCESS | 1652 | Values: 3040.7 3307.2 3325.2 3346.4 3354.7 5666.5 5705.8 5724.3 5747.6 5760.9 5662.6 5672.1 5763.7 5769.1 5773.2 5199.3 5217.9 5225.5 5233.3 5293.7 5194.7 5198.0 5299.9 5326.7 5348.8 5206.3 5246.1 5260.4 5272.8 5287.7 5249.8 5303.5 5307.5 5308.5 5325.0 5171.5 5230.9 5252.1 5257.4 5283.6 4796.8 5607.0 5649.6 5674.7 5684.2 6150.1 6199.9 6238.1 6244.5 6255.7 5255.8 6317.1 6319.7 6327.1 6359.6 5690.4 5715.5 5726.6 5755.1 5852.9 5338.0 6275.1 6361.5 6361.7 6368.8 6017.8 6070.0 6072.9 6105.6 6113.2 5117.6 6113.0 6173.0 6236.1 6238.4 6181.8 6237.6 6238.6 6246.4 6286.8 6209.7 6235.8 6285.9 6295.2 6301.9 4848.0 4913.4 4918.6 4941.3 4944.9 4401.0 4453.1 4485.5 4490.4 4531.6 5813.7 5814.1 5833.8 5841.6 5851.5 6314.8 6323.2 6341.0 6350.8 6354.1 5639.9 5645.0 5716.5 5746.5 5808.4 5411.0 5417.2 5419.6 5442.6 5446.4 6293.8 6306.4 6306.4 6307.9 6310.3 6119.8 6123.3 6260.6 6331.9 6336.0 6152.0 6155.7 6198.6 6259.1 6288.3 4585.7 6209.5 6236.7 6242.9 6246.7 5869.9 5972.5 6144.8 6275.9 6345.7 5978.1 5981.0 6018.2 6037.9 6068.7 6057.2 6071.5 6089.6 6089.6 6101.2 5867.6 5878.7 5883.0 5886.3 5887.1 5926.3 6063.4 6070.6 6103.7 6141.5 5373.2 5527.6 5989.9 6033.4 6044.6 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:71641.15 Median:21815.83 stddev:160296.41 (734.8%) stddev-sans-first:160657.14 04:07:21 INFO - PROCESS | 1652 | Values: 521.5 522.8 529.3 537.5 557.0 29963.1 31297.7 32116.5 32125.2 32162.7 32627.8 33213.8 41150.4 42249.2 42365.9 9575.1 9690.3 9713.2 9735.5 9743.9 9568.2 9652.5 9661.0 9665.2 9666.1 9643.0 9706.2 9718.2 9718.7 9740.6 9611.9 9665.4 9684.6 9700.8 9705.2 9615.6 9663.8 9682.1 9702.3 9702.8 39673.2 39895.6 40085.8 40087.2 40285.4 3218.5 3427.6 3761.5 3958.4 3968.9 24617.9 28828.6 29288.9 30349.1 30813.2 2959.1 2970.7 3154.2 3161.9 3218.4 507015.0 508695.0 508874.0 509908.0 510167.0 56292.0 56714.7 56731.0 56737.0 56759.7 59444.7 59796.0 59800.4 59904.0 59940.7 16134.6 16330.0 16361.8 16384.0 16391.9 12904.3 12968.5 12983.2 12990.2 13001.3 13455.9 15220.2 15236.9 15242.5 15416.4 6677.8 6831.0 6861.5 6872.4 6899.5 735.6 761.3 806.3 828.0 1011.6 28485.0 29645.0 29830.0 30140.5 30141.4 933.6 1047.8 1059.6 1099.0 1154.6 14514.1 14698.7 15084.5 15213.9 15462.0 657115.0 660894.0 663869.0 664353.0 666504.0 55349.7 55526.6 55667.2 55798.7 55872.7 1347.3 1377.4 1389.3 1391.5 1400.4 26481.7 26790.3 28896.4 29120.4 29535.1 47348.8 47653.8 47697.6 47744.3 47910.0 609495.0 613413.9 615221.0 616049.0 616146.0 25606.5 26396.9 38474.8 38854.2 38859.8 46477.8 46687.5 46975.8 47332.5 47710.3 33495.5 37652.1 37970.6 38517.8 38623.4 37471.6 38121.0 38596.8 38726.4 38747.8 37108.0 37447.6 37520.2 37562.8 37834.4 32029.8 33680.8 34073.3 34136.8 34356.7 24382.4 24830.5 25140.9 25152.0 25299.7 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:36062.58 Median:13923.79 stddev:103706.22 (744.8%) stddev-sans-first:103962.43 04:07:21 INFO - PROCESS | 1652 | Values: 323.3 351.0 375.5 379.9 408.2 14875.9 15534.0 15818.3 19722.6 20131.7 19567.6 19613.6 20783.0 21027.3 21234.6 5739.8 5872.3 6007.5 6011.1 6016.0 4902.6 6603.9 6697.4 6749.7 6778.5 5131.4 5883.9 6654.9 6689.6 6722.1 6220.1 6246.1 6246.8 6251.5 6259.0 5859.9 6016.9 6102.2 6106.1 6109.1 13184.7 13423.3 13684.5 23049.5 25232.9 2349.3 2614.7 2723.9 2749.3 3010.1 9768.2 10044.4 10168.4 10181.2 10328.7 1770.1 1789.5 1853.8 1860.5 1866.5 121942.2 123775.0 126539.0 127336.0 128581.4 10248.8 11583.7 11640.5 11709.8 11857.5 14720.7 14722.9 14730.2 14753.7 14767.0 8487.2 8500.4 8603.9 8605.6 8712.3 6823.4 6981.3 8492.3 8572.7 8631.0 4526.8 4530.3 4535.5 4537.7 4604.4 1870.5 1899.6 1910.6 1920.9 1929.9 880.7 911.1 974.6 982.7 998.2 17744.5 19554.2 21076.2 21091.4 21207.2 910.6 910.8 951.7 955.0 1013.4 10432.6 10904.3 11125.0 11139.7 11173.8 604921.0 612624.0 620071.0 627348.0 630800.0 129208.0 133768.0 135237.0 141461.0 145328.0 970.6 979.3 994.9 995.8 997.4 17420.7 18100.6 18690.3 18701.9 18792.6 55655.4 55821.0 57020.1 57416.7 57958.0 81538.2 83115.6 83677.6 85342.6 86480.0 7767.7 8094.6 8146.6 8323.9 8346.2 10361.4 12947.3 12969.6 13062.3 13349.5 11058.7 11191.9 11401.4 11553.9 11583.7 10115.3 10414.7 10692.8 11189.5 11418.0 11294.7 11386.7 11427.7 11441.0 11817.5 7163.9 7437.3 7607.8 7754.0 8258.7 10064.6 11230.0 11231.4 11735.2 11789.6 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5646.84 Median:4926.00 stddev:3166.31 (64.3%) stddev-sans-first:3158.68 04:07:21 INFO - PROCESS | 1652 | Values: 1344.5 1503.1 1527.3 1705.6 1875.5 7744.3 8231.1 8523.5 8834.0 8849.1 8650.0 8754.0 8754.7 8758.9 8761.9 2375.6 2402.6 2405.1 2409.2 2410.4 2337.9 2343.5 2349.1 2365.6 2387.0 2363.2 2381.9 2397.5 2398.4 2402.6 2041.7 2368.8 2378.3 2379.8 2383.4 2317.9 2342.1 2343.6 2346.1 2348.9 8656.4 8728.1 8738.7 8847.4 8876.8 5216.1 5426.0 5426.0 5429.9 5432.1 3437.9 3477.4 3537.2 3545.2 3546.4 1032.1 1057.2 1722.3 1774.0 1831.9 11646.6 11752.1 11754.8 11763.9 11799.2 4503.4 4534.2 4638.7 4690.1 4691.6 9171.4 9177.2 9183.5 9184.2 9189.2 5262.6 5262.7 5264.0 5264.5 5267.5 4116.7 4400.4 4557.2 4919.5 4925.7 3811.9 3821.3 3853.9 3910.6 3928.4 1148.8 1159.4 1159.4 1171.6 1173.4 765.5 839.3 852.0 926.8 933.8 5665.0 5673.3 5836.1 6025.9 6186.8 428.4 432.1 455.7 457.9 458.2 3686.7 3765.7 3980.6 4108.5 4114.8 10356.5 10670.4 10683.1 10813.2 10831.5 10619.3 10630.8 10739.2 10776.3 10806.7 7907.1 8145.4 8278.5 8307.7 8347.5 5685.5 5755.2 5827.2 5911.3 5921.1 9862.5 9874.1 10025.4 10038.3 10088.0 9414.4 9713.9 9770.8 10026.4 10146.7 6869.8 7046.9 7080.5 7093.1 7150.8 8195.3 8239.3 8330.2 8335.6 8352.2 7092.8 7179.6 7228.4 7337.6 7358.6 6334.9 7449.8 7450.9 7463.7 7484.0 6941.9 6964.7 6987.7 7049.3 7061.9 4925.5 4932.8 4981.5 5001.6 5064.6 4926.3 5016.4 5052.9 5104.8 5182.5 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4441.13 Median:5097.80 stddev:1398.98 (27.4%) stddev-sans-first:1367.92 04:07:21 INFO - PROCESS | 1652 | Values: 298.8 303.3 307.9 313.4 314.6 4348.3 5137.9 5188.9 5219.1 5238.2 5080.5 5131.4 5171.9 5217.0 5259.8 3265.9 3281.7 3500.8 3724.5 3761.4 3575.3 3647.4 3935.6 3937.9 4040.0 3299.8 3929.9 3988.9 4019.5 4044.4 3003.7 3284.1 3626.5 3857.7 3974.2 3464.4 3502.9 3524.7 3539.9 3550.6 4970.8 5040.5 5058.1 5067.7 5079.9 4337.4 4573.6 4576.5 4603.9 4610.5 4062.6 4865.8 4989.8 5056.7 5272.3 3102.8 3803.2 3864.5 3870.0 3890.2 5651.5 5684.4 5684.7 5694.8 5712.4 3452.1 3474.3 3503.3 3693.8 3780.5 3437.8 3830.8 3835.7 3847.9 3857.7 3761.9 4313.2 4438.3 4451.8 4486.7 5190.4 5487.8 5515.5 5547.8 5553.7 1138.5 1310.9 1312.2 1315.4 1316.4 697.7 749.6 767.8 782.4 797.3 4630.0 5115.1 5117.9 5130.6 5133.1 5327.9 5496.1 5517.3 5562.7 5704.6 5029.2 5186.3 5197.6 5209.9 5216.8 2441.8 2935.4 2971.9 2976.8 3013.5 5511.7 5872.3 5887.6 5898.3 5910.6 5026.5 5497.7 5735.4 5746.1 5767.4 5077.9 5755.8 5758.7 5787.8 5792.4 4762.7 4970.4 5452.7 5625.5 5677.7 5349.9 5636.3 5636.7 5644.9 5661.7 4659.0 5873.8 5904.6 5907.1 5920.9 3292.2 3628.5 3814.2 3816.8 3836.8 4698.9 5042.9 5627.0 5659.3 5716.1 5216.8 5466.5 5488.6 5509.7 5528.9 5293.3 5476.4 5481.9 5513.7 5520.2 5387.7 5420.6 5420.6 5427.3 5434.6 5259.7 5454.5 5478.0 5483.7 5542.4 4934.5 5186.7 5297.4 5372.8 5463.5 04:07:21 INFO - PROCESS | 1652 | 04:07:21 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24327.29 Median:3601.75 stddev:38360.22 (1065.0%) stddev-sans-first:38426.83 04:07:21 INFO - PROCESS | 1652 | Values: 706.6 738.5 763.7 787.2 811.4 14866.5 16045.6 16051.6 16091.3 16112.6 14347.6 14537.3 14568.4 14602.5 14619.7 662.6 681.4 684.9 685.9 807.1 678.7 680.3 702.8 810.1 835.5 886.6 887.9 891.6 891.7 891.9 881.2 881.7 881.9 883.2 883.8 522.0 538.5 539.0 541.3 666.3 12447.2 13904.1 14434.4 14471.8 14747.6 14106.2 14482.6 14518.9 14535.9 14545.2 11436.1 11657.2 11895.8 11906.0 11973.7 3758.9 3832.5 3845.3 3909.4 3927.9 109875.9 113152.3 115909.0 116965.0 117556.0 8952.4 10433.5 10841.9 10851.7 11194.4 21272.9 21413.4 21554.4 21555.8 21689.7 7887.3 7934.2 7936.2 7961.6 7973.1 4193.5 4359.8 4429.5 4671.3 4689.9 3466.0 3588.1 3599.1 3604.4 3607.2 633.2 634.1 647.5 648.1 658.9 591.9 620.3 655.9 657.8 677.5 8763.8 9439.2 9481.6 9625.5 9750.8 618.0 647.3 659.9 660.8 690.7 4216.8 4635.1 5010.5 5038.9 5124.4 77285.6 130127.0 131610.3 157687.2 165995.0 118343.4 130044.7 133730.3 136096.0 137449.6 73578.6 77427.6 79528.9 80356.0 80835.6 8483.7 9008.5 9494.9 9601.9 10034.8 67565.7 67920.7 68520.0 69057.0 70990.0 103823.5 104361.5 104751.5 104904.0 107279.0 13164.6 13431.4 13914.4 14029.5 14047.6 14083.1 14403.9 14728.2 15778.8 15785.9 13919.0 13984.7 14102.4 14653.8 14671.2 13584.7 13682.9 13862.9 13979.2 14462.9 11206.3 13400.1 13414.5 13503.1 14124.0 11292.8 11325.0 11567.7 11892.3 11991.7 9913.4 11465.3 11520.2 11589.3 11750.4 04:07:21 INFO - PROCESS | 1652 | -------- Summary: end -------- 04:07:21 INFO - PROCESS | 1652 | 04:07:22 INFO - TEST-INFO | 1652: exit 0 04:07:22 INFO - TEST-OK | dromaeo_css | took 1117609ms 04:07:22 INFO - TEST-START | kraken 04:07:22 INFO - operating with platform_type : mac_ 04:07:22 INFO - Initialising browser for kraken test... 04:07:22 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpCeGPO6/profile http://localhost:49266/getInfo.html) 04:07:24 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 04:07:24 INFO - PROCESS | 1664 | colorDepth:24 04:07:24 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 04:07:24 INFO - PROCESS | 1664 | __metrics 04:07:24 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:07:24 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:25 INFO - TEST-INFO | 1664: exit 0 04:07:25 INFO - Browser initialized. 04:07:25 INFO - Running cycle 1/1 for kraken test... 04:07:25 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpCeGPO6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:37 INFO - PROCESS | 1666 | RSS: Main: 220024832 04:07:37 INFO - PROCESS | 1666 | 04:07:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:40 INFO - PROCESS | 1666 | RSS: Main: 269676544 04:07:40 INFO - PROCESS | 1666 | 04:07:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 04:07:44 INFO - PROCESS | 1666 | RSS: Main: 280244224 04:07:44 INFO - PROCESS | 1666 | 04:07:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 04:07:47 INFO - PROCESS | 1666 | RSS: Main: 377139200 04:07:47 INFO - PROCESS | 1666 | 04:07:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 04:07:50 INFO - PROCESS | 1666 | RSS: Main: 280559616 04:07:50 INFO - PROCESS | 1666 | 04:07:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:53 INFO - PROCESS | 1666 | RSS: Main: 281329664 04:07:53 INFO - PROCESS | 1666 | 04:07:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:56 INFO - PROCESS | 1666 | RSS: Main: 319737856 04:07:56 INFO - PROCESS | 1666 | 04:07:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:59 INFO - PROCESS | 1666 | RSS: Main: 319791104 04:07:59 INFO - PROCESS | 1666 | 04:08:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 04:08:03 INFO - PROCESS | 1666 | RSS: Main: 316571648 04:08:03 INFO - PROCESS | 1666 | 04:08:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:05 INFO - PROCESS | 1666 | RSS: Main: 291356672 04:08:05 INFO - PROCESS | 1666 | 04:08:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:07 INFO - PROCESS | 1666 | RSS: Main: 296112128 04:08:07 INFO - PROCESS | 1666 | 04:08:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:10 INFO - PROCESS | 1666 | RSS: Main: 301318144 04:08:10 INFO - PROCESS | 1666 | 04:08:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:14 INFO - PROCESS | 1666 | RSS: Main: 316411904 04:08:14 INFO - PROCESS | 1666 | 04:08:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:17 INFO - PROCESS | 1666 | RSS: Main: 309559296 04:08:17 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 04:08:19 INFO - PROCESS | 1666 | RSS: Main: 353419264 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | __start_tp_report 04:08:19 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 04:08:19 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 04:08:19 INFO - PROCESS | 1666 | |i|pagename|runs| 04:08:19 INFO - PROCESS | 1666 | |0;ai-astar;114;113;113;113;113;114;112;112;113;113 04:08:19 INFO - PROCESS | 1666 | |1;audio-beat-detection;142;109;109;142;109;107;109;108;139;107 04:08:19 INFO - PROCESS | 1666 | |2;audio-dft;181;179;182;182;184;183;183;182;204;258 04:08:19 INFO - PROCESS | 1666 | |3;audio-fft;81;59;59;88;65;59;58;59;80;52 04:08:19 INFO - PROCESS | 1666 | |4;audio-oscillator;88;70;93;69;67;67;93;93;96;118 04:08:19 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;88;85;87;86;88;84;88;84;89;85 04:08:19 INFO - PROCESS | 1666 | |6;imaging-darkroom;94;93;94;93;94;94;93;94;94;94 04:08:19 INFO - PROCESS | 1666 | |7;imaging-desaturate;85;85;83;87;86;86;84;81;84;84 04:08:19 INFO - PROCESS | 1666 | |8;json-parse-financial;57;53;53;54;56;58;57;58;58;58 04:08:19 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;75;77;66;74;73;69;69;69;70;70 04:08:19 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;83;83;85;84;86;86;82;81;89;84 04:08:19 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;136;137;143;139;138;140;134;153;193;137 04:08:19 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;166;170;167;167;167;167;168;167;170;166 04:08:19 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;67;69;67;66;69;68;68;69;67 04:08:19 INFO - PROCESS | 1666 | __end_tp_report 04:08:19 INFO - PROCESS | 1666 | __start_cc_report 04:08:19 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1953 04:08:19 INFO - PROCESS | 1666 | __end_cc_report 04:08:19 INFO - PROCESS | 1666 | __startTimestamp1478257699717__endTimestamp 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | ------- Summary: start ------- 04:08:19 INFO - PROCESS | 1666 | Number of tests: 14 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 04:08:19 INFO - PROCESS | 1666 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 112.0 112.0 113.0 113.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:109.00 stddev:15.84 (14.5%) stddev-sans-first:14.25 04:08:19 INFO - PROCESS | 1666 | Values: 142.0 109.0 109.0 142.0 109.0 107.0 109.0 108.0 139.0 107.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:191.80 Median:183.00 stddev:24.30 (13.3%) stddev-sans-first:25.46 04:08:19 INFO - PROCESS | 1666 | Values: 181.0 179.0 182.0 182.0 184.0 183.0 183.0 182.0 204.0 258.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.00 Median:62.00 stddev:12.30 (19.8%) stddev-sans-first:11.79 04:08:19 INFO - PROCESS | 1666 | Values: 81.0 59.0 59.0 88.0 65.0 59.0 58.0 59.0 80.0 52.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:90.50 stddev:16.79 (18.6%) stddev-sans-first:17.79 04:08:19 INFO - PROCESS | 1666 | Values: 88.0 70.0 93.0 69.0 67.0 67.0 93.0 93.0 96.0 118.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:1.84 (2.1%) stddev-sans-first:1.86 04:08:19 INFO - PROCESS | 1666 | Values: 88.0 85.0 87.0 86.0 88.0 84.0 88.0 84.0 89.0 85.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:08:19 INFO - PROCESS | 1666 | Values: 94.0 93.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:1.72 (2.0%) stddev-sans-first:1.81 04:08:19 INFO - PROCESS | 1666 | Values: 85.0 85.0 83.0 87.0 86.0 86.0 84.0 81.0 84.0 84.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.50 stddev:2.10 (3.6%) stddev-sans-first:2.20 04:08:19 INFO - PROCESS | 1666 | Values: 57.0 53.0 53.0 54.0 56.0 58.0 57.0 58.0 58.0 58.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:3.39 (4.7%) stddev-sans-first:3.31 04:08:19 INFO - PROCESS | 1666 | Values: 75.0 77.0 66.0 74.0 73.0 69.0 69.0 69.0 70.0 70.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:2.31 (2.7%) stddev-sans-first:2.40 04:08:19 INFO - PROCESS | 1666 | Values: 83.0 83.0 85.0 84.0 86.0 86.0 82.0 81.0 89.0 84.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:139.50 stddev:17.68 (12.7%) stddev-sans-first:18.45 04:08:19 INFO - PROCESS | 1666 | Values: 136.0 137.0 143.0 139.0 138.0 140.0 134.0 153.0 193.0 137.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.00 stddev:1.43 (0.9%) stddev-sans-first:1.41 04:08:19 INFO - PROCESS | 1666 | Values: 166.0 170.0 167.0 167.0 167.0 167.0 168.0 167.0 170.0 166.0 04:08:19 INFO - PROCESS | 1666 | 04:08:19 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.10 (1.6%) stddev-sans-first:1.09 04:08:19 INFO - PROCESS | 1666 | Values: 69.0 67.0 69.0 67.0 66.0 69.0 68.0 68.0 69.0 67.0 04:08:19 INFO - PROCESS | 1666 | -------- Summary: end -------- 04:08:19 INFO - PROCESS | 1666 | 04:08:20 INFO - TEST-INFO | 1666: exit 0 04:08:20 INFO - TEST-OK | kraken | took 58229ms 04:08:20 INFO - SUITE-END | took 1175s 04:08:20 INFO - Completed test suite (00:19:36) 04:08:20 INFO - javascript benchmark 04:08:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.7415369693576, 3307.1897385140646, 3325.2185736351967, 3346.4143774839413, 3354.7483938704604, 5666.546676265899, 5705.77176912923, 5724.313082430104, 5747.626404283724, 5760.913586296204, 5662.6036177467595, 5672.064109421951, 5763.682997435139, 5769.076947688371, 5773.249477567911, 5199.298094757216, 5217.869553261161, 5225.529702326789, 5233.267342572043, 5293.682379057269, 5194.71429071401, 5198.0, 5299.867503312409, 5326.707031113307, 5348.759305831247, 5206.349206349207, 5246.108161612535, 5260.447652996438, 5272.815451459181, 5287.709175995319, 5249.842504724865, 5303.54152608032, 5307.548858347045, 5308.522232999048, 5325.041492531343, 5171.482851714836, 5230.947690523122, 5252.107141785906, 5257.447967963347, 5283.577313814885, 4796.808127674889, 5606.971965140148, 5649.604527683064, 5674.687892165929, 5684.232628595169, 6150.077488376734, 6199.907001394983, 6238.1266622672865, 6244.469220116295, 6255.655938923357, 5255.76349064293, 6317.05244213367, 6319.684015799237, 6327.082573026932, 6359.618422894641, 5690.40250773667, 5715.514181294637, 5726.570507211975, 5755.107958266475, 5852.941470585282, 5338.0, 6275.090111933835, 6361.4592759615025, 6361.745530178833, 6368.808935731936, 6017.819465416044, 6069.998450255658, 6072.908906366408, 6105.633661980295, 6113.205283313141, 5117.590592752571, 6112.989854784112, 6172.969135154295, 6236.095766113979, 6238.438540531374, 6181.81454556364, 6237.625742455467, 6238.625682459067, 6246.4378205960775, 6286.811395658137, 6209.658468784261, 6235.812925612239, 6285.937140628535, 6295.18162638854, 6301.905471417932, 4848.0, 4913.410390753133, 4918.5573298403315, 4941.25881117828, 4944.9258261126115, 4401.0, 4453.087117140978, 4485.484169320504, 4490.371348011281, 4531.614812740954, 5813.7383817728305, 5814.098814683731, 5833.766649333979, 5841.620294680833, 5851.502622277154, 6314.810555683337, 6323.177986861679, 6341.048842673636, 6350.7777227796805, 6354.142190804182, 5639.915401268984, 5645.040343141676, 5716.542676585863, 5746.454086861741, 5808.448197421323, 5410.97294513525, 5417.241586177938, 5419.566434685215, 5442.619016668795, 5446.400895901447, 6293.811185664437, 6306.432421082125, 6306.432421082125, 6307.873842523124, 6310.305866354697, 6119.8470038247615, 6123.2652081750475, 6260.593061450991, 6331.9366806331345, 6336.017917222838, 6152.046432802923, 6155.692215389302, 6198.597091189239, 6259.092431597302, 6288.339724328879, 4585.679002469795, 6209.5032397409, 6236.656983865931, 6242.907491189115, 6246.6876656167915, 5869.882602348014, 5972.492338151305, 6144.754209831557, 6275.874482510416, 6345.746170153142, 5978.103284507359, 5981.0, 6018.157457955802, 6037.939620603738, 6068.7269072892705, 6057.242844644419, 6071.51427885777, 6089.604175728564, 6089.634621922699, 6101.206843110367, 5867.618604790675, 5878.706064696663, 5882.970585147047, 5886.293644762484, 5887.087501437284, 5926.318473375617, 6063.363346848518, 6070.605410648293, 6103.725332359965, 6141.477974372228, 5373.247745315737, 5527.5577953762795, 5989.880202396015, 6033.396660333931, 6044.637321760709], "value": 5674.375827967178, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.5436493068565, 522.8144008876847, 529.3489008519523, 537.545773821121, 556.9612672366038, 29963.1011069668, 31297.68702312976, 32116.51825222618, 32125.19687007826, 32162.67837321632, 32627.83686081572, 33213.83393083031, 41150.382744258786, 42249.15501689964, 42365.94085147873, 9575.090366415197, 9690.27322950778, 9713.174380177694, 9735.513224338754, 9743.902560974406, 9568.234541236685, 9652.517374131301, 9661.0, 9665.226781857435, 9666.081722236411, 9642.951785241099, 9706.174975127122, 9718.173955213815, 9718.65984690536, 9740.561674724619, 9611.855822162674, 9665.420074795464, 9684.56419461126, 9700.805983880284, 9705.175060119898, 9615.567299471471, 9663.806723865484, 9682.080202380763, 9702.320837541374, 9702.757431064209, 39673.20653586912, 39895.60365387198, 40085.79957100196, 40087.19825603501, 40285.39571906424, 3218.4850423932294, 3427.5715535558056, 3761.4545890845948, 3958.44581758554, 3968.8809335719975, 24617.876910615334, 28828.567571486234, 29288.853555732087, 30349.089527314216, 30813.229669258224, 2959.1270575180374, 2970.732634062923, 3154.1956801015594, 3161.9051428457183, 3218.4045951499047, 507014.99999999633, 508695.0, 508874.0, 509907.9999999963, 510167.0, 56292.0, 56714.7164264176, 56730.99999999918, 56737.0, 56759.71620141873, 59444.70277648671, 59796.0, 59800.40199597948, 59904.0, 59940.70029649824, 16134.596635083983, 16330.0, 16361.754573681405, 16384.0169589825, 16391.91804040972, 12904.290264035568, 12968.546100886424, 12983.221006739626, 12990.220586764824, 13001.349932503337, 13455.86544134546, 15220.238988050774, 15236.923815381075, 15242.466513671969, 15416.383344666312, 6677.76627818024, 6831.0, 6861.519693621399, 6872.41584465316, 6899.517033807686, 735.5880706804206, 761.2501685839444, 806.3267171911402, 827.995860020696, 1011.5599714124379, 28485.0, 29645.0, 29830.0, 30140.54789178164, 30141.397172056437, 933.6358820060182, 1047.8271085270997, 1059.6026490066224, 1099.0328510910347, 1154.630518234174, 14514.129152250687, 14698.706025879423, 15084.547463576111, 15213.91304347826, 15462.0, 657115.0, 660894.0, 663869.0, 664353.0, 666504.0, 55349.72325138429, 55526.611834704454, 55667.16499252515, 55798.72100639552, 55872.72063639656, 1347.2926713475308, 1377.4283672275894, 1389.3192335755407, 1391.5338361648758, 1400.404827948118, 26481.735182647928, 26790.330241744112, 28896.42207155803, 29120.41759164847, 29535.113946581638, 47348.7632561835, 47653.76173119112, 47697.569072927865, 47744.28383574318, 47910.041799164515, 609495.0, 613413.9329303325, 615221.0, 616049.0, 616146.0, 25606.487870242865, 26396.8680156598, 38474.84575462741, 38854.222915542094, 38859.80570097244, 46477.767611161726, 46687.53312466832, 46975.765121175544, 47332.52667473281, 47710.284345734144, 33495.49756753602, 37652.05869853275, 37970.62029379671, 38517.807410963884, 38623.42064869085, 37471.62528374681, 38121.0, 38596.80701596474, 38726.41910371403, 38747.806260968515, 37108.0, 37447.625523745504, 37520.2495950074, 37562.81218593999, 37834.43248351222, 32029.839850800596, 33680.83159584186, 34073.31853362869, 34136.82931585426, 34356.65643343634, 24382.390440239134, 24830.503389932463, 25140.86866090994, 25152.0, 25299.747002530476], "value": 19564.202818574424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.27586206896547, 350.9894703158903, 375.48933450507315, 379.9012256813228, 408.1673386291965, 14875.851241487582, 15534.0, 15818.288177032033, 19722.605547889034, 20131.698024529644, 19567.60864782707, 19613.607727845436, 20783.0, 21027.264045758402, 21234.57530849386, 5739.770409183628, 5872.265966754156, 6007.4593286604195, 6011.128386383972, 6016.037434010559, 4902.607791376681, 6603.910354791454, 6697.363750443725, 6749.730010799587, 6778.457723382117, 5131.358580177478, 5883.941160588403, 6654.933450665504, 6689.598624082546, 6722.1261236039245, 6220.098085777559, 6246.094316324107, 6246.843828904268, 6251.531135164881, 6259.0298503731765, 5859.8535036624, 6016.909746353808, 6102.206713127265, 6106.084087386883, 6109.114178444145, 13184.670383240496, 13423.328833558284, 13684.452621895112, 23049.539009219723, 25232.87383563089, 2349.319265314663, 2614.6993095794037, 2723.931901702473, 2749.3264150283308, 3010.0518336723862, 9768.169705575036, 10044.447555384451, 10168.44073575953, 10181.236407269484, 10328.741781455448, 1770.1149425287356, 1789.5347209725564, 1853.7960824309316, 1860.479065861561, 1866.5426970392205, 121942.17086743706, 123775.0, 126539.0, 127335.99999999907, 128581.35709321487, 10248.795024099476, 11583.710407239887, 11640.534378624929, 11709.765804683859, 11857.466414011391, 14720.705585888223, 14722.852771472362, 14730.189839558712, 14753.704925901422, 14767.04014239071, 8487.193716596914, 8500.362472814564, 8603.913960860436, 8605.612747426381, 8712.259457946018, 6823.420009299166, 6981.2669669684965, 8492.320614350838, 8572.657093716307, 8630.956845215735, 4526.7510286933875, 4530.320451932236, 4535.501094879561, 4537.727736335831, 4604.424446944132, 1870.5136664467063, 1899.6010837723957, 1910.646530391882, 1920.8559358048203, 1929.9035048247813, 880.6873559886276, 911.0980129671577, 974.6198982396871, 982.7199248214224, 998.2213873178932, 17744.46766597004, 19554.217831286875, 21076.156953721988, 21091.367258982256, 21207.15171393158, 910.5674804467825, 910.7677542226689, 951.690700522333, 954.9809003819885, 1013.3869009249445, 10432.5826966922, 10904.34573925567, 11125.0, 11139.72150696239, 11173.776524469627, 604920.9507904864, 612624.0, 620071.0, 627348.0, 630800.0, 129208.0, 133768.0, 135237.0, 141461.0, 145328.0, 970.6360114956891, 979.314479864098, 994.9403035817729, 995.835687111633, 997.4364484066624, 17420.73868891993, 18100.637987240443, 18690.252389904796, 18701.906490468005, 18792.624147517246, 55655.44344556665, 55821.0, 57020.144697830394, 57416.71291643515, 57958.0, 81538.18461815306, 83115.5844220775, 83677.58161209156, 85342.57328713317, 86480.0, 7767.728129515666, 8094.583447896477, 8146.5519396433765, 8323.916760832315, 8346.165383461605, 10361.378317300987, 12947.287899165636, 12969.610911672666, 13062.34688265602, 13349.466021359036, 11058.723531911766, 11191.944040279746, 11401.372924489233, 11553.942230288794, 11583.710407239549, 10115.342502737592, 10414.687559373231, 10692.786144277226, 11189.496472658913, 11418.029467495357, 11294.717632059264, 11386.658400248005, 11427.657170284905, 11441.027512661183, 11817.468213930222, 7163.892541611775, 7437.293457121565, 7607.847843043219, 7753.961230193813, 8258.669653213805, 10064.597416103567, 11229.989300962952, 11231.4384280784, 11735.23720958135, 11789.587364442203], "value": 9592.771383001842, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.5092541222446, 1503.0831192972284, 1527.289810238239, 1705.6247625522387, 1875.5311172206948, 7744.26429489199, 8231.135730748267, 8523.531205783687, 8834.0, 8849.115088491148, 8650.005249396321, 8753.993290771563, 8754.737357879274, 8758.86861697075, 8761.868571971425, 2375.572396968545, 2402.615581506959, 2405.1101092595763, 2409.168836751318, 2410.3974006498374, 2337.859728416292, 2343.5195784864145, 2349.142562964514, 2365.6451532270125, 2387.0, 2363.1847012780563, 2381.940451488709, 2397.5324811661735, 2398.4123889646976, 2402.5555272274687, 2041.652919003773, 2368.8460250083776, 2378.2984019714227, 2379.7739214774656, 2383.3803211165223, 2317.9072837086665, 2342.0982921575146, 2343.6367363058753, 2346.1084787780533, 2348.894299756515, 8656.437331573428, 8728.083551227093, 8738.650453981832, 8847.424917380415, 8876.822463550692, 5216.087184742655, 5425.972870135624, 5426.0, 5429.945700543023, 5432.13085906257, 3437.9312413751586, 3477.3914564951033, 3537.1510837399096, 3545.18460754028, 3546.4325707886874, 1032.1072272484248, 1057.228223396917, 1722.2938595175917, 1773.9911300443543, 1831.9358822441284, 11646.59236926712, 11752.059835213247, 11754.823677644843, 11763.941180294043, 11799.233049851819, 4503.369528266046, 4534.183846907522, 4638.652101092432, 4690.108879312919, 4691.55430234134, 9171.44971301724, 9177.219936305355, 9183.494907780003, 9184.21934135606, 9189.218916392048, 5262.578993680497, 5262.71055091966, 5264.0261551613075, 5264.473552644705, 5267.499587539178, 4116.711830171859, 4400.44994375703, 4557.1797076526545, 4919.458859525449, 4925.655204135748, 3811.923761524754, 3821.312163810541, 3853.9036524087123, 3910.569837317893, 3928.4107383892647, 1148.7530181011123, 1159.3913195572222, 1159.4260840883817, 1171.619223752284, 1173.4484792147678, 765.5291995422775, 839.3075712537182, 851.9574021299035, 926.8424367857481, 933.7712260496222, 5665.0, 5673.262475878192, 5836.095405212199, 6025.879482410327, 6186.81439556814, 428.4173524007347, 432.1033854751403, 455.6969615205851, 457.86492984569634, 458.1524180266547, 3686.746506187909, 3765.736398452082, 3980.5621381647998, 4108.548059713429, 4114.814833332507, 10356.533955971849, 10670.413127278074, 10683.14534837211, 10813.18901082422, 10831.458427078614, 10619.256652034283, 10630.787384252271, 10739.248252622241, 10776.29954052984, 10806.675799725863, 7907.130215676271, 8145.389095817837, 8278.503289802631, 8307.709230177035, 8347.457415267989, 5685.459881311269, 5755.223044889054, 5827.155062515827, 5911.261092363455, 5921.111833224878, 9862.457564834003, 9874.111329980049, 10025.398476091457, 10038.347507412287, 10088.041636044563, 9414.435133891988, 9713.854292185482, 9770.75573110678, 10026.398416095057, 10146.695599132037, 6869.793906182623, 7046.859062818612, 7080.504364694422, 7093.113360829896, 7150.785476435715, 8195.303399211134, 8239.340852731886, 8330.166983301622, 8335.624896879533, 8352.248297653241, 7092.822679433056, 7179.641017949186, 7228.421726261781, 7337.633118344168, 7358.595277259802, 6334.873302534015, 7449.776506704808, 7450.850982980419, 7463.664135113824, 7484.0, 6941.861162776817, 6964.721411143498, 6987.6855541499735, 7049.330313620198, 7061.858762824818, 4925.482824303396, 4932.753362331798, 4981.452040275639, 5001.624878134082, 5064.620153488577, 4926.3349447824085, 5016.372953380827, 5052.8989420210655, 5104.795808167781, 5182.455842136521], "value": 4485.869361922307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8207075754547, 303.2797106871181, 307.9030105516763, 313.4342511766261, 314.64445176950045, 4348.347747837822, 5137.922931156031, 5188.896222075561, 5219.112750832358, 5238.240455134003, 5080.466551012146, 5131.435542090377, 5171.896562068766, 5217.0, 5259.8422047338545, 3265.8693652253883, 3281.7210537104374, 3500.842462089199, 3724.5344331958504, 3761.4357846322996, 3575.284943011395, 3647.379945409287, 3935.5867633898456, 3937.8621748238816, 4040.0, 3299.7525185611057, 3929.9214015719667, 3988.880333589997, 4019.5176578810583, 4044.3933409988445, 3003.717174947034, 3284.1132894118573, 3626.492291079251, 3857.710671699606, 3974.2448934702315, 3464.4456886897974, 3502.9474557881654, 3524.7356448266482, 3539.8938031859084, 3550.5739311282555, 4970.776315065831, 5040.495950404967, 5058.054717320496, 5067.746612669352, 5079.87300317495, 4337.395163789387, 4573.63410927125, 4576.496585375606, 4603.861884143481, 4610.515895830957, 4062.5531191568903, 4865.7692980046595, 4989.825356112555, 5056.74716264189, 5272.340957380327, 3102.7672924530752, 3803.2393521295853, 3864.478295430109, 3870.0069464225944, 3890.1636148228267, 5651.547876169855, 5684.374718780972, 5684.658920464785, 5694.829155125353, 5712.400197979236, 3452.085197422685, 3474.253035597308, 3503.2993401319327, 3693.8337774800198, 3780.5085338905765, 3437.759356845047, 3830.7893065881085, 3835.6931445484292, 3847.941351377, 3857.6913846892744, 3761.9059523512133, 4313.245182093184, 4438.334249862546, 4451.821927122944, 4486.730796152241, 5190.37715474138, 5487.780488780404, 5515.4760297771645, 5547.805826796042, 5553.72264379187, 1138.5047504335641, 1310.8754668306497, 1312.1760752553957, 1315.4409376015346, 1316.367704046975, 697.7231666051114, 749.6027105634023, 767.8146248066919, 782.4327362662139, 797.2943944609062, 4629.976850115728, 5115.130427827278, 5117.923231151536, 5130.563902068291, 5133.050385678586, 5327.866803329948, 5496.120620700669, 5517.2551705519245, 5562.694051827108, 5704.629199102045, 5029.183657152006, 5186.299849520266, 5197.58419326453, 5209.8639557781125, 5216.7913283469, 2441.7802397784285, 2935.427591619614, 2971.870689138114, 2976.7618590512707, 3013.5329024000876, 5511.669299842022, 5872.324682661549, 5887.558433117533, 5898.262717160355, 5910.615809972338, 5026.52248036436, 5497.697626630574, 5735.369109397963, 5746.13807928814, 5767.423257674283, 5077.8730531737, 5755.776765011607, 5758.740856661377, 5787.826365209051, 5792.420757924258, 4762.666613337033, 4970.353853998957, 5452.700101494456, 5625.521830644441, 5677.687727175045, 5349.893002140013, 5636.2954630671165, 5636.689982051026, 5644.915326270027, 5661.745221464962, 4658.99663144851, 5873.765049398147, 5904.61619994699, 5907.054871220584, 5920.911186332122, 3292.1769557610596, 3628.5282913221113, 3814.1691987845434, 3816.828242729139, 3836.7506112102624, 4698.906021879611, 5042.9409823937385, 5627.00241414292, 5659.26429564154, 5716.056850619601, 5216.843494695166, 5466.535344495604, 5488.588355873246, 5509.705219273547, 5528.889422211614, 5293.311869456946, 5476.3702174250475, 5481.917771233355, 5513.669179849222, 5520.227168196376, 5387.703676297841, 5420.620556561003, 5420.620556561003, 5427.3215848019, 5434.619576629756, 5259.737013149251, 5454.509094181542, 5477.972610137083, 5483.725813709379, 5542.418046105101, 4934.484946274119, 5186.703324168958, 5297.390800058042, 5372.785088596413, 5463.48096930791], "value": 3987.2351988418736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.6466766616688, 738.468302821968, 763.6563546404119, 787.1577412168978, 811.4279432999735, 14866.47967321144, 16045.598860028476, 16051.598710032255, 16091.275892584832, 16112.597185070379, 14347.56957291283, 14537.273136343167, 14568.417263309482, 14602.488912888051, 14619.707605847876, 662.6322391072953, 681.437813803614, 684.8767221900056, 685.9245482996866, 807.055744778609, 678.6945874356535, 680.3298750730527, 702.8242939265184, 810.116972499975, 835.4903508859591, 886.6276164011099, 887.8579427291635, 891.6433426629335, 891.7369376034086, 891.8974317953421, 881.1540920716056, 881.7002219245423, 881.9162179592928, 883.231588517987, 883.8099808541131, 522.029026011618, 538.5099559400966, 539.0431983229798, 541.301720780193, 666.2870728320698, 12447.190932589443, 13904.096233744775, 14434.350454229585, 14471.78292325616, 14747.55757327282, 14106.153630782186, 14482.637934051627, 14518.92740536301, 14535.927320363331, 14545.200013999225, 11436.142289328334, 11657.242279251821, 11895.762084758257, 11906.0, 11973.700657483632, 3758.8684396046006, 3832.540095188567, 3845.3462911305146, 3909.3745000799736, 3927.9410808837893, 109875.90124098737, 113152.30271545933, 115909.0, 116965.0, 117556.0, 8952.418092823946, 10433.478326083665, 10841.945790271157, 10851.674449766362, 11194.384308862927, 21272.893635531724, 21413.357599272047, 21554.353369398945, 21555.814430206177, 21689.67465488019, 7887.290143887078, 7934.246246606564, 7936.246056624612, 7961.562114083665, 7973.0830954439825, 4193.496780386373, 4359.782010899442, 4429.49060857999, 4671.299305104261, 4689.859304220879, 3465.9826700866333, 3588.1209103769743, 3599.136207310227, 3604.3692353837973, 3607.206414588786, 633.2369494758805, 634.1027446163719, 647.4755448087064, 648.0700195219874, 658.940695337422, 591.899377105893, 620.2835724737935, 655.8817216645608, 657.789507357641, 677.4580335731396, 8763.829340688897, 9439.150476457151, 9481.620735170654, 9625.470599117116, 9750.756231094138, 617.9783707570214, 647.2653538234044, 659.8548319369731, 660.8116686744255, 690.6684791300204, 4216.789160541961, 4635.096156249499, 5010.496572446194, 5038.910700192759, 5124.410692770304, 77285.6135719329, 130127.0, 131610.34194828966, 157687.21156394144, 165995.0, 118343.40828295803, 130044.69955300515, 133730.33134834265, 136096.0, 137449.62550374368, 73578.63210684019, 77427.61286193533, 79528.87773517305, 80356.0, 80835.5958220205, 8483.660653573788, 9008.549572521479, 9494.905050949403, 9601.855972160563, 10034.795824501107, 67565.66217168883, 67920.6603966977, 68520.0, 69057.0, 70990.0, 103823.4808825951, 104361.47819261158, 104751.4762426183, 104904.0, 107279.0, 13164.60506184816, 13431.395587198404, 13914.373853176428, 14029.508967186099, 14047.648808779863, 14083.084599501, 14403.92798036045, 14728.189949552878, 15778.76331855046, 15785.921070394574, 13919.0, 13984.720305593628, 14102.36539355711, 14653.780193297322, 14671.193084380035, 13584.728305433639, 13682.863171368557, 13862.86137138656, 13979.161250325013, 14462.85537144615, 11206.271592346471, 13400.128991615515, 13414.530491432753, 13503.054786164874, 14124.0, 11292.774144517229, 11325.0, 11567.652970410902, 11892.345920974429, 11991.700207494883, 9913.355631883904, 11465.31208127515, 11520.193586448868, 11589.304641721523, 11750.412479375826], "value": 7733.541468917482, "unit": "score"}], "name": "dromaeo_css", "value": 7267.383784530375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 112.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 109.0, 142.0, 109.0, 107.0, 109.0, 108.0, 139.0, 107.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 182.0, 182.0, 184.0, 183.0, 183.0, 182.0, 204.0, 258.0], "value": 191.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 65.0, 59.0, 58.0, 59.0, 80.0, 52.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 69.0, 67.0, 67.0, 93.0, 93.0, 96.0, 118.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 86.0, 88.0, 84.0, 88.0, 84.0, 89.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 87.0, 86.0, 86.0, 84.0, 81.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 54.0, 56.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 66.0, 74.0, 73.0, 69.0, 69.0, 69.0, 70.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 85.0, 84.0, 86.0, 86.0, 82.0, 81.0, 89.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 143.0, 139.0, 138.0, 140.0, 134.0, 153.0, 193.0, 137.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 167.0, 167.0, 167.0, 167.0, 168.0, 167.0, 170.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 67.0, 66.0, 69.0, 68.0, 68.0, 69.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1431.0000000000002, "alertThreshold": 2.0}]} 04:08:21 INFO - Return code: 0 04:08:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:21 INFO - # TBPL SUCCESS # 04:08:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:08:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:08:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:08:21 INFO - 2016-11-04 04:08:21.082 screenresolution[1670:10030] starting screenresolution argv=screenresolution get 04:08:21 INFO - 2016-11-04 04:08:21.085 screenresolution[1670:10030] Display 0: 1600x1200x32@60 04:08:21 INFO - 2016-11-04 04:08:21.091 screenresolution[1671:10033] starting screenresolution argv=screenresolution list 04:08:21 INFO - Available Modes on Display 0 04:08:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:08:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:08:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:08:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:08:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:08:21 INFO - Intel Iris: 04:08:21 INFO - Chipset Model: Intel Iris 04:08:21 INFO - Type: GPU 04:08:21 INFO - Bus: Built-In 04:08:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:08:21 INFO - Vendor: Intel (0x8086) 04:08:21 INFO - Device ID: 0x0a2e 04:08:21 INFO - Revision ID: 0x0009 04:08:21 INFO - Displays: 04:08:21 INFO - Display: 04:08:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:08:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:08:21 INFO - Display Serial Number: 1600x1200 60 04:08:21 INFO - Main Display: Yes 04:08:21 INFO - Mirror: Off 04:08:21 INFO - Online: Yes 04:08:21 INFO - Rotation: Supported 04:08:21 INFO - Return code: 0 04:08:21 INFO - Running post-action listener: _resource_record_post_action 04:08:21 INFO - [mozharness: 2016-11-04 11:08:21.325846Z] Finished run-tests step (success) 04:08:21 INFO - Running post-run listener: _resource_record_post_run 04:08:21 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 49189888; Write bytes: 674126336; Read time: 544; Write time: 2099 04:08:21 INFO - TinderboxPrint: CPU usage
53.4% 04:08:21 INFO - TinderboxPrint: I/O read bytes / time
49,189,888 / 544 04:08:21 INFO - TinderboxPrint: I/O write bytes / time
674,126,336 / 2,099 04:08:21 INFO - TinderboxPrint: CPU idle
2,252.7 (46.6%) 04:08:21 INFO - TinderboxPrint: CPU system
970.5 (20.1%) 04:08:21 INFO - TinderboxPrint: CPU user
1,614.4 (33.4%) 04:08:21 INFO - TinderboxPrint: Swap in / out
406,138,880 / 0 04:08:21 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 359831552; Write bytes: 355284992; Read time: 27560; Write time: 660 04:08:21 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 42916864; Write bytes: 308683264; Read time: 457; Write time: 1404 04:08:21 INFO - Running post-run listener: _upload_blobber_files 04:08:21 INFO - Blob upload gear active. 04:08:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:08:22 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:23 INFO - (blobuploader) - INFO - Done attempting. 04:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:08:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:24 INFO - (blobuploader) - INFO - Done attempting. 04:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:08:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:26 INFO - (blobuploader) - INFO - Done attempting. 04:08:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:26 INFO - Return code: 0 04:08:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:08:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39cdda7960fc5d1640d9a4b25ea03b475d1c457eefcab680ce6d917f7ab3cc4efc94d6725ffd05bd55b8005ff840dcc6aea488cb66a8cc4a07eecc1386829a38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5342f98e9ccb60c32dde0eaa00e3a754b854a444b04b7e175d6ff1c6ed8579a431eac348d4e5dfc2859a9d59fce2f1b77352cb5374aa852ff5024ad30172e9e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85200d9409053213458df01b974888b5d84ddfdc11e66172c3f4e656a39ae7f5be0bf2d39081a0dd8ca87ee570623d99b314cba206f60500ecb62fe919a5ea0f"} 04:08:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:08:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:08:26 INFO - Contents: 04:08:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39cdda7960fc5d1640d9a4b25ea03b475d1c457eefcab680ce6d917f7ab3cc4efc94d6725ffd05bd55b8005ff840dcc6aea488cb66a8cc4a07eecc1386829a38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5342f98e9ccb60c32dde0eaa00e3a754b854a444b04b7e175d6ff1c6ed8579a431eac348d4e5dfc2859a9d59fce2f1b77352cb5374aa852ff5024ad30172e9e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85200d9409053213458df01b974888b5d84ddfdc11e66172c3f4e656a39ae7f5be0bf2d39081a0dd8ca87ee570623d99b314cba206f60500ecb62fe919a5ea0f"} 04:08:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:08:26 INFO - Copying logs to upload dir... 04:08:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:08:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.340056 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-04 04:08:26.607781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 04:08:26.611592) ========= 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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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/39cdda7960fc5d1640d9a4b25ea03b475d1c457eefcab680ce6d917f7ab3cc4efc94d6725ffd05bd55b8005ff840dcc6aea488cb66a8cc4a07eecc1386829a38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5342f98e9ccb60c32dde0eaa00e3a754b854a444b04b7e175d6ff1c6ed8579a431eac348d4e5dfc2859a9d59fce2f1b77352cb5374aa852ff5024ad30172e9e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85200d9409053213458df01b974888b5d84ddfdc11e66172c3f4e656a39ae7f5be0bf2d39081a0dd8ca87ee570623d99b314cba206f60500ecb62fe919a5ea0f"} build_url:https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/XBy7xofdQfGkS339nDSzQw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39cdda7960fc5d1640d9a4b25ea03b475d1c457eefcab680ce6d917f7ab3cc4efc94d6725ffd05bd55b8005ff840dcc6aea488cb66a8cc4a07eecc1386829a38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5342f98e9ccb60c32dde0eaa00e3a754b854a444b04b7e175d6ff1c6ed8579a431eac348d4e5dfc2859a9d59fce2f1b77352cb5374aa852ff5024ad30172e9e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85200d9409053213458df01b974888b5d84ddfdc11e66172c3f4e656a39ae7f5be0bf2d39081a0dd8ca87ee570623d99b314cba206f60500ecb62fe919a5ea0f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 04:08:26.648877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 04:08:26.649232) ========= 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.F88bWLCzFe/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.Jm4IxY8TGH/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005371 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 04:08:26.700736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 04:08:26.701472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 04:08:26.702611) ========= ========= Total master_lag: 1.29 =========