builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0181 starttime: 1482300754.61 results: success (0) buildid: 20161220202254 builduid: b73a7546e03d4a068e616701eae893e7 revision: 19a951289cad3bbfa1f01470f0a9e7d515443c79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.609010) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.609531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.609859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.635541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.635874) ========= 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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-20 22:12:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.04M=0.001s 2016-12-20 22:12:34 (8.04 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080500 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.742390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.742804) ========= 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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.019872 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:34.792388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-20 22:12:34.792917) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 19a951289cad3bbfa1f01470f0a9e7d515443c79 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 19a951289cad3bbfa1f01470f0a9e7d515443c79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z5JoPOEzLf/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.DbqMKnSDGC/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-20 22:12:34,870 truncating revision to first 12 chars 2016-12-20 22:12:34,870 Setting DEBUG logging. 2016-12-20 22:12:34,871 attempt 1/10 2016-12-20 22:12:34,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/19a951289cad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 22:12:36,631 unpacking tar archive at: graphics-19a951289cad/testing/mozharness/ program finished with exit code 0 elapsedTime=2.015471 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-20 22:12:36.834684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:36.835069) ========= script_repo_revision: 19a951289cad3bbfa1f01470f0a9e7d515443c79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:36.835653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:36.836327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 22:12:36.859285) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-20 22:12:36.859971) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z5JoPOEzLf/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.DbqMKnSDGC/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:12:37 INFO - MultiFileLogger online at 20161220 22:12:37 in /builds/slave/test 22:12:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 22:12:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:12:37 INFO - {'append_to_log': False, 22:12:37 INFO - 'base_work_dir': '/builds/slave/test', 22:12:37 INFO - 'blob_upload_branch': 'Graphics', 22:12:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:12:37 INFO - 'branch': 'Graphics', 22:12:37 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:37 INFO - 'config_files': ('talos/mac_config.py',), 22:12:37 INFO - 'default_actions': ('clobber', 22:12:37 INFO - 'read-buildbot-config', 22:12:37 INFO - 'download-and-extract', 22:12:37 INFO - 'populate-webroot', 22:12:37 INFO - 'create-virtualenv', 22:12:37 INFO - 'install', 22:12:37 INFO - 'run-tests'), 22:12:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:37 INFO - 'download_minidump_stackwalk': True, 22:12:37 INFO - 'download_symbols': 'ondemand', 22:12:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:37 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:37 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:37 INFO - 'installer_path': 'installer.exe', 22:12:37 INFO - 'log_level': 'info', 22:12:37 INFO - 'log_name': 'talos', 22:12:37 INFO - 'log_to_console': True, 22:12:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:12:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:12:37 INFO - 'opt_config_files': (), 22:12:37 INFO - 'pip_index': False, 22:12:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:12:37 INFO - 'cmd': ('bash', 22:12:37 INFO - '-c', 22:12:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:12:37 INFO - 'enabled': True, 22:12:37 INFO - 'halt_on_failure': False, 22:12:37 INFO - 'name': 'check_screen_resolution'},), 22:12:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:12:37 INFO - 'cmd': ('bash', 22:12:37 INFO - '-c', 22:12:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:12:37 INFO - 'enabled': True, 22:12:37 INFO - 'halt_on_failure': False, 22:12:37 INFO - 'name': 'check_screen_resolution'},), 22:12:37 INFO - 'run_cmd_checks_enabled': True, 22:12:37 INFO - 'sps_profile': False, 22:12:37 INFO - 'sps_profile_interval': 0, 22:12:37 INFO - 'suite': 'dromaeojs', 22:12:37 INFO - 'system_bits': '32', 22:12:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:37 INFO - 'title': 't-yosemite-r7-0181', 22:12:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:37 INFO - 'use_talos_json': True, 22:12:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:12:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:37 INFO - 'work_dir': 'build'} 22:12:37 INFO - [mozharness: 2016-12-21 06:12:37.066130Z] Running clobber step. 22:12:37 INFO - Running pre-action listener: _resource_record_pre_action 22:12:37 INFO - Running main action method: clobber 22:12:37 INFO - rmtree: /builds/slave/test/build 22:12:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:12:37 INFO - Running post-action listener: _resource_record_post_action 22:12:37 INFO - [mozharness: 2016-12-21 06:12:37.956451Z] Finished clobber step (success) 22:12:37 INFO - [mozharness: 2016-12-21 06:12:37.956560Z] Running read-buildbot-config step. 22:12:37 INFO - Running pre-action listener: _resource_record_pre_action 22:12:37 INFO - Running main action method: read_buildbot_config 22:12:37 INFO - Using buildbot properties: 22:12:37 INFO - { 22:12:37 INFO - "project": "", 22:12:37 INFO - "product": "firefox", 22:12:37 INFO - "script_repo_revision": "default", 22:12:37 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 22:12:37 INFO - "repository": "", 22:12:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 22:12:37 INFO - "buildid": "20161220202254", 22:12:37 INFO - "pgo_build": "False", 22:12:37 INFO - "basedir": "/builds/slave/test", 22:12:37 INFO - "buildnumber": 12, 22:12:37 INFO - "slavename": "t-yosemite-r7-0181", 22:12:37 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 22:12:37 INFO - "platform": "yosemite_r7", 22:12:37 INFO - "scheduler": "tests-graphics-macosx64-talos", 22:12:37 INFO - "branch": "graphics", 22:12:37 INFO - "repo_path": "projects/graphics", 22:12:37 INFO - "revision": "19a951289cad3bbfa1f01470f0a9e7d515443c79", 22:12:37 INFO - "stage_platform": "macosx64", 22:12:37 INFO - "builduid": "b73a7546e03d4a068e616701eae893e7", 22:12:37 INFO - "slavebuilddir": "test" 22:12:37 INFO - } 22:12:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 22:12:37 INFO - Running post-action listener: _resource_record_post_action 22:12:37 INFO - [mozharness: 2016-12-21 06:12:37.959662Z] Finished read-buildbot-config step (success) 22:12:37 INFO - [mozharness: 2016-12-21 06:12:37.959777Z] Running download-and-extract step. 22:12:37 INFO - Running pre-action listener: _resource_record_pre_action 22:12:37 INFO - Running main action method: download_and_extract 22:12:37 INFO - mkdir: /builds/slave/test/build/tests 22:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:37 INFO - trying https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 22:12:37 INFO - Downloading https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 22:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 22:12:39 INFO - Downloaded 1199 bytes. 22:12:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 22:12:39 INFO - Using the following test package requirements: 22:12:39 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 22:12:39 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 22:12:39 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 22:12:39 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'jsshell-mac.zip'], 22:12:39 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 22:12:39 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 22:12:39 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 22:12:39 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 22:12:39 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 22:12:39 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 22:12:39 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 22:12:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:12:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 22:12:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:12:39 INFO - Fetch https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 22:12:39 INFO - Expected file size: 16276031 22:12:39 INFO - Obtained file size: 16276031 22:12:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:12:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 22:12:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:12:46 INFO - Fetch https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 22:12:47 INFO - Expected file size: 16276031 22:12:47 INFO - Obtained file size: 16276031 22:12:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 22:12:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:12:53 INFO - Fetch https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 22:12:54 INFO - Expected file size: 14409734 22:12:54 INFO - Obtained file size: 14409734 22:12:54 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')]} 22:12:54 INFO - trying https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:12:54 INFO - Downloading https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 22:12:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 22:12:56 INFO - Downloaded 69659000 bytes. 22:12:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:12:56 INFO - mkdir: /builds/slave/test/properties 22:12:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:12:56 INFO - Writing to file /builds/slave/test/properties/build_url 22:12:56 INFO - Contents: 22:12:56 INFO - build_url:https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 22:12:57 INFO - Running post-action listener: _resource_record_post_action 22:12:57 INFO - Running post-action listener: set_extra_try_arguments 22:12:57 INFO - [mozharness: 2016-12-21 06:12:57.584460Z] Finished download-and-extract step (success) 22:12:57 INFO - [mozharness: 2016-12-21 06:12:57.584613Z] Running populate-webroot step. 22:12:57 INFO - Running pre-action listener: _resource_record_pre_action 22:12:57 INFO - Running main action method: populate_webroot 22:12:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:12:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:12:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:12:57 INFO - '--tppagecycles', 22:12:57 INFO - '7'], 22:12:57 INFO - 'tests': ['tsvgm']}}, 22:12:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:12:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:12:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:12:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:12:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:12:57 INFO - 'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:12:57 INFO - 'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['damp', 'tps']}, 22:12:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:12:57 INFO - 'tests': ['damp', 'tps']}, 22:12:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['dromaeo_dom']}, 22:12:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:12:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['basic_compositor_video']}, 22:12:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:12:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['a11yr', 22:12:57 INFO - 'ts_paint', 22:12:57 INFO - 'tpaint', 22:12:57 INFO - 'sessionrestore', 22:12:57 INFO - 'sessionrestore_no_auto_restore', 22:12:57 INFO - 'tabpaint']}, 22:12:57 INFO - 'other-e10s': {'tests': ['a11yr', 22:12:57 INFO - 'ts_paint', 22:12:57 INFO - 'tpaint', 22:12:57 INFO - 'sessionrestore', 22:12:57 INFO - 'sessionrestore_no_auto_restore', 22:12:57 INFO - 'tabpaint']}, 22:12:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:12:57 INFO - 'ts_paint', 22:12:57 INFO - 'tpaint', 22:12:57 INFO - 'sessionrestore', 22:12:57 INFO - 'sessionrestore_no_auto_restore', 22:12:57 INFO - 'tabpaint']}, 22:12:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:12:57 INFO - 'ts_paint', 22:12:57 INFO - 'tpaint', 22:12:57 INFO - 'sessionrestore', 22:12:57 INFO - 'sessionrestore_no_auto_restore', 22:12:57 INFO - 'tabpaint']}, 22:12:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['a11yr', 22:12:57 INFO - 'ts_paint', 22:12:57 INFO - 'tpaint', 22:12:57 INFO - 'sessionrestore', 22:12:57 INFO - 'sessionrestore_no_auto_restore', 22:12:57 INFO - 'tabpaint']}, 22:12:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['a11yr', 22:12:57 INFO - 'ts_paint', 22:12:57 INFO - 'tpaint', 22:12:57 INFO - 'sessionrestore', 22:12:57 INFO - 'sessionrestore_no_auto_restore', 22:12:57 INFO - 'tabpaint']}, 22:12:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['tsvgx', 22:12:57 INFO - 'tsvgr_opacity', 22:12:57 INFO - 'tart', 22:12:57 INFO - 'tscrollx', 22:12:57 INFO - 'cart', 22:12:57 INFO - 'tsvg_static']}, 22:12:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:12:57 INFO - 'tsvgr_opacity', 22:12:57 INFO - 'tart', 22:12:57 INFO - 'tscrollx', 22:12:57 INFO - 'cart', 22:12:57 INFO - 'tsvg_static']}, 22:12:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:12:57 INFO - 'talos_options': ['--disable-e10s'], 22:12:57 INFO - 'tests': ['tp5o']}, 22:12:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:12:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:12:57 INFO - 'talos_options': ['--disable-e10s', 22:12:57 INFO - '--xperf_path', 22:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:57 INFO - 'tests': ['tp5n']}, 22:12:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:12:57 INFO - 'talos_options': ['--xperf_path', 22:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:57 INFO - 'tests': ['tp5n']}}, 22:12:57 INFO - 'talos.zip': {'path': '', 22:12:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:12:57 INFO - Running post-action listener: _resource_record_post_action 22:12:57 INFO - [mozharness: 2016-12-21 06:12:57.603354Z] Finished populate-webroot step (success) 22:12:57 INFO - [mozharness: 2016-12-21 06:12:57.603472Z] Running create-virtualenv step. 22:12:57 INFO - Running pre-action listener: _resource_record_pre_action 22:12:57 INFO - Running main action method: create_virtualenv 22:12:57 INFO - Creating virtualenv /builds/slave/test/build/venv 22:12:57 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 22:12:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:12:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:12:57 INFO - Using real prefix '/tools/python27' 22:12:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:12:58 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:01 INFO - Installing pip.................done. 22:13:01 INFO - Return code: 0 22:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:13:01 INFO - Reading from file tmpfile_stdout 22:13:01 INFO - Output received: 22:13:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:13:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:02 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')]} 22:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:02 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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:02 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 22:13:02 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 22:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:02 INFO - 'HOME': '/Users/cltbld', 22:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:02 INFO - 'LOGNAME': 'cltbld', 22:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:02 INFO - 'MOZ_NO_REMOTE': '1', 22:13:02 INFO - 'NO_EM_RESTART': '1', 22:13:02 INFO - 'PAGER': '/bin/cat', 22:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:02 INFO - 'PWD': '/builds/slave/test', 22:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:02 INFO - 'SHELL': '/bin/bash', 22:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:02 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:02 INFO - 'USER': 'cltbld', 22:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:02 INFO - 'XPC_FLAGS': '0x0', 22:13:02 INFO - 'XPC_SERVICE_NAME': '0', 22:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:02 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 22:13:02 INFO - Cleaning up... 22:13:02 INFO - Return code: 0 22:13:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:13:02 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')]} 22:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:02 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')]} 22:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:02 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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:02 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 22:13:02 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 22:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:02 INFO - 'HOME': '/Users/cltbld', 22:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:02 INFO - 'LOGNAME': 'cltbld', 22:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:02 INFO - 'MOZ_NO_REMOTE': '1', 22:13:02 INFO - 'NO_EM_RESTART': '1', 22:13:02 INFO - 'PAGER': '/bin/cat', 22:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:02 INFO - 'PWD': '/builds/slave/test', 22:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:02 INFO - 'SHELL': '/bin/bash', 22:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:02 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:02 INFO - 'USER': 'cltbld', 22:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:02 INFO - 'XPC_FLAGS': '0x0', 22:13:02 INFO - 'XPC_SERVICE_NAME': '0', 22:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:02 INFO - Downloading/unpacking psutil>=3.1.1 22:13:02 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 22:13:02 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 22:13:02 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 22:13:02 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 22:13:02 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 22:13:02 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 22:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:05 INFO - Installing collected packages: psutil 22:13:05 INFO - Running setup.py install for psutil 22:13:06 INFO - building 'psutil._psutil_osx' extension 22:13:06 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 22:13:06 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 22:13:06 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 22:13:06 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 22:13:06 INFO - building 'psutil._psutil_posix' extension 22:13:06 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 22:13:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:13:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:13:06 INFO - ^ 22:13:06 INFO - 1 warning generated. 22:13:06 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 22:13:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:06 INFO - Successfully installed psutil 22:13:06 INFO - Cleaning up... 22:13:06 INFO - Return code: 0 22:13:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:13:06 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')]} 22:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:06 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')]} 22:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:06 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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:06 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 22:13:06 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 22:13:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:06 INFO - 'HOME': '/Users/cltbld', 22:13:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:06 INFO - 'LOGNAME': 'cltbld', 22:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:06 INFO - 'MOZ_NO_REMOTE': '1', 22:13:06 INFO - 'NO_EM_RESTART': '1', 22:13:06 INFO - 'PAGER': '/bin/cat', 22:13:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:06 INFO - 'PWD': '/builds/slave/test', 22:13:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:06 INFO - 'SHELL': '/bin/bash', 22:13:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:06 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:06 INFO - 'USER': 'cltbld', 22:13:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:06 INFO - 'XPC_FLAGS': '0x0', 22:13:06 INFO - 'XPC_SERVICE_NAME': '0', 22:13:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:13:09 INFO - Installing collected packages: mozsystemmonitor 22:13:09 INFO - Running setup.py install for mozsystemmonitor 22:13:09 INFO - Successfully installed mozsystemmonitor 22:13:09 INFO - Cleaning up... 22:13:09 INFO - Return code: 0 22:13:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:09 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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:09 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 22:13:09 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 22:13:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:09 INFO - 'HOME': '/Users/cltbld', 22:13:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:09 INFO - 'LOGNAME': 'cltbld', 22:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:09 INFO - 'MOZ_NO_REMOTE': '1', 22:13:09 INFO - 'NO_EM_RESTART': '1', 22:13:09 INFO - 'PAGER': '/bin/cat', 22:13:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:09 INFO - 'PWD': '/builds/slave/test', 22:13:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:09 INFO - 'SHELL': '/bin/bash', 22:13:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:09 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:09 INFO - 'USER': 'cltbld', 22:13:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:09 INFO - 'XPC_FLAGS': '0x0', 22:13:09 INFO - 'XPC_SERVICE_NAME': '0', 22:13:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:10 INFO - Downloading/unpacking jsonschema==2.5.1 22:13:10 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 22:13:10 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 22:13:10 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 22:13:10 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 22:13:10 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 22:13:10 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 22:13:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:13:12 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 22:13:12 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 22:13:12 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 22:13:12 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 22:13:12 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 22:13:12 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 22:13:13 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:13 INFO - warning: no files found matching '*.txt' 22:13:13 INFO - no previously-included directories found matching 'build' 22:13:13 INFO - no previously-included directories found matching 'dist' 22:13:13 INFO - no previously-included directories found matching '.git*' 22:13:13 INFO - Installing collected packages: jsonschema, functools32 22:13:13 INFO - Running setup.py install for functools32 22:13:13 INFO - warning: no files found matching '*.txt' 22:13:13 INFO - no previously-included directories found matching 'build' 22:13:13 INFO - no previously-included directories found matching 'dist' 22:13:13 INFO - no previously-included directories found matching '.git*' 22:13:13 INFO - Successfully installed jsonschema functools32 22:13:13 INFO - Cleaning up... 22:13:13 INFO - Return code: 0 22:13:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:13 INFO - 'HOME': '/Users/cltbld', 22:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:13 INFO - 'LOGNAME': 'cltbld', 22:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:13 INFO - 'MOZ_NO_REMOTE': '1', 22:13:13 INFO - 'NO_EM_RESTART': '1', 22:13:13 INFO - 'PAGER': '/bin/cat', 22:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:13 INFO - 'PWD': '/builds/slave/test', 22:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:13 INFO - 'SHELL': '/bin/bash', 22:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:13 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:13 INFO - 'USER': 'cltbld', 22:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:13 INFO - 'XPC_FLAGS': '0x0', 22:13:13 INFO - 'XPC_SERVICE_NAME': '0', 22:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:13:13 INFO - Cleaning up... 22:13:13 INFO - Return code: 0 22:13:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:13 INFO - 'HOME': '/Users/cltbld', 22:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:13 INFO - 'LOGNAME': 'cltbld', 22:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:13 INFO - 'MOZ_NO_REMOTE': '1', 22:13:13 INFO - 'NO_EM_RESTART': '1', 22:13:13 INFO - 'PAGER': '/bin/cat', 22:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:13 INFO - 'PWD': '/builds/slave/test', 22:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:13 INFO - 'SHELL': '/bin/bash', 22:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:13 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:13 INFO - 'USER': 'cltbld', 22:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:13 INFO - 'XPC_FLAGS': '0x0', 22:13:13 INFO - 'XPC_SERVICE_NAME': '0', 22:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:14 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 22:13:14 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 22:13:14 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 22:13:14 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 22:13:14 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 22:13:14 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 22:13:16 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:16 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 22:13:16 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 22:13:16 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 22:13:16 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 22:13:16 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 22:13:16 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 22:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:18 INFO - Downloading docopt-0.6.1.tar.gz 22:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:18 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:18 INFO - Running setup.py install for blobuploader 22:13:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:18 INFO - Running setup.py install for requests 22:13:18 INFO - Running setup.py install for docopt 22:13:18 INFO - Successfully installed blobuploader requests docopt 22:13:18 INFO - Cleaning up... 22:13:19 INFO - Return code: 0 22:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:19 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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:19 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 22:13:19 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 22:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:19 INFO - 'HOME': '/Users/cltbld', 22:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:19 INFO - 'LOGNAME': 'cltbld', 22:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:19 INFO - 'MOZ_NO_REMOTE': '1', 22:13:19 INFO - 'NO_EM_RESTART': '1', 22:13:19 INFO - 'PAGER': '/bin/cat', 22:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:19 INFO - 'PWD': '/builds/slave/test', 22:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:19 INFO - 'SHELL': '/bin/bash', 22:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:19 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:19 INFO - 'USER': 'cltbld', 22:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:19 INFO - 'XPC_FLAGS': '0x0', 22:13:19 INFO - 'XPC_SERVICE_NAME': '0', 22:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:19 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-QoqxWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:19 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-A6z52E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:19 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-wXY78T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:19 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-SQKxKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:19 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-5qoxpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:19 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-yyCuzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:19 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-gUkR7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-oy7lgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-LtwZps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-LdiYWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-5DVOeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-q_hvoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-2n5FJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Ioq0cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-vJ0QmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:20 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-NTo5DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:21 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-uY5_Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:21 INFO - Running setup.py install for manifestparser 22:13:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:21 INFO - Running setup.py install for mozcrash 22:13:21 INFO - Running setup.py install for mozdebug 22:13:21 INFO - Running setup.py install for mozdevice 22:13:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:13:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:21 INFO - Running setup.py install for mozfile 22:13:21 INFO - Running setup.py install for mozhttpd 22:13:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:21 INFO - Running setup.py install for mozinfo 22:13:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:22 INFO - Running setup.py install for mozInstall 22:13:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:22 INFO - Running setup.py install for mozleak 22:13:22 INFO - Running setup.py install for mozlog 22:13:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:22 INFO - Running setup.py install for moznetwork 22:13:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:22 INFO - Running setup.py install for mozprocess 22:13:22 INFO - Running setup.py install for mozprofile 22:13:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:23 INFO - Running setup.py install for mozrunner 22:13:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:23 INFO - Running setup.py install for mozscreenshot 22:13:23 INFO - Running setup.py install for moztest 22:13:23 INFO - Running setup.py install for mozversion 22:13:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:23 INFO - Cleaning up... 22:13:23 INFO - Return code: 0 22:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:23 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')]} 22:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 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')]} 22:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:23 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 22:13:23 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 22:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:23 INFO - 'HOME': '/Users/cltbld', 22:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:23 INFO - 'LOGNAME': 'cltbld', 22:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:23 INFO - 'MOZ_NO_REMOTE': '1', 22:13:23 INFO - 'NO_EM_RESTART': '1', 22:13:23 INFO - 'PAGER': '/bin/cat', 22:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:23 INFO - 'PWD': '/builds/slave/test', 22:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:23 INFO - 'SHELL': '/bin/bash', 22:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:23 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:23 INFO - 'USER': 'cltbld', 22:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:23 INFO - 'XPC_FLAGS': '0x0', 22:13:23 INFO - 'XPC_SERVICE_NAME': '0', 22:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:23 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ybwEMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:24 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)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Ck6nrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-jYDxfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:24 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)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-KIdRAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-1CLdyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:24 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)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-OAZsTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:24 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)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-TMNwlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:24 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)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-LejN8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:24 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)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-nJ3U10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:24 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)) 22:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:24 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-qX7MtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:25 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)) 22:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:25 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-s6T7Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:25 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)) 22:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:25 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-NxF65F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:25 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)) 22:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:25 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-kDfbf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:25 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)) 22:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:25 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Za02Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:25 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-phhgnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:25 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)) 22:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:25 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-pfSkIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:25 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)) 22:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:25 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Tq2G4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:25 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)) 22:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:13:25 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)) 22:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:13:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:25 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 22:13:25 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 22:13:25 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 22:13:25 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 22:13:25 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 22:13:25 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 22:13:28 INFO - Downloading blessings-1.6.tar.gz 22:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:28 INFO - Installing collected packages: blessings 22:13:28 INFO - Running setup.py install for blessings 22:13:28 INFO - Successfully installed blessings 22:13:28 INFO - Cleaning up... 22:13:28 INFO - Return code: 0 22:13:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:29 INFO - Reading from file tmpfile_stdout 22:13:29 INFO - Current package versions: 22:13:29 INFO - blessings == 1.6 22:13:29 INFO - blobuploader == 1.2.4 22:13:29 INFO - docopt == 0.6.1 22:13:29 INFO - functools32 == 3.2.3-2 22:13:29 INFO - jsonschema == 2.5.1 22:13:29 INFO - manifestparser == 1.1 22:13:29 INFO - mozInstall == 1.12 22:13:29 INFO - mozcrash == 1.0 22:13:29 INFO - mozdebug == 0.1 22:13:29 INFO - mozdevice == 0.49 22:13:29 INFO - mozfile == 1.2 22:13:29 INFO - mozhttpd == 0.7 22:13:29 INFO - mozinfo == 0.9 22:13:29 INFO - mozleak == 0.1 22:13:29 INFO - mozlog == 3.4 22:13:29 INFO - moznetwork == 0.27 22:13:29 INFO - mozprocess == 0.23 22:13:29 INFO - mozprofile == 0.28 22:13:29 INFO - mozrunner == 6.13 22:13:29 INFO - mozscreenshot == 0.1 22:13:29 INFO - mozsystemmonitor == 0.3 22:13:29 INFO - moztest == 0.7 22:13:29 INFO - mozversion == 1.4 22:13:29 INFO - psutil == 3.1.1 22:13:29 INFO - requests == 1.2.3 22:13:29 INFO - wsgiref == 0.1.2 22:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:29 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 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:29 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 22:13:29 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 22:13:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:29 INFO - 'HOME': '/Users/cltbld', 22:13:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:29 INFO - 'LOGNAME': 'cltbld', 22:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:29 INFO - 'MOZ_NO_REMOTE': '1', 22:13:29 INFO - 'NO_EM_RESTART': '1', 22:13:29 INFO - 'PAGER': '/bin/cat', 22:13:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:29 INFO - 'PWD': '/builds/slave/test', 22:13:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:29 INFO - 'SHELL': '/bin/bash', 22:13:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:29 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:29 INFO - 'USER': 'cltbld', 22:13:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:29 INFO - 'XPC_FLAGS': '0x0', 22:13:29 INFO - 'XPC_SERVICE_NAME': '0', 22:13:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 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)) 22:13:29 INFO - Cleaning up... 22:13:29 INFO - Return code: 0 22:13:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f589b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f58c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2456480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, '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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 22:13:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:13:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:29 INFO - 'HOME': '/Users/cltbld', 22:13:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:29 INFO - 'LOGNAME': 'cltbld', 22:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:29 INFO - 'MOZ_NO_REMOTE': '1', 22:13:29 INFO - 'NO_EM_RESTART': '1', 22:13:29 INFO - 'PAGER': '/bin/cat', 22:13:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:29 INFO - 'PWD': '/builds/slave/test', 22:13:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:29 INFO - 'SHELL': '/bin/bash', 22:13:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:29 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:29 INFO - 'USER': 'cltbld', 22:13:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:29 INFO - 'XPC_FLAGS': '0x0', 22:13:29 INFO - 'XPC_SERVICE_NAME': '0', 22:13:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:13:29 INFO - Cleaning up... 22:13:29 INFO - Return code: 0 22:13:29 INFO - Running post-action listener: _resource_record_post_action 22:13:29 INFO - Running post-action listener: _start_resource_monitoring 22:13:29 INFO - Starting resource monitoring. 22:13:29 INFO - [mozharness: 2016-12-21 06:13:29.646690Z] Finished create-virtualenv step (success) 22:13:29 INFO - [mozharness: 2016-12-21 06:13:29.647663Z] Running install step. 22:13:29 INFO - Running pre-action listener: _resource_record_pre_action 22:13:29 INFO - Running main action method: install 22:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:29 INFO - Reading from file tmpfile_stdout 22:13:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:30 INFO - Reading from file tmpfile_stdout 22:13:30 INFO - Output received: 22:13:30 INFO - Usage: mozinstall [options] installer 22:13:30 INFO - Options: 22:13:30 INFO - -h, --help show this help message and exit 22:13:30 INFO - -d DEST, --destination=DEST 22:13:30 INFO - Directory to install application into. [default: 22:13:30 INFO - "/builds/slave/test"] 22:13:30 INFO - --app=APP Application being installed. [default: firefox] 22:13:30 INFO - mkdir: /builds/slave/test/build/application 22:13:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:13:52 INFO - Reading from file tmpfile_stdout 22:13:52 INFO - Output received: 22:13:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:13:52 INFO - Running post-action listener: _resource_record_post_action 22:13:52 INFO - [mozharness: 2016-12-21 06:13:52.121568Z] Finished install step (success) 22:13:52 INFO - [mozharness: 2016-12-21 06:13:52.121729Z] Running run-tests step. 22:13:52 INFO - Running pre-action listener: _resource_record_pre_action 22:13:52 INFO - Running main action method: run_tests 22:13:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:13:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:13:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:13:52 INFO - 2016-12-20 22:13:52.136 screenresolution[1986:15919] starting screenresolution argv=screenresolution get 22:13:52 INFO - 2016-12-20 22:13:52.138 screenresolution[1986:15919] Display 0: 1600x1200x32@60 22:13:52 INFO - 2016-12-20 22:13:52.144 screenresolution[1987:15922] starting screenresolution argv=screenresolution list 22:13:52 INFO - Available Modes on Display 0 22:13:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:13:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:13:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:13:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:13:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:13:52 INFO - Intel Iris: 22:13:52 INFO - Chipset Model: Intel Iris 22:13:52 INFO - Type: GPU 22:13:52 INFO - Bus: Built-In 22:13:52 INFO - VRAM (Dynamic, Max): 1536 MB 22:13:52 INFO - Vendor: Intel (0x8086) 22:13:52 INFO - Device ID: 0x0a2e 22:13:52 INFO - Revision ID: 0x0009 22:13:52 INFO - Displays: 22:13:52 INFO - Display: 22:13:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:13:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:13:52 INFO - Display Serial Number: 1600x1200 60 22:13:52 INFO - Main Display: Yes 22:13:52 INFO - Mirror: Off 22:13:52 INFO - Online: Yes 22:13:52 INFO - Rotation: Supported 22:13:52 INFO - Return code: 0 22:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:52 INFO - Python 2.7.3 22:13:52 INFO - Return code: 0 22:13:52 INFO - grabbing minidump binary from tooltool 22:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:13:52 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 0x10f367d30>, '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 0x10f28edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f35cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:52 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 22:13:52 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 22:13:52 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 22:13:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:52 INFO - Return code: 0 22:13:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:13:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:13:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0181 --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 22:13:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z5JoPOEzLf/Render', 22:13:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:13:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:13:52 INFO - 'HOME': '/Users/cltbld', 22:13:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:13:52 INFO - 'LOGNAME': 'cltbld', 22:13:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:52 INFO - 'MOZ_NO_REMOTE': '1', 22:13:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:52 INFO - 'NO_EM_RESTART': '1', 22:13:52 INFO - 'PAGER': '/bin/cat', 22:13:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:52 INFO - 'PWD': '/builds/slave/test', 22:13:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:13:52 INFO - 'SHELL': '/bin/bash', 22:13:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbqMKnSDGC/Listeners', 22:13:52 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 22:13:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:13:52 INFO - 'USER': 'cltbld', 22:13:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:13:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:52 INFO - 'XPC_FLAGS': '0x0', 22:13:52 INFO - 'XPC_SERVICE_NAME': '0', 22:13:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:13:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 22:13:52 INFO - mozversion application_buildid: 20161220202254 22:13:52 INFO - mozversion application_changeset: 19a951289cad3bbfa1f01470f0a9e7d515443c79 22:13:52 INFO - mozversion application_display_name: Nightly 22:13:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:52 INFO - mozversion application_name: Firefox 22:13:52 INFO - mozversion application_remotingname: firefox 22:13:52 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 22:13:52 INFO - mozversion application_vendor: Mozilla 22:13:52 INFO - mozversion application_version: 53.0a1 22:13:52 INFO - mozversion platform_buildid: 20161220202254 22:13:52 INFO - mozversion platform_changeset: 19a951289cad3bbfa1f01470f0a9e7d515443c79 22:13:52 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 22:13:52 INFO - mozversion platform_version: 53.0a1 22:13:52 INFO - using testdate: 1482300832 22:13:52 INFO - actual date: 1482300832 22:13:52 INFO - starting webserver on 'localhost:52119' 22:13:52 INFO - SUITE-START | Running 2 tests 22:13:52 INFO - TEST-START | dromaeo_css 22:13:52 INFO - operating with platform_type : mac_ 22:13:52 INFO - Initialising browser for dromaeo_css test... 22:13:52 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmp6lasVd/profile http://localhost:52119/getInfo.html) 22:13:54 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 22:13:54 INFO - PROCESS | 1997 | colorDepth:24 22:13:54 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 22:13:54 INFO - PROCESS | 1997 | __metrics 22:13:55 INFO - PROCESS | 1997 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:13:55 INFO - PROCESS | 1997 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:13:55 INFO - TEST-INFO | 1997: exit 0 22:13:55 INFO - Browser initialized. 22:13:55 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:55 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmp6lasVd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:07 INFO - PROCESS | 1999 | RSS: Main: 237735936 22:14:07 INFO - PROCESS | 1999 | 22:14:59 INFO - PROCESS | 1999 | 1482300899238 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] 22:17:10 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:52119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52119/tests/dromaeo/cssquery-ext.html) 22:17:13 INFO - PROCESS | 1999 | RSS: Main: 529973248 22:17:13 INFO - PROCESS | 1999 | 22:20:17 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:52119/tests/dromaeo/cssquery-ext.html (next: http://localhost:52119/tests/dromaeo/cssquery-jquery.html) 22:20:17 INFO - PROCESS | 1999 | RSS: Main: 456048640 22:20:17 INFO - PROCESS | 1999 | 22:23:20 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:52119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52119/tests/dromaeo/cssquery-mootools.html) 22:23:20 INFO - PROCESS | 1999 | RSS: Main: 345870336 22:23:20 INFO - PROCESS | 1999 | 22:26:23 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:52119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52119/tests/dromaeo/cssquery-prototype.html) 22:26:23 INFO - PROCESS | 1999 | RSS: Main: 357728256 22:26:23 INFO - PROCESS | 1999 | 22:29:27 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:52119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52119/tests/dromaeo/cssquery-yui.html) 22:29:27 INFO - PROCESS | 1999 | RSS: Main: 340688896 22:29:27 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:52119/tests/dromaeo/cssquery-yui.html (next: http://localhost:52119/tests/dromaeo/cssquery-dojo.html) 22:32:31 INFO - PROCESS | 1999 | RSS: Main: 459255808 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | __start_tp_report 22:32:31 INFO - PROCESS | 1999 | _x_x_mozilla_page_load 22:32:31 INFO - PROCESS | 1999 | _x_x_mozilla_page_load_details 22:32:31 INFO - PROCESS | 1999 | |i|pagename|runs| 22:32:31 INFO - PROCESS | 1999 | |0;dojo.html;3228.451163302239;3245.6754324567546;3264.6082470103593;3294.621118571365;3325.634180240173;5477.561795056396;5559.58303127265;5573.498385145336;5634.633748806325;5638.577106716992;5580.051391263485;5607.831765047055;5653.9151912721345;5684.062129748597;5700.800471983482;5076.6700164489375;5086.618503612244;5099.133147364957;5114.462981386957;5170.043541944752;5173.974130129344;5251.186066159751;5268.367795864501;5271.499207575274;5325.094733895247;5037.068142393632;5180.326557547494;5203.9219411708855;5239.161734122522;5241.711705856176;5082.517160869711;5115.335006449175;5121.667091639031;5126.102931986925;5126.6923984561045;5034.421041580228;5074.974625126888;5084.618653600958;5094.77073531692;5099.5410413063;5552.305961754781;5555.583331250173;5558.082916318843;5560.666360018412;5563.944360556424;6033.064874944391;6041.6072955258205;6042.425969532887;6050.485708714765;6051.304100028465;6124.571280010401;6126.509879209652;6127.708789264043;6162.476189523896;6166.445019948226;5672.205891175238;5737.995850726106;5749.942500574983;5755.136729490568;5755.510781583613;6189.907151392733;6212.937870621236;6215.223097112861;6230.56386052981;6234.470070044097;6022.69886505673;6022.939770602326;6034.155218269446;6035.124906888476;6083.057126145454;4882.487338829443;5891.49922256613;5936.8812623748145;5941.257342832146;6109.495762817132;6129.307718812861;6140.820008896867;6140.846478838065;6144.109104179869;6157.0456579230295;6141.017437210025;6152.907706384408;6154.1999540059505;6160.322364539897;6217.036359364306;4812.230043193073;4842.903141937141;4845.491223421561;4902.779374928136;4934.5312195341385;4354.586314300136;4359.629431498295;4368.956310436918;4385.254506733863;4422.977885110554;5607.579431542569;5643.746031428595;5645.096784514458;5647.830565083054;5651.576131790132;6054.39456054391;6117.188044311343;6120.204373431426;6121.392004143319;6127.220070483952;5666.178404131378;5670.432956704379;5674.06377947634;5679.346875109415;5719.971400143056;5374.704391258519;5382.2464854920345;5384.6499977501335;5394.433584473652;5395.163749618815;6132.845047373359;6187.071939208975;6187.133801267736;6269.247690277196;6272.968635156795;6101.853092873148;6106.885399019288;6140.995089002448;6180.598261113013;6207.472364848858;6207.968960155351;6213.03697926822;6213.130161777445;6223.937760622336;6286.15136956505;5966.433188847052;5979.342272349951;6119.724612392364;6120.08198770188;6132.662703551169;6025.849353766015;6095.634261944298;6097.542684298606;6104.428839602322;6139.754409823557;6010.338862725184;6018.4884284834525;6028.975074237478;6031.4270144336215;6039.033754599419;5962.433568810956;6002.939970600412;6005.819825405245;6015.218021657157;6018.909716354346;5675.77296908119;5704.3725190228215;5831.970840145772;5843.328017278068;5853.707314634166;6000.489958353589;6003.739214764773;6010.398960103955;6016.067509536029;6020.969895150496;5757.65454072757;5798.797042103675;5826.184334193301;5859.648421094748;5943.078822782476 22:32:31 INFO - PROCESS | 1999 | |1;ext.html;443.2885219223145;447.76044816023426;461.142275367816;489.24167540312516;562.836777334573;32187.51718724221;38257.42613860791;39530.80234598827;39798.00504987377;39927.60072399275;40806.7959660202;41383.379249311285;41450;41450.792746036226;41524;8382.622781974795;9215.585298661543;9442.291828112919;9457.668981585646;9465.195458386046;8398.580070996457;10993.835092473619;11277.605283815068;11301.03941164998;11462.025727813105;11243.775124497504;11300.434978251096;11320.320780753182;11327.320360778338;11332.773344533105;8431;11235;11331.603393881256;11335.659930202108;11351.375674337949;8394.706185283485;9416.764580885465;10884.67345979614;11220;11375;38287.85136445911;38443.23113537741;38831.41752873709;38877.41683874744;38912.80543597292;2902.7532659723947;3416.572928383952;3431.725461963037;3510.6664866837864;3889.3776995680555;28524.286892827637;29752.107436776932;29769.106926792232;29789.70210297891;30343.393132137233;3182.618085829692;3292.0453068610072;3339.716124129452;3371.039253812676;3372.443546814797;468264.99999999657;470555;473311;473899;475438;54063.72968135134;54248.74507529482;54315.45684543183;54334;54404;50285.49714502808;61403.62280074549;61489.23938310778;61551;61639.69180154071;15402.46091386796;15874.841251587337;15924.92037539805;15938.840611593736;15941.681166376608;10971.890281097087;11283.435828208556;12364.44360003784;12425.689357766129;12427.627171184879;14295.213763242913;15000.624984375478;15227.695446091016;15352.923235383752;15462.845371546366;6189.81430557084;6225.750969961151;6693.732250710014;6716.496262780311;6776.576918847098;869.7043005378201;948.5162567090696;1000.8048430556117;1029.351508549609;1052.2371280821496;29587.704122958494;29618.851905740332;29776.904059809898;29879.10362689123;29987.700122998926;1003.3177439341172;1062.718379629399;1067.6049861551276;1132.2923173016864;1175.1186610042469;12511.624651260478;14847.034942728687;15309.540713778382;15513.689726205414;15677.764833527506;562985;563855;564494;570895.1455242697;571060;55450.445495544525;55712.16431753527;55715;55760.442395576334;55959.88080238373;1227.2391117507202;1283.377561882505;1347.6765576261823;1383.384393944685;1398.098226643809;27420.862895685394;27750.306242344104;29428.525724341467;29906.70093299126;30561.847190763903;37021.81489092537;46911.765441172574;46939;47052.29421558611;47077.529224707316;464085;566249;570675;573023.1348843229;573929;23154;23461;23976.160834370712;23976.520469590163;24715;39886.40170397388;39977.60022399739;40749.38875916805;40823.97940051522;41117.79441102775;34063.97808065762;34171.14572135716;34195.4870676945;34999.4750078744;35335;28960.855195723885;34174.82912585421;34243.4358029001;34652.960411187705;34879.47680784739;29665.40669186561;32173;33466.665333346355;34112.48831267483;34240.657593424745;26875.924963002042;29198.978035768647;30821.921232756747;30840.92056778002;30957.535636965913;23140.652890207;23425.297241082793;23706.170284039978;23771.762282376956;24168.791560421556 22:32:31 INFO - PROCESS | 1999 | |2;jquery.html;355.6177109607173;368.1514109976505;376.6045652065331;382.906187983944;409.27762499188935;14365.42538298468;14758.852411475882;15896;18982.62034759304;19734;18302.63394732108;19852.50368740782;20473.692894606593;20647;20717;5313.57491400687;5771.134329850514;5808.4481974212595;5823.417658234185;5823.650580965134;4852.927206091911;6328.493720502349;6396.840078998016;6471.644059576722;6487.902681459782;6122.448979591836;6272.68636568172;6396.488280937537;6412.39082287182;6425.678716064202;6333.87332253357;6335.176427064475;6385.648789316586;6392.936070639281;6405.967970160166;5324.1747529133045;5463.48096930791;5520.503154716095;5522.696251706155;5536.806211782608;24357.147499837596;25050.749492505023;25109.121180758586;25124.371890702696;25424.364390890376;2208.4920468292385;2246.542345382232;2286.4398222435443;2376.7266764322153;2405.482821193434;8530;14936.850631493764;15112.924435377863;15144.772828407582;15766.921165394215;1727.75811386406;1749.7112976358885;1766.0816375484806;1792.9462116136538;1794.8294911983342;85443;113131.43434282858;114263.42868285606;116278;116637;9973.700788976343;10046.849297260547;10047.698569042941;10440.634577789893;10751;13420.328983550784;13449.193048417126;13459.932700336436;13461.730765384638;13487.460501580023;8052.919470805217;8344.749657510285;8349.248567628943;8491.19333663301;8501.914980850112;8363.121872203332;8375.371847111492;8412.873806892901;8566.52884091381;8574.056853746082;5450.700211488327;5710.886377156415;6019.277686677627;6444.838879027968;6458.257300410419;1539.8845086618323;1789.2932291744687;1828.606849527358;1829.2865782344895;1830.3319288459882;788.8640357884627;888.4314039015036;957.9760505987267;997.9301448898508;1003.4581326083979;18742.344017959305;21235.893820530797;21256;21317.25389611356;21365.78634213638;929.9442033478012;942.990570094304;958.9818659815352;960.2893858544767;1022.6676330192718;8787.604557794915;8963.596638151299;10782.838257426145;11273;11374.14693897961;407849;409351;412915;416471;434635;63180.87159206022;75880.62059689667;99598.00401996032;109248;113009.43495282471;916.757059379265;958.6980101268217;1024.1499555369176;1024.4416792847917;1024.9692509224735;19277.8072219276;19678.508037299183;19688.90155549213;19693.40919772409;19704.507387315432;47037;48517.51482485271;49030;49547.25679114888;50872.74563627158;68327.65836170787;68640;68912.65543672249;69670.65164674145;70039.64980175067;7000.124984376953;7253.492255542062;7746.186650401627;7827.804304892423;7929.881051784112;11743.882561174622;12493.375331233583;12699.746005079662;13179.934100329821;13217.603471895858;7772.572508512086;8736.91263087361;10663.786724265627;10926.453677316262;11664.416779161178;10915.454227288763;11028;11279.943600282275;11387.601433949772;11669;11002.944985275022;11074.501647426046;11114.83294254124;11370.94314528422;11448.484818183368;6946.583205007716;8039.356851451753;8153.02163740355;8197.95901020515;8398.118197589165;9252.537373131181;9829.262805289774;10366.948165259126;11220.214584978972;11295.209335346446 22:32:31 INFO - PROCESS | 1999 | |3;mootools.html;1305.8834696334634;1528.39628346803;1703.190984282466;1905.1141219333008;1940.9708854367177;8103.108658047618;8557.91442085579;8562.400631955765;8563.700270490519;8582.313414926806;6746.662666866661;7404;7703.306702396797;7709.537427754339;8369.581520923944;1977.9703304450445;2294.6558016297563;2328.4528135888054;2341.672165896776;2344.8006919411787;1984;2332.323626148415;2347.072906202049;2366.100881664965;2370.739218685952;2214.3689048621145;2233.20721143994;2242.316093591454;2243.2597242909883;2248.9887550562307;2214.5716013171495;2252;2255.8984845681985;2257.085880218514;2289.553537060274;2282.132789539981;2308.619077852169;2310.803581695558;2312.861228326306;2319.512902290521;8354.8329033419;8358.623861926168;8460.323174146053;8469.49183049013;8471.407001509897;4733.290006499018;5214.191800270926;5216.843494695166;5217.321748172713;5218.66078704883;3269.1500209945348;3362.3947689415895;3572.7499075064757;3579.2125732338845;3585.15748799032;937.5921474158763;1055.1400608504046;1062.2988827373897;1079.433297518801;1095.058249905081;10745.194110441747;10760.300580462244;10906.781864362669;10921.726956826064;10928.180386471047;3354.5806774152743;4189.224993376235;4255.106427650167;4262.381954616563;4545.977270113628;9399.389039712396;9422.95288523553;9429.575669094907;9440.811183776286;9460.621575137055;4347.956520434818;5174.689518628894;5174.741262936838;5175.120229560984;5176.818811341585;4258;4373;4420.801063952065;4712.175369310357;4755;3712.925741485155;3740.102375429877;3828.3300422425964;3852.3451013327804;3882.9805850970565;1268.8287081244098;1273.420593629896;1278.6803299175206;1287.4463980488292;1292.9482820687256;834.3158609939791;896.8385690575759;905.5427009360362;924.3852837862746;925.9120383563685;5480.205370221295;5641.2384328116;5791.333996590446;5809.854753631109;5906.527477801766;399.22948708991345;434.98260069596864;447.4339959950665;448.08143306222115;454.6590057456907;3723.94414083789;3766.322062028806;3811.0281878121455;3902.2195560887935;3926.764394136361;9688.854667179998;9992.15223661253;10112.342697724771;10133.797324053477;10138.797224055477;10040.64857729976;10043.648472303581;10047.296689231684;10060.295779295526;10068.798624027624;7124.3944264738075;7274.199838017919;7636.274553917369;7662.080550333995;7662.348700360531;5520.1443776214755;5539.639923404966;5544.916826247691;5561.916571251353;5701.087825947829;7583.886241706489;8868.379213454997;9196.35625506208;9240.214581760625;9375.156235938799;7792.259735325135;9072.228860546928;9175.54122293896;9366.438013719198;9456.858147127661;6557.540972131905;6793.93206067933;6806;6997.790066298019;7116.110486189226;7690.577018263825;7960.004999375078;7966.442349035512;8089.757307280791;8090.220151566646;6947.79156625302;7102.289771022856;7182.5634873024555;7259.564426134449;7346.6326683666675;6923.723051078102;7077.469189810888;7100.147982242164;7185.425165986604;7188.784336469915;6663.866722665616;6751.257361690112;6767.830804229934;6771.695273712793;6789.89815152783;4755.595774359218;4817.108834865561;4823.397075365579;4875.585575226146;4970.105381031449;4036.233115708006;4820.325154478306;4944.381952255968;4982.676126051795;4982.950170498249 22:32:31 INFO - PROCESS | 1999 | |4;prototype.html;334.87609584453753;338.3224351301355;344.92239246169606;350.9070096424448;355.4590848671011;4566.1780879441685;5126.974605078985;5173.249878767577;5250.317458730369;5259.368875734913;4090.345544712839;4631.7684115794245;4912.312276281324;5125.282460455539;5158.123119069758;3913.6086391360923;3915.941260881089;4014.7591144531275;4035.1929614077153;4088.7546747195265;3404.5360494987144;3422.606400263964;4048.360414032322;4112.321466957948;4115.283912617673;3308.470644696849;3740.962590374102;3914.4128380742973;4047.1298670785777;4085.1829634073156;3453.4301840196335;3919.098607320318;3924.862629807943;3946.2636439966323;3949.7037722170953;3388.4578467445335;3398.694117529434;3407.2163402417336;3410.2838403934957;3423.6918677318913;4027.2952233359047;4315.755806980353;4573.359729637853;5122.180451127839;5129.692218466904;3601.873934412283;4453.216739537789;4453.710508816916;4456.754878481682;4534.591886730177;5474.233607294982;5496.7526461308935;5532.889342213133;5537.861553461195;5540.612157148961;3693.279810436966;3708.8516459341595;3711.3319602471543;3723.6090210528046;3724.5344331958504;4089.2230476209425;5690.784706640735;5755.712214389264;5848.385919478436;5850.385709500526;3460.823320071188;3969.4717533749713;4027.2348253832265;4027.375756757707;4041.8989525262105;3544.5392099026963;3878.650921417086;4094.2016306819883;4102.687140115194;4112.300908845504;4414.867553973386;4520.638348932078;4667.486576476585;4708.623310135181;4718.127146477913;4629.236176030984;5550.111982082928;5578.54957710998;5595.64982707264;5656.321241451053;1047.7328281288376;1201.9278843269433;1213.5801112698164;1309.3845892430543;1334.6596617862383;834.4367551902442;876.6543355948716;896.6771962093641;922.285228947571;949.4113649537193;3893.165232246235;4707.741074240949;4846.709197448094;4879.951200488021;4884.5603895649565;4352.564743525685;4453.955460445419;4616.815327386934;5013.699178049329;5388.353397592314;4045.6561192298986;4126.855560055384;4640.535946405333;4842.491538388489;4922.680025798311;2504.6743923289855;2553.4510080332448;2575.987120064388;2670.838185389362;2857.528507796232;4868.95131048692;5535;5539.612227144142;5550.72246387679;5573.21974923503;4485.398468888037;4730.834420795256;5097.439281679012;5133.666311689728;5399.271098401744;4699.530046995274;5279.709615971082;5570.41510641385;5587.770690448095;5595.944040559623;5369.973150134224;5399.676019438846;5406.675599464044;5406.7296635167295;5417.51242388187;4504.891624778892;5585.69278689676;5626.483447845097;5665.688387138747;5680.4319568042865;4760.952390476051;5019.7490125494305;5466;5578.721063946868;5893.941060589511;3722.8696995606106;3728.217074414403;3735.6451137141926;3745.932409263347;3747.681447077029;5284.81503147388;5573.526250268773;5659.971700141473;5732.980370610759;5776.855578610568;4743.66794324394;4907.4847141051105;5501.559875209893;5537.169424586345;5564.749586268708;5201.1678131498775;5451.918221226605;5471.917921231265;5524.944750552443;5599.608027438203;4348.760818154905;5236.376723215815;5406.621536492407;5436.320459942507;5445.26488924006;4118.217538667644;5427.565794736491;5462.508374246178;5577.271045975761;5626.521745651666;4996.475370086234;5422.861199148223;5457.918131228114;5471.863203419946;5517.420670829666 22:32:31 INFO - PROCESS | 1999 | |5;yui.html;709.0182938686374;741.614360532523;747.9214682458341;775.9873365258336;788.3338578900834;15047;15219.923900380483;15678.845106046878;15735.763963540541;15760.05439673619;11952.880471195285;14172.362243699032;14187;14201.573952781408;14232.92883535581;704.6018999265424;726.4478995963053;871.5467956662532;880.3661363818056;909.4997751236793;891.7503099132254;897.6005677473527;900.3067637918798;900.9459432434043;909.2998391238742;966.0194902174298;968.2012339819642;968.5351031504882;973.4548652754445;979.4025644356936;963.0225321298888;964.4888209249109;966.4008314844806;967.7870868408938;967.796762679838;551.555997422075;570.8687001989524;692.1106378303906;717.0857157124656;727.6216367488929;14285.21431321277;14318.713625727427;14475.348609312607;14502.492412765609;14605.05067170641;12192;13159.736805263841;13161.144525605805;13192.274424906625;13273.601791946257;11416.71458213543;12270.38648067593;12294.323812190327;12308.507659693601;12415;4362.302031674949;4401.757903315316;4411.139827733561;4448.021435284232;4493.752843593601;75855.24144758537;100351.49472757915;102343.48828255886;103469.482652587;108602.45698771534;10470.267081304388;10513.684589462327;10603.310784798963;10698.304610200312;11021.44892755375;20600.484987875123;20691.379258621964;20773.688394674093;20793.58412831735;20808.791912080684;7463.290987356192;7534.924650753532;7541.73603923871;7599.582022988789;7760.456768026297;4216.9789151054665;4257.57424257578;4317.633001194934;4329.610335069859;4452.109578084396;3309.6028476582965;3325.368180045832;3411.0790086676457;3419.709324707378;3420.350133474632;637.1494055435952;638.1480723234441;638.5370606310481;646.6669665122465;661.6493258572964;580.9041508151192;588.4733163818358;598.9713533287448;620.0964925792149;624.4442446222865;8605.698800541952;8749.343799215085;8771.868421973548;8844.46933184011;8847.557622118868;553.593109064837;585.6515373352848;595.1727099331932;624.1698540940629;640.724488469953;4285.507166675872;4288.592583704543;4295.098029413858;4319.003016035735;4463.977680111579;89201.55399222963;95469;99135.50432247936;102039;102220.97779022263;73149;74087.25912740911;74575.62712186512;80162;81679.18320816835;72460.63769681117;73044;74452;75218.58893282656;75500.62249688717;9164.495952722664;9858.260630452889;9874.160696340892;9878.357906736326;9883.50582470888;42562.36156457718;49033.50966490432;49245.50754492409;49665.751671241414;52250.73874630754;67206;69495.65252173707;69824.65087674529;71782.64108679423;72885.08459661555;12297.32364719949;12325.876741232472;12710.173838700455;12787.552435664707;13233.751064124632;13055.608331750063;13094.607161785161;13276.137051092035;13307.46770129184;13563.86436135626;9661.855072174063;13102.934485327512;13200.339983001004;13921.651958701113;13932.721345573234;12854.871451285742;13190.142640728322;13290.335483225994;13321;13342;12724.618261452171;13107.606771796862;13428.19430834153;13542.796858047333;13833.031687781759;9907.801843963225;9971.002899710262;10796.634247623047;11299.548018079186;11496.080313575061;11197.384143872165;11238.943805280922;11312.490937907649;11384.715382115513;11428.599998999995 22:32:31 INFO - PROCESS | 1999 | __end_tp_report 22:32:31 INFO - PROCESS | 1999 | __start_cc_report 22:32:31 INFO - PROCESS | 1999 | _x_x_mozilla_cycle_collect,3310 22:32:31 INFO - PROCESS | 1999 | __end_cc_report 22:32:31 INFO - PROCESS | 1999 | __startTimestamp1482301951417__endTimestamp 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | ------- Summary: start ------- 22:32:31 INFO - PROCESS | 1999 | Number of tests: 6 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | [#0] dojo.html Cycles:165 Average:5651.13 Median:5843.33 stddev:624.84 (10.7%) stddev-sans-first:597.15 22:32:31 INFO - PROCESS | 1999 | Values: 3228.5 3245.7 3264.6 3294.6 3325.6 5477.6 5559.6 5573.5 5634.6 5638.6 5580.1 5607.8 5653.9 5684.1 5700.8 5076.7 5086.6 5099.1 5114.5 5170.0 5174.0 5251.2 5268.4 5271.5 5325.1 5037.1 5180.3 5203.9 5239.2 5241.7 5082.5 5115.3 5121.7 5126.1 5126.7 5034.4 5075.0 5084.6 5094.8 5099.5 5552.3 5555.6 5558.1 5560.7 5563.9 6033.1 6041.6 6042.4 6050.5 6051.3 6124.6 6126.5 6127.7 6162.5 6166.4 5672.2 5738.0 5749.9 5755.1 5755.5 6189.9 6212.9 6215.2 6230.6 6234.5 6022.7 6022.9 6034.2 6035.1 6083.1 4882.5 5891.5 5936.9 5941.3 6109.5 6129.3 6140.8 6140.8 6144.1 6157.0 6141.0 6152.9 6154.2 6160.3 6217.0 4812.2 4842.9 4845.5 4902.8 4934.5 4354.6 4359.6 4369.0 4385.3 4423.0 5607.6 5643.7 5645.1 5647.8 5651.6 6054.4 6117.2 6120.2 6121.4 6127.2 5666.2 5670.4 5674.1 5679.3 5720.0 5374.7 5382.2 5384.6 5394.4 5395.2 6132.8 6187.1 6187.1 6269.2 6273.0 6101.9 6106.9 6141.0 6180.6 6207.5 6208.0 6213.0 6213.1 6223.9 6286.2 5966.4 5979.3 6119.7 6120.1 6132.7 6025.8 6095.6 6097.5 6104.4 6139.8 6010.3 6018.5 6029.0 6031.4 6039.0 5962.4 6002.9 6005.8 6015.2 6018.9 5675.8 5704.4 5832.0 5843.3 5853.7 6000.5 6003.7 6010.4 6016.1 6021.0 5757.7 5798.8 5826.2 5859.6 5943.1 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | [#1] ext.html Cycles:180 Average:65401.38 Median:34088.23 stddev:141960.76 (416.5%) stddev-sans-first:142275.22 22:32:31 INFO - PROCESS | 1999 | Values: 443.3 447.8 461.1 489.2 562.8 32187.5 38257.4 39530.8 39798.0 39927.6 40806.8 41383.4 41450.0 41450.8 41524.0 8382.6 9215.6 9442.3 9457.7 9465.2 8398.6 10993.8 11277.6 11301.0 11462.0 11243.8 11300.4 11320.3 11327.3 11332.8 8431.0 11235.0 11331.6 11335.7 11351.4 8394.7 9416.8 10884.7 11220.0 11375.0 38287.9 38443.2 38831.4 38877.4 38912.8 2902.8 3416.6 3431.7 3510.7 3889.4 28524.3 29752.1 29769.1 29789.7 30343.4 3182.6 3292.0 3339.7 3371.0 3372.4 468265.0 470555.0 473311.0 473899.0 475438.0 54063.7 54248.7 54315.5 54334.0 54404.0 50285.5 61403.6 61489.2 61551.0 61639.7 15402.5 15874.8 15924.9 15938.8 15941.7 10971.9 11283.4 12364.4 12425.7 12427.6 14295.2 15000.6 15227.7 15352.9 15462.8 6189.8 6225.8 6693.7 6716.5 6776.6 869.7 948.5 1000.8 1029.4 1052.2 29587.7 29618.9 29776.9 29879.1 29987.7 1003.3 1062.7 1067.6 1132.3 1175.1 12511.6 14847.0 15309.5 15513.7 15677.8 562985.0 563855.0 564494.0 570895.1 571060.0 55450.4 55712.2 55715.0 55760.4 55959.9 1227.2 1283.4 1347.7 1383.4 1398.1 27420.9 27750.3 29428.5 29906.7 30561.8 37021.8 46911.8 46939.0 47052.3 47077.5 464085.0 566249.0 570675.0 573023.1 573929.0 23154.0 23461.0 23976.2 23976.5 24715.0 39886.4 39977.6 40749.4 40824.0 41117.8 34064.0 34171.1 34195.5 34999.5 35335.0 28960.9 34174.8 34243.4 34653.0 34879.5 29665.4 32173.0 33466.7 34112.5 34240.7 26875.9 29199.0 30821.9 30840.9 30957.5 23140.7 23425.3 23706.2 23771.8 24168.8 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | [#2] jquery.html Cycles:180 Average:28293.39 Median:379.76 stddev:70212.02 (18488.7%) stddev-sans-first:70377.65 22:32:31 INFO - PROCESS | 1999 | Values: 355.6 368.2 376.6 382.9 409.3 14365.4 14758.9 15896.0 18982.6 19734.0 18302.6 19852.5 20473.7 20647.0 20717.0 5313.6 5771.1 5808.4 5823.4 5823.7 4852.9 6328.5 6396.8 6471.6 6487.9 6122.4 6272.7 6396.5 6412.4 6425.7 6333.9 6335.2 6385.6 6392.9 6406.0 5324.2 5463.5 5520.5 5522.7 5536.8 24357.1 25050.7 25109.1 25124.4 25424.4 2208.5 2246.5 2286.4 2376.7 2405.5 8530.0 14936.9 15112.9 15144.8 15766.9 1727.8 1749.7 1766.1 1792.9 1794.8 85443.0 113131.4 114263.4 116278.0 116637.0 9973.7 10046.8 10047.7 10440.6 10751.0 13420.3 13449.2 13459.9 13461.7 13487.5 8052.9 8344.7 8349.2 8491.2 8501.9 8363.1 8375.4 8412.9 8566.5 8574.1 5450.7 5710.9 6019.3 6444.8 6458.3 1539.9 1789.3 1828.6 1829.3 1830.3 788.9 888.4 958.0 997.9 1003.5 18742.3 21235.9 21256.0 21317.3 21365.8 929.9 943.0 959.0 960.3 1022.7 8787.6 8963.6 10782.8 11273.0 11374.1 407849.0 409351.0 412915.0 416471.0 434635.0 63180.9 75880.6 99598.0 109248.0 113009.4 916.8 958.7 1024.1 1024.4 1025.0 19277.8 19678.5 19688.9 19693.4 19704.5 47037.0 48517.5 49030.0 49547.3 50872.7 68327.7 68640.0 68912.7 69670.7 70039.6 7000.1 7253.5 7746.2 7827.8 7929.9 11743.9 12493.4 12699.7 13179.9 13217.6 7772.6 8736.9 10663.8 10926.5 11664.4 10915.5 11028.0 11279.9 11387.6 11669.0 11002.9 11074.5 11114.8 11370.9 11448.5 6946.6 8039.4 8153.0 8198.0 8398.1 9252.5 9829.3 10366.9 11220.2 11295.2 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | [#3] mootools.html Cycles:180 Average:5371.83 Median:4957.24 stddev:2969.48 (59.9%) stddev-sans-first:2962.09 22:32:31 INFO - PROCESS | 1999 | Values: 1305.9 1528.4 1703.2 1905.1 1941.0 8103.1 8557.9 8562.4 8563.7 8582.3 6746.7 7404.0 7703.3 7709.5 8369.6 1978.0 2294.7 2328.5 2341.7 2344.8 1984.0 2332.3 2347.1 2366.1 2370.7 2214.4 2233.2 2242.3 2243.3 2249.0 2214.6 2252.0 2255.9 2257.1 2289.6 2282.1 2308.6 2310.8 2312.9 2319.5 8354.8 8358.6 8460.3 8469.5 8471.4 4733.3 5214.2 5216.8 5217.3 5218.7 3269.2 3362.4 3572.7 3579.2 3585.2 937.6 1055.1 1062.3 1079.4 1095.1 10745.2 10760.3 10906.8 10921.7 10928.2 3354.6 4189.2 4255.1 4262.4 4546.0 9399.4 9423.0 9429.6 9440.8 9460.6 4348.0 5174.7 5174.7 5175.1 5176.8 4258.0 4373.0 4420.8 4712.2 4755.0 3712.9 3740.1 3828.3 3852.3 3883.0 1268.8 1273.4 1278.7 1287.4 1292.9 834.3 896.8 905.5 924.4 925.9 5480.2 5641.2 5791.3 5809.9 5906.5 399.2 435.0 447.4 448.1 454.7 3723.9 3766.3 3811.0 3902.2 3926.8 9688.9 9992.2 10112.3 10133.8 10138.8 10040.6 10043.6 10047.3 10060.3 10068.8 7124.4 7274.2 7636.3 7662.1 7662.3 5520.1 5539.6 5544.9 5561.9 5701.1 7583.9 8868.4 9196.4 9240.2 9375.2 7792.3 9072.2 9175.5 9366.4 9456.9 6557.5 6793.9 6806.0 6997.8 7116.1 7690.6 7960.0 7966.4 8089.8 8090.2 6947.8 7102.3 7182.6 7259.6 7346.6 6923.7 7077.5 7100.1 7185.4 7188.8 6663.9 6751.3 6767.8 6771.7 6789.9 4755.6 4817.1 4823.4 4875.6 4970.1 4036.2 4820.3 4944.4 4982.7 4983.0 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | [#4] prototype.html Cycles:180 Average:4359.52 Median:4724.48 stddev:1333.74 (28.2%) stddev-sans-first:1302.82 22:32:31 INFO - PROCESS | 1999 | Values: 334.9 338.3 344.9 350.9 355.5 4566.2 5127.0 5173.2 5250.3 5259.4 4090.3 4631.8 4912.3 5125.3 5158.1 3913.6 3915.9 4014.8 4035.2 4088.8 3404.5 3422.6 4048.4 4112.3 4115.3 3308.5 3741.0 3914.4 4047.1 4085.2 3453.4 3919.1 3924.9 3946.3 3949.7 3388.5 3398.7 3407.2 3410.3 3423.7 4027.3 4315.8 4573.4 5122.2 5129.7 3601.9 4453.2 4453.7 4456.8 4534.6 5474.2 5496.8 5532.9 5537.9 5540.6 3693.3 3708.9 3711.3 3723.6 3724.5 4089.2 5690.8 5755.7 5848.4 5850.4 3460.8 3969.5 4027.2 4027.4 4041.9 3544.5 3878.7 4094.2 4102.7 4112.3 4414.9 4520.6 4667.5 4708.6 4718.1 4629.2 5550.1 5578.5 5595.6 5656.3 1047.7 1201.9 1213.6 1309.4 1334.7 834.4 876.7 896.7 922.3 949.4 3893.2 4707.7 4846.7 4880.0 4884.6 4352.6 4454.0 4616.8 5013.7 5388.4 4045.7 4126.9 4640.5 4842.5 4922.7 2504.7 2553.5 2576.0 2670.8 2857.5 4869.0 5535.0 5539.6 5550.7 5573.2 4485.4 4730.8 5097.4 5133.7 5399.3 4699.5 5279.7 5570.4 5587.8 5595.9 5370.0 5399.7 5406.7 5406.7 5417.5 4504.9 5585.7 5626.5 5665.7 5680.4 4761.0 5019.7 5466.0 5578.7 5893.9 3722.9 3728.2 3735.6 3745.9 3747.7 5284.8 5573.5 5660.0 5733.0 5776.9 4743.7 4907.5 5501.6 5537.2 5564.7 5201.2 5451.9 5471.9 5524.9 5599.6 4348.8 5236.4 5406.6 5436.3 5445.3 4118.2 5427.6 5462.5 5577.3 5626.5 4996.5 5422.9 5457.9 5471.9 5517.4 22:32:31 INFO - PROCESS | 1999 | 22:32:31 INFO - PROCESS | 1999 | [#5] yui.html Cycles:180 Average:19507.13 Median:4450.07 stddev:27570.67 (619.6%) stddev-sans-first:27611.88 22:32:31 INFO - PROCESS | 1999 | Values: 709.0 741.6 747.9 776.0 788.3 15047.0 15219.9 15678.8 15735.8 15760.1 11952.9 14172.4 14187.0 14201.6 14232.9 704.6 726.4 871.5 880.4 909.5 891.8 897.6 900.3 900.9 909.3 966.0 968.2 968.5 973.5 979.4 963.0 964.5 966.4 967.8 967.8 551.6 570.9 692.1 717.1 727.6 14285.2 14318.7 14475.3 14502.5 14605.1 12192.0 13159.7 13161.1 13192.3 13273.6 11416.7 12270.4 12294.3 12308.5 12415.0 4362.3 4401.8 4411.1 4448.0 4493.8 75855.2 100351.5 102343.5 103469.5 108602.5 10470.3 10513.7 10603.3 10698.3 11021.4 20600.5 20691.4 20773.7 20793.6 20808.8 7463.3 7534.9 7541.7 7599.6 7760.5 4217.0 4257.6 4317.6 4329.6 4452.1 3309.6 3325.4 3411.1 3419.7 3420.4 637.1 638.1 638.5 646.7 661.6 580.9 588.5 599.0 620.1 624.4 8605.7 8749.3 8771.9 8844.5 8847.6 553.6 585.7 595.2 624.2 640.7 4285.5 4288.6 4295.1 4319.0 4464.0 89201.6 95469.0 99135.5 102039.0 102221.0 73149.0 74087.3 74575.6 80162.0 81679.2 72460.6 73044.0 74452.0 75218.6 75500.6 9164.5 9858.3 9874.2 9878.4 9883.5 42562.4 49033.5 49245.5 49665.8 52250.7 67206.0 69495.7 69824.7 71782.6 72885.1 12297.3 12325.9 12710.2 12787.6 13233.8 13055.6 13094.6 13276.1 13307.5 13563.9 9661.9 13102.9 13200.3 13921.7 13932.7 12854.9 13190.1 13290.3 13321.0 13342.0 12724.6 13107.6 13428.2 13542.8 13833.0 9907.8 9971.0 10796.6 11299.5 11496.1 11197.4 11238.9 11312.5 11384.7 11428.6 22:32:31 INFO - PROCESS | 1999 | -------- Summary: end -------- 22:32:31 INFO - PROCESS | 1999 | 22:32:32 INFO - TEST-INFO | 1999: exit 0 22:32:32 INFO - TEST-OK | dromaeo_css | took 1119377ms 22:32:32 INFO - TEST-START | kraken 22:32:32 INFO - operating with platform_type : mac_ 22:32:32 INFO - Initialising browser for kraken test... 22:32:32 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpu6vI00/profile http://localhost:52119/getInfo.html) 22:32:34 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 22:32:34 INFO - PROCESS | 2004 | colorDepth:24 22:32:34 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 22:32:34 INFO - PROCESS | 2004 | __metrics 22:32:34 INFO - PROCESS | 2004 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:32:34 INFO - PROCESS | 2004 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:32:35 INFO - TEST-INFO | 2004: exit 0 22:32:35 INFO - Browser initialized. 22:32:35 INFO - Running cycle 1/1 for kraken test... 22:32:35 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpu6vI00/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:47 INFO - PROCESS | 2005 | RSS: Main: 237457408 22:32:47 INFO - PROCESS | 2005 | 22:32:50 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52119/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:51 INFO - PROCESS | 2005 | RSS: Main: 290258944 22:32:51 INFO - PROCESS | 2005 | 22:32:54 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52119/tests/kraken/driver.html?testName=audio-dft) 22:32:54 INFO - PROCESS | 2005 | RSS: Main: 291266560 22:32:54 INFO - PROCESS | 2005 | 22:32:57 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52119/tests/kraken/driver.html?testName=audio-fft) 22:32:58 INFO - PROCESS | 2005 | RSS: Main: 383385600 22:32:58 INFO - PROCESS | 2005 | 22:33:00 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52119/tests/kraken/driver.html?testName=audio-oscillator) 22:33:01 INFO - PROCESS | 2005 | RSS: Main: 285958144 22:33:01 INFO - PROCESS | 2005 | 22:33:03 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:04 INFO - PROCESS | 2005 | RSS: Main: 289046528 22:33:04 INFO - PROCESS | 2005 | 22:33:07 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52119/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:07 INFO - PROCESS | 2005 | RSS: Main: 332111872 22:33:07 INFO - PROCESS | 2005 | 22:33:10 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52119/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:11 INFO - PROCESS | 2005 | RSS: Main: 334438400 22:33:11 INFO - PROCESS | 2005 | 22:33:14 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52119/tests/kraken/driver.html?testName=json-parse-financial) 22:33:14 INFO - PROCESS | 2005 | RSS: Main: 329265152 22:33:14 INFO - PROCESS | 2005 | 22:33:16 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:17 INFO - PROCESS | 2005 | RSS: Main: 305565696 22:33:17 INFO - PROCESS | 2005 | 22:33:19 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:19 INFO - PROCESS | 2005 | RSS: Main: 308801536 22:33:19 INFO - PROCESS | 2005 | 22:33:22 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:22 INFO - PROCESS | 2005 | RSS: Main: 311443456 22:33:22 INFO - PROCESS | 2005 | 22:33:25 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:26 INFO - PROCESS | 2005 | RSS: Main: 326799360 22:33:26 INFO - PROCESS | 2005 | 22:33:29 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:30 INFO - PROCESS | 2005 | RSS: Main: 321204224 22:33:30 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:52119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52119/tests/kraken/driver.html?testName=ai-astar) 22:33:32 INFO - PROCESS | 2005 | RSS: Main: 364863488 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | __start_tp_report 22:33:32 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 22:33:32 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 22:33:32 INFO - PROCESS | 2005 | |i|pagename|runs| 22:33:32 INFO - PROCESS | 2005 | |0;ai-astar;114;114;114;114;114;113;113;118;161;169 22:33:32 INFO - PROCESS | 2005 | |1;audio-beat-detection;141;111;109;145;112;113;110;109;137;143 22:33:32 INFO - PROCESS | 2005 | |2;audio-dft;186;184;185;182;184;186;187;185;183;184 22:33:32 INFO - PROCESS | 2005 | |3;audio-fft;80;58;85;113;53;72;74;83;97;83 22:33:32 INFO - PROCESS | 2005 | |4;audio-oscillator;86;69;86;71;71;91;117;99;78;84 22:33:32 INFO - PROCESS | 2005 | |5;imaging-gaussian-blur;108;110;108;111;108;111;108;112;108;110 22:33:32 INFO - PROCESS | 2005 | |6;imaging-darkroom;93;93;93;95;131;149;94;94;94;93 22:33:32 INFO - PROCESS | 2005 | |7;imaging-desaturate;88;84;85;87;84;84;101;115;87;86 22:33:32 INFO - PROCESS | 2005 | |8;json-parse-financial;56;54;53;53;54;55;57;54;54;54 22:33:32 INFO - PROCESS | 2005 | |9;json-stringify-tinderbox;72;70;92;117;108;61;72;107;107;92 22:33:32 INFO - PROCESS | 2005 | |10;stanford-crypto-aes;86;88;88;86;87;88;85;95;107;110 22:33:32 INFO - PROCESS | 2005 | |11;stanford-crypto-ccm;148;147;148;153;149;147;140;162;210;160 22:33:32 INFO - PROCESS | 2005 | |12;stanford-crypto-pbkdf2;170;171;174;172;171;171;171;170;173;174 22:33:32 INFO - PROCESS | 2005 | |13;stanford-crypto-sha256-iterative;67;67;68;66;70;63;60;68;77;84 22:33:32 INFO - PROCESS | 2005 | __end_tp_report 22:33:32 INFO - PROCESS | 2005 | __start_cc_report 22:33:32 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,2131 22:33:32 INFO - PROCESS | 2005 | __end_cc_report 22:33:32 INFO - PROCESS | 2005 | __startTimestamp1482302012380__endTimestamp 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | ------- Summary: start ------- 22:33:32 INFO - PROCESS | 2005 | Number of tests: 14 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#0] ai-astar Cycles:10 Average:124.40 Median:114.00 stddev:21.53 (18.9%) stddev-sans-first:22.50 22:33:32 INFO - PROCESS | 2005 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 113.0 118.0 161.0 169.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:125.00 stddev:16.09 (12.9%) stddev-sans-first:15.69 22:33:32 INFO - PROCESS | 2005 | Values: 141.0 111.0 109.0 145.0 112.0 113.0 110.0 109.0 137.0 143.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:1.51 (0.8%) stddev-sans-first:1.51 22:33:32 INFO - PROCESS | 2005 | Values: 186.0 184.0 185.0 182.0 184.0 186.0 187.0 185.0 183.0 184.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#3] audio-fft Cycles:10 Average:79.80 Median:81.50 stddev:17.43 (21.4%) stddev-sans-first:18.48 22:33:32 INFO - PROCESS | 2005 | Values: 80.0 58.0 85.0 113.0 53.0 72.0 74.0 83.0 97.0 83.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:85.00 stddev:14.74 (17.3%) stddev-sans-first:15.63 22:33:32 INFO - PROCESS | 2005 | Values: 86.0 69.0 86.0 71.0 71.0 91.0 117.0 99.0 78.0 84.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:110.00 stddev:1.58 (1.4%) stddev-sans-first:1.59 22:33:32 INFO - PROCESS | 2005 | Values: 108.0 110.0 108.0 111.0 108.0 111.0 108.0 112.0 108.0 110.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:93.50 stddev:20.02 (21.4%) stddev-sans-first:20.91 22:33:32 INFO - PROCESS | 2005 | Values: 93.0 93.0 93.0 95.0 131.0 149.0 94.0 94.0 94.0 93.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:85.50 stddev:10.09 (11.8%) stddev-sans-first:10.68 22:33:32 INFO - PROCESS | 2005 | Values: 88.0 84.0 85.0 87.0 84.0 84.0 101.0 115.0 87.0 86.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.26 (2.3%) stddev-sans-first:1.20 22:33:32 INFO - PROCESS | 2005 | Values: 56.0 54.0 53.0 53.0 54.0 55.0 57.0 54.0 54.0 54.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#9] json-stringify-tinderbox Cycles:10 Average:89.80 Median:71.00 stddev:19.80 (27.9%) stddev-sans-first:19.92 22:33:32 INFO - PROCESS | 2005 | Values: 72.0 70.0 92.0 117.0 108.0 61.0 72.0 107.0 107.0 92.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:87.50 stddev:9.14 (10.4%) stddev-sans-first:9.43 22:33:32 INFO - PROCESS | 2005 | Values: 86.0 88.0 88.0 86.0 87.0 88.0 85.0 95.0 107.0 110.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:151.00 stddev:19.92 (13.2%) stddev-sans-first:20.89 22:33:32 INFO - PROCESS | 2005 | Values: 148.0 147.0 148.0 153.0 149.0 147.0 140.0 162.0 210.0 160.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:171.50 stddev:1.49 (0.9%) stddev-sans-first:1.45 22:33:32 INFO - PROCESS | 2005 | Values: 170.0 171.0 174.0 172.0 171.0 171.0 171.0 170.0 173.0 174.0 22:33:32 INFO - PROCESS | 2005 | 22:33:32 INFO - PROCESS | 2005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.00 stddev:6.88 (10.1%) stddev-sans-first:7.26 22:33:32 INFO - PROCESS | 2005 | Values: 67.0 67.0 68.0 66.0 70.0 63.0 60.0 68.0 77.0 84.0 22:33:32 INFO - PROCESS | 2005 | -------- Summary: end -------- 22:33:32 INFO - PROCESS | 2005 | 22:33:33 INFO - TEST-INFO | 2005: exit 0 22:33:33 INFO - TEST-OK | kraken | took 61193ms 22:33:33 INFO - SUITE-END | took 1180s 22:33:33 INFO - Completed test suite (00:19:40) 22:33:33 INFO - javascript benchmark 22:33:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.451163302239, 3245.6754324567546, 3264.6082470103593, 3294.621118571365, 3325.634180240173, 5477.561795056396, 5559.58303127265, 5573.498385145336, 5634.633748806325, 5638.577106716992, 5580.051391263485, 5607.831765047055, 5653.9151912721345, 5684.062129748597, 5700.800471983482, 5076.6700164489375, 5086.618503612244, 5099.133147364957, 5114.462981386957, 5170.043541944752, 5173.974130129344, 5251.186066159751, 5268.367795864501, 5271.499207575274, 5325.094733895247, 5037.068142393632, 5180.326557547494, 5203.9219411708855, 5239.161734122522, 5241.711705856176, 5082.517160869711, 5115.335006449175, 5121.667091639031, 5126.102931986925, 5126.6923984561045, 5034.421041580228, 5074.974625126888, 5084.618653600958, 5094.77073531692, 5099.5410413063, 5552.305961754781, 5555.583331250173, 5558.082916318843, 5560.666360018412, 5563.944360556424, 6033.064874944391, 6041.6072955258205, 6042.425969532887, 6050.485708714765, 6051.304100028465, 6124.571280010401, 6126.509879209652, 6127.708789264043, 6162.476189523896, 6166.445019948226, 5672.205891175238, 5737.995850726106, 5749.942500574983, 5755.136729490568, 5755.510781583613, 6189.907151392733, 6212.937870621236, 6215.223097112861, 6230.56386052981, 6234.470070044097, 6022.69886505673, 6022.939770602326, 6034.155218269446, 6035.124906888476, 6083.057126145454, 4882.487338829443, 5891.49922256613, 5936.8812623748145, 5941.257342832146, 6109.495762817132, 6129.307718812861, 6140.820008896867, 6140.846478838065, 6144.109104179869, 6157.0456579230295, 6141.017437210025, 6152.907706384408, 6154.1999540059505, 6160.322364539897, 6217.036359364306, 4812.230043193073, 4842.903141937141, 4845.491223421561, 4902.779374928136, 4934.5312195341385, 4354.586314300136, 4359.629431498295, 4368.956310436918, 4385.254506733863, 4422.977885110554, 5607.579431542569, 5643.746031428595, 5645.096784514458, 5647.830565083054, 5651.576131790132, 6054.39456054391, 6117.188044311343, 6120.204373431426, 6121.392004143319, 6127.220070483952, 5666.178404131378, 5670.432956704379, 5674.06377947634, 5679.346875109415, 5719.971400143056, 5374.704391258519, 5382.2464854920345, 5384.6499977501335, 5394.433584473652, 5395.163749618815, 6132.845047373359, 6187.071939208975, 6187.133801267736, 6269.247690277196, 6272.968635156795, 6101.853092873148, 6106.885399019288, 6140.995089002448, 6180.598261113013, 6207.472364848858, 6207.968960155351, 6213.03697926822, 6213.130161777445, 6223.937760622336, 6286.15136956505, 5966.433188847052, 5979.342272349951, 6119.724612392364, 6120.08198770188, 6132.662703551169, 6025.849353766015, 6095.634261944298, 6097.542684298606, 6104.428839602322, 6139.754409823557, 6010.338862725184, 6018.4884284834525, 6028.975074237478, 6031.4270144336215, 6039.033754599419, 5962.433568810956, 6002.939970600412, 6005.819825405245, 6015.218021657157, 6018.909716354346, 5675.77296908119, 5704.3725190228215, 5831.970840145772, 5843.328017278068, 5853.707314634166, 6000.489958353589, 6003.739214764773, 6010.398960103955, 6016.067509536029, 6020.969895150496, 5757.65454072757, 5798.797042103675, 5826.184334193301, 5859.648421094748, 5943.078822782476], "value": 5610.565335230845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.2885219223145, 447.76044816023426, 461.142275367816, 489.24167540312516, 562.836777334573, 32187.51718724221, 38257.42613860791, 39530.80234598827, 39798.00504987377, 39927.60072399275, 40806.7959660202, 41383.379249311285, 41450.0, 41450.792746036226, 41524.0, 8382.622781974795, 9215.585298661543, 9442.291828112919, 9457.668981585646, 9465.195458386046, 8398.580070996457, 10993.835092473619, 11277.605283815068, 11301.03941164998, 11462.025727813105, 11243.775124497504, 11300.434978251096, 11320.320780753182, 11327.320360778338, 11332.773344533105, 8431.0, 11235.0, 11331.603393881256, 11335.659930202108, 11351.375674337949, 8394.706185283485, 9416.764580885465, 10884.67345979614, 11220.0, 11375.0, 38287.85136445911, 38443.23113537741, 38831.41752873709, 38877.41683874744, 38912.80543597292, 2902.7532659723947, 3416.572928383952, 3431.725461963037, 3510.6664866837864, 3889.3776995680555, 28524.286892827637, 29752.107436776932, 29769.106926792232, 29789.70210297891, 30343.393132137233, 3182.618085829692, 3292.0453068610072, 3339.716124129452, 3371.039253812676, 3372.443546814797, 468264.99999999657, 470555.0, 473311.0, 473899.0, 475438.0, 54063.72968135134, 54248.74507529482, 54315.45684543183, 54334.0, 54404.0, 50285.49714502808, 61403.62280074549, 61489.23938310778, 61551.0, 61639.69180154071, 15402.46091386796, 15874.841251587337, 15924.92037539805, 15938.840611593736, 15941.681166376608, 10971.890281097087, 11283.435828208556, 12364.44360003784, 12425.689357766129, 12427.627171184879, 14295.213763242913, 15000.624984375478, 15227.695446091016, 15352.923235383752, 15462.845371546366, 6189.81430557084, 6225.750969961151, 6693.732250710014, 6716.496262780311, 6776.576918847098, 869.7043005378201, 948.5162567090696, 1000.8048430556117, 1029.351508549609, 1052.2371280821496, 29587.704122958494, 29618.851905740332, 29776.904059809898, 29879.10362689123, 29987.700122998926, 1003.3177439341172, 1062.718379629399, 1067.6049861551276, 1132.2923173016864, 1175.1186610042469, 12511.624651260478, 14847.034942728687, 15309.540713778382, 15513.689726205414, 15677.764833527506, 562985.0, 563855.0, 564494.0, 570895.1455242697, 571060.0, 55450.445495544525, 55712.16431753527, 55715.0, 55760.442395576334, 55959.88080238373, 1227.2391117507202, 1283.377561882505, 1347.6765576261823, 1383.384393944685, 1398.098226643809, 27420.862895685394, 27750.306242344104, 29428.525724341467, 29906.70093299126, 30561.847190763903, 37021.81489092537, 46911.765441172574, 46939.0, 47052.29421558611, 47077.529224707316, 464085.0, 566249.0, 570675.0, 573023.1348843229, 573929.0, 23154.0, 23461.0, 23976.160834370712, 23976.520469590163, 24715.0, 39886.40170397388, 39977.60022399739, 40749.38875916805, 40823.97940051522, 41117.79441102775, 34063.97808065762, 34171.14572135716, 34195.4870676945, 34999.4750078744, 35335.0, 28960.855195723885, 34174.82912585421, 34243.4358029001, 34652.960411187705, 34879.47680784739, 29665.40669186561, 32173.0, 33466.665333346355, 34112.48831267483, 34240.657593424745, 26875.924963002042, 29198.978035768647, 30821.921232756747, 30840.92056778002, 30957.535636965913, 23140.652890207, 23425.297241082793, 23706.170284039978, 23771.762282376956, 24168.791560421556], "value": 19065.197512756356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.6177109607173, 368.1514109976505, 376.6045652065331, 382.906187983944, 409.27762499188935, 14365.42538298468, 14758.852411475882, 15896.0, 18982.62034759304, 19734.0, 18302.63394732108, 19852.50368740782, 20473.692894606593, 20647.0, 20717.0, 5313.57491400687, 5771.134329850514, 5808.4481974212595, 5823.417658234185, 5823.650580965134, 4852.927206091911, 6328.493720502349, 6396.840078998016, 6471.644059576722, 6487.902681459782, 6122.448979591836, 6272.68636568172, 6396.488280937537, 6412.39082287182, 6425.678716064202, 6333.87332253357, 6335.176427064475, 6385.648789316586, 6392.936070639281, 6405.967970160166, 5324.1747529133045, 5463.48096930791, 5520.503154716095, 5522.696251706155, 5536.806211782608, 24357.147499837596, 25050.749492505023, 25109.121180758586, 25124.371890702696, 25424.364390890376, 2208.4920468292385, 2246.542345382232, 2286.4398222435443, 2376.7266764322153, 2405.482821193434, 8530.0, 14936.850631493764, 15112.924435377863, 15144.772828407582, 15766.921165394215, 1727.75811386406, 1749.7112976358885, 1766.0816375484806, 1792.9462116136538, 1794.8294911983342, 85443.0, 113131.43434282858, 114263.42868285606, 116278.0, 116637.0, 9973.700788976343, 10046.849297260547, 10047.698569042941, 10440.634577789893, 10751.0, 13420.328983550784, 13449.193048417126, 13459.932700336436, 13461.730765384638, 13487.460501580023, 8052.919470805217, 8344.749657510285, 8349.248567628943, 8491.19333663301, 8501.914980850112, 8363.121872203332, 8375.371847111492, 8412.873806892901, 8566.52884091381, 8574.056853746082, 5450.700211488327, 5710.886377156415, 6019.277686677627, 6444.838879027968, 6458.257300410419, 1539.8845086618323, 1789.2932291744687, 1828.606849527358, 1829.2865782344895, 1830.3319288459882, 788.8640357884627, 888.4314039015036, 957.9760505987267, 997.9301448898508, 1003.4581326083979, 18742.344017959305, 21235.893820530797, 21256.0, 21317.25389611356, 21365.78634213638, 929.9442033478012, 942.990570094304, 958.9818659815352, 960.2893858544767, 1022.6676330192718, 8787.604557794915, 8963.596638151299, 10782.838257426145, 11273.0, 11374.14693897961, 407849.0, 409351.0, 412915.0, 416471.0, 434635.0, 63180.87159206022, 75880.62059689667, 99598.00401996032, 109248.0, 113009.43495282471, 916.757059379265, 958.6980101268217, 1024.1499555369176, 1024.4416792847917, 1024.9692509224735, 19277.8072219276, 19678.508037299183, 19688.90155549213, 19693.40919772409, 19704.507387315432, 47037.0, 48517.51482485271, 49030.0, 49547.25679114888, 50872.74563627158, 68327.65836170787, 68640.0, 68912.65543672249, 69670.65164674145, 70039.64980175067, 7000.124984376953, 7253.492255542062, 7746.186650401627, 7827.804304892423, 7929.881051784112, 11743.882561174622, 12493.375331233583, 12699.746005079662, 13179.934100329821, 13217.603471895858, 7772.572508512086, 8736.91263087361, 10663.786724265627, 10926.453677316262, 11664.416779161178, 10915.454227288763, 11028.0, 11279.943600282275, 11387.601433949772, 11669.0, 11002.944985275022, 11074.501647426046, 11114.83294254124, 11370.94314528422, 11448.484818183368, 6946.583205007716, 8039.356851451753, 8153.02163740355, 8197.95901020515, 8398.118197589165, 9252.537373131181, 9829.262805289774, 10366.948165259126, 11220.214584978972, 11295.209335346446], "value": 9303.655243660989, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.8834696334634, 1528.39628346803, 1703.190984282466, 1905.1141219333008, 1940.9708854367177, 8103.108658047618, 8557.91442085579, 8562.400631955765, 8563.700270490519, 8582.313414926806, 6746.662666866661, 7404.0, 7703.306702396797, 7709.537427754339, 8369.581520923944, 1977.9703304450445, 2294.6558016297563, 2328.4528135888054, 2341.672165896776, 2344.8006919411787, 1984.0, 2332.323626148415, 2347.072906202049, 2366.100881664965, 2370.739218685952, 2214.3689048621145, 2233.20721143994, 2242.316093591454, 2243.2597242909883, 2248.9887550562307, 2214.5716013171495, 2252.0, 2255.8984845681985, 2257.085880218514, 2289.553537060274, 2282.132789539981, 2308.619077852169, 2310.803581695558, 2312.861228326306, 2319.512902290521, 8354.8329033419, 8358.623861926168, 8460.323174146053, 8469.49183049013, 8471.407001509897, 4733.290006499018, 5214.191800270926, 5216.843494695166, 5217.321748172713, 5218.66078704883, 3269.1500209945348, 3362.3947689415895, 3572.7499075064757, 3579.2125732338845, 3585.15748799032, 937.5921474158763, 1055.1400608504046, 1062.2988827373897, 1079.433297518801, 1095.058249905081, 10745.194110441747, 10760.300580462244, 10906.781864362669, 10921.726956826064, 10928.180386471047, 3354.5806774152743, 4189.224993376235, 4255.106427650167, 4262.381954616563, 4545.977270113628, 9399.389039712396, 9422.95288523553, 9429.575669094907, 9440.811183776286, 9460.621575137055, 4347.956520434818, 5174.689518628894, 5174.741262936838, 5175.120229560984, 5176.818811341585, 4258.0, 4373.0, 4420.801063952065, 4712.175369310357, 4755.0, 3712.925741485155, 3740.102375429877, 3828.3300422425964, 3852.3451013327804, 3882.9805850970565, 1268.8287081244098, 1273.420593629896, 1278.6803299175206, 1287.4463980488292, 1292.9482820687256, 834.3158609939791, 896.8385690575759, 905.5427009360362, 924.3852837862746, 925.9120383563685, 5480.205370221295, 5641.2384328116, 5791.333996590446, 5809.854753631109, 5906.527477801766, 399.22948708991345, 434.98260069596864, 447.4339959950665, 448.08143306222115, 454.6590057456907, 3723.94414083789, 3766.322062028806, 3811.0281878121455, 3902.2195560887935, 3926.764394136361, 9688.854667179998, 9992.15223661253, 10112.342697724771, 10133.797324053477, 10138.797224055477, 10040.64857729976, 10043.648472303581, 10047.296689231684, 10060.295779295526, 10068.798624027624, 7124.3944264738075, 7274.199838017919, 7636.274553917369, 7662.080550333995, 7662.348700360531, 5520.1443776214755, 5539.639923404966, 5544.916826247691, 5561.916571251353, 5701.087825947829, 7583.886241706489, 8868.379213454997, 9196.35625506208, 9240.214581760625, 9375.156235938799, 7792.259735325135, 9072.228860546928, 9175.54122293896, 9366.438013719198, 9456.858147127661, 6557.540972131905, 6793.93206067933, 6806.0, 6997.790066298019, 7116.110486189226, 7690.577018263825, 7960.004999375078, 7966.442349035512, 8089.757307280791, 8090.220151566646, 6947.79156625302, 7102.289771022856, 7182.5634873024555, 7259.564426134449, 7346.6326683666675, 6923.723051078102, 7077.469189810888, 7100.147982242164, 7185.425165986604, 7188.784336469915, 6663.866722665616, 6751.257361690112, 6767.830804229934, 6771.695273712793, 6789.89815152783, 4755.595774359218, 4817.108834865561, 4823.397075365579, 4875.585575226146, 4970.105381031449, 4036.233115708006, 4820.325154478306, 4944.381952255968, 4982.676126051795, 4982.950170498249], "value": 4288.680799958669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.87609584453753, 338.3224351301355, 344.92239246169606, 350.9070096424448, 355.4590848671011, 4566.1780879441685, 5126.974605078985, 5173.249878767577, 5250.317458730369, 5259.368875734913, 4090.345544712839, 4631.7684115794245, 4912.312276281324, 5125.282460455539, 5158.123119069758, 3913.6086391360923, 3915.941260881089, 4014.7591144531275, 4035.1929614077153, 4088.7546747195265, 3404.5360494987144, 3422.606400263964, 4048.360414032322, 4112.321466957948, 4115.283912617673, 3308.470644696849, 3740.962590374102, 3914.4128380742973, 4047.1298670785777, 4085.1829634073156, 3453.4301840196335, 3919.098607320318, 3924.862629807943, 3946.2636439966323, 3949.7037722170953, 3388.4578467445335, 3398.694117529434, 3407.2163402417336, 3410.2838403934957, 3423.6918677318913, 4027.2952233359047, 4315.755806980353, 4573.359729637853, 5122.180451127839, 5129.692218466904, 3601.873934412283, 4453.216739537789, 4453.710508816916, 4456.754878481682, 4534.591886730177, 5474.233607294982, 5496.7526461308935, 5532.889342213133, 5537.861553461195, 5540.612157148961, 3693.279810436966, 3708.8516459341595, 3711.3319602471543, 3723.6090210528046, 3724.5344331958504, 4089.2230476209425, 5690.784706640735, 5755.712214389264, 5848.385919478436, 5850.385709500526, 3460.823320071188, 3969.4717533749713, 4027.2348253832265, 4027.375756757707, 4041.8989525262105, 3544.5392099026963, 3878.650921417086, 4094.2016306819883, 4102.687140115194, 4112.300908845504, 4414.867553973386, 4520.638348932078, 4667.486576476585, 4708.623310135181, 4718.127146477913, 4629.236176030984, 5550.111982082928, 5578.54957710998, 5595.64982707264, 5656.321241451053, 1047.7328281288376, 1201.9278843269433, 1213.5801112698164, 1309.3845892430543, 1334.6596617862383, 834.4367551902442, 876.6543355948716, 896.6771962093641, 922.285228947571, 949.4113649537193, 3893.165232246235, 4707.741074240949, 4846.709197448094, 4879.951200488021, 4884.5603895649565, 4352.564743525685, 4453.955460445419, 4616.815327386934, 5013.699178049329, 5388.353397592314, 4045.6561192298986, 4126.855560055384, 4640.535946405333, 4842.491538388489, 4922.680025798311, 2504.6743923289855, 2553.4510080332448, 2575.987120064388, 2670.838185389362, 2857.528507796232, 4868.95131048692, 5535.0, 5539.612227144142, 5550.72246387679, 5573.21974923503, 4485.398468888037, 4730.834420795256, 5097.439281679012, 5133.666311689728, 5399.271098401744, 4699.530046995274, 5279.709615971082, 5570.41510641385, 5587.770690448095, 5595.944040559623, 5369.973150134224, 5399.676019438846, 5406.675599464044, 5406.7296635167295, 5417.51242388187, 4504.891624778892, 5585.69278689676, 5626.483447845097, 5665.688387138747, 5680.4319568042865, 4760.952390476051, 5019.7490125494305, 5466.0, 5578.721063946868, 5893.941060589511, 3722.8696995606106, 3728.217074414403, 3735.6451137141926, 3745.932409263347, 3747.681447077029, 5284.81503147388, 5573.526250268773, 5659.971700141473, 5732.980370610759, 5776.855578610568, 4743.66794324394, 4907.4847141051105, 5501.559875209893, 5537.169424586345, 5564.749586268708, 5201.1678131498775, 5451.918221226605, 5471.917921231265, 5524.944750552443, 5599.608027438203, 4348.760818154905, 5236.376723215815, 5406.621536492407, 5436.320459942507, 5445.26488924006, 4118.217538667644, 5427.565794736491, 5462.508374246178, 5577.271045975761, 5626.521745651666, 4996.475370086234, 5422.861199148223, 5457.918131228114, 5471.863203419946, 5517.420670829666], "value": 3952.791171491305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.0182938686374, 741.614360532523, 747.9214682458341, 775.9873365258336, 788.3338578900834, 15047.0, 15219.923900380483, 15678.845106046878, 15735.763963540541, 15760.05439673619, 11952.880471195285, 14172.362243699032, 14187.0, 14201.573952781408, 14232.92883535581, 704.6018999265424, 726.4478995963053, 871.5467956662532, 880.3661363818056, 909.4997751236793, 891.7503099132254, 897.6005677473527, 900.3067637918798, 900.9459432434043, 909.2998391238742, 966.0194902174298, 968.2012339819642, 968.5351031504882, 973.4548652754445, 979.4025644356936, 963.0225321298888, 964.4888209249109, 966.4008314844806, 967.7870868408938, 967.796762679838, 551.555997422075, 570.8687001989524, 692.1106378303906, 717.0857157124656, 727.6216367488929, 14285.21431321277, 14318.713625727427, 14475.348609312607, 14502.492412765609, 14605.05067170641, 12192.0, 13159.736805263841, 13161.144525605805, 13192.274424906625, 13273.601791946257, 11416.71458213543, 12270.38648067593, 12294.323812190327, 12308.507659693601, 12415.0, 4362.302031674949, 4401.757903315316, 4411.139827733561, 4448.021435284232, 4493.752843593601, 75855.24144758537, 100351.49472757915, 102343.48828255886, 103469.482652587, 108602.45698771534, 10470.267081304388, 10513.684589462327, 10603.310784798963, 10698.304610200312, 11021.44892755375, 20600.484987875123, 20691.379258621964, 20773.688394674093, 20793.58412831735, 20808.791912080684, 7463.290987356192, 7534.924650753532, 7541.73603923871, 7599.582022988789, 7760.456768026297, 4216.9789151054665, 4257.57424257578, 4317.633001194934, 4329.610335069859, 4452.109578084396, 3309.6028476582965, 3325.368180045832, 3411.0790086676457, 3419.709324707378, 3420.350133474632, 637.1494055435952, 638.1480723234441, 638.5370606310481, 646.6669665122465, 661.6493258572964, 580.9041508151192, 588.4733163818358, 598.9713533287448, 620.0964925792149, 624.4442446222865, 8605.698800541952, 8749.343799215085, 8771.868421973548, 8844.46933184011, 8847.557622118868, 553.593109064837, 585.6515373352848, 595.1727099331932, 624.1698540940629, 640.724488469953, 4285.507166675872, 4288.592583704543, 4295.098029413858, 4319.003016035735, 4463.977680111579, 89201.55399222963, 95469.0, 99135.50432247936, 102039.0, 102220.97779022263, 73149.0, 74087.25912740911, 74575.62712186512, 80162.0, 81679.18320816835, 72460.63769681117, 73044.0, 74452.0, 75218.58893282656, 75500.62249688717, 9164.495952722664, 9858.260630452889, 9874.160696340892, 9878.357906736326, 9883.50582470888, 42562.36156457718, 49033.50966490432, 49245.50754492409, 49665.751671241414, 52250.73874630754, 67206.0, 69495.65252173707, 69824.65087674529, 71782.64108679423, 72885.08459661555, 12297.32364719949, 12325.876741232472, 12710.173838700455, 12787.552435664707, 13233.751064124632, 13055.608331750063, 13094.607161785161, 13276.137051092035, 13307.46770129184, 13563.86436135626, 9661.855072174063, 13102.934485327512, 13200.339983001004, 13921.651958701113, 13932.721345573234, 12854.871451285742, 13190.142640728322, 13290.335483225994, 13321.0, 13342.0, 12724.618261452171, 13107.606771796862, 13428.19430834153, 13542.796858047333, 13833.031687781759, 9907.801843963225, 9971.002899710262, 10796.634247623047, 11299.548018079186, 11496.080313575061, 11197.384143872165, 11238.943805280922, 11312.490937907649, 11384.715382115513, 11428.599998999995], "value": 7317.317138199079, "unit": "score"}], "name": "dromaeo_css", "value": 7056.481059624089, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 118.0, 161.0, 169.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 109.0, 145.0, 112.0, 113.0, 110.0, 109.0, 137.0, 143.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 182.0, 184.0, 186.0, 187.0, 185.0, 183.0, 184.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 85.0, 113.0, 53.0, 72.0, 74.0, 83.0, 97.0, 83.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 86.0, 71.0, 71.0, 91.0, 117.0, 99.0, 78.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 108.0, 111.0, 108.0, 111.0, 108.0, 112.0, 108.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 95.0, 131.0, 149.0, 94.0, 94.0, 94.0, 93.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 85.0, 87.0, 84.0, 84.0, 101.0, 115.0, 87.0, 86.0], "value": 90.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 53.0, 54.0, 55.0, 57.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 92.0, 117.0, 108.0, 61.0, 72.0, 107.0, 107.0, 92.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 88.0, 86.0, 87.0, 88.0, 85.0, 95.0, 107.0, 110.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 153.0, 149.0, 147.0, 140.0, 162.0, 210.0, 160.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 174.0, 172.0, 171.0, 171.0, 171.0, 170.0, 173.0, 174.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 70.0, 63.0, 60.0, 68.0, 77.0, 84.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1532.7, "alertThreshold": 2.0}]} 22:33:33 INFO - Return code: 0 22:33:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:33:33 INFO - # TBPL SUCCESS # 22:33:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:33:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:33:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:33:33 INFO - 2016-12-20 22:33:33.682 screenresolution[2009:17959] starting screenresolution argv=screenresolution get 22:33:33 INFO - 2016-12-20 22:33:33.685 screenresolution[2009:17959] Display 0: 1600x1200x32@60 22:33:33 INFO - 2016-12-20 22:33:33.691 screenresolution[2010:17962] starting screenresolution argv=screenresolution list 22:33:33 INFO - Available Modes on Display 0 22:33:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:33:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:33:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:33:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:33:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:33:33 INFO - Intel Iris: 22:33:33 INFO - Chipset Model: Intel Iris 22:33:33 INFO - Type: GPU 22:33:33 INFO - Bus: Built-In 22:33:33 INFO - VRAM (Dynamic, Max): 1536 MB 22:33:33 INFO - Vendor: Intel (0x8086) 22:33:33 INFO - Device ID: 0x0a2e 22:33:33 INFO - Revision ID: 0x0009 22:33:33 INFO - Displays: 22:33:33 INFO - Display: 22:33:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:33:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:33:33 INFO - Display Serial Number: 1600x1200 60 22:33:33 INFO - Main Display: Yes 22:33:33 INFO - Mirror: Off 22:33:33 INFO - Online: Yes 22:33:33 INFO - Rotation: Supported 22:33:33 INFO - Return code: 0 22:33:33 INFO - Running post-action listener: _resource_record_post_action 22:33:33 INFO - [mozharness: 2016-12-21 06:33:33.930043Z] Finished run-tests step (success) 22:33:33 INFO - Running post-run listener: _resource_record_post_run 22:33:33 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 782336; Write bytes: 549155840; Read time: 11; Write time: 1716 22:33:33 INFO - TinderboxPrint: CPU usage
53.9% 22:33:33 INFO - TinderboxPrint: I/O read bytes / time
782,336 / 11 22:33:33 INFO - TinderboxPrint: I/O write bytes / time
549,155,840 / 1,716 22:33:33 INFO - TinderboxPrint: CPU idle
2,219.2 (46.1%) 22:33:33 INFO - TinderboxPrint: CPU system
967.1 (20.1%) 22:33:33 INFO - TinderboxPrint: CPU user
1,627.3 (33.8%) 22:33:33 INFO - TinderboxPrint: Swap in / out
250,486,784 / 0 22:33:33 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 241408512; Write bytes: 236611072; Read time: 17667; Write time: 573 22:33:34 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 782336; Write bytes: 294989312; Read time: 11; Write time: 1106 22:33:34 INFO - Running post-run listener: _upload_blobber_files 22:33:34 INFO - Blob upload gear active. 22:33:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:33:34 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 22:33:34 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:33:34 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:33:34 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:33:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:33:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:35 INFO - (blobuploader) - INFO - Done attempting. 22:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:36 INFO - (blobuploader) - INFO - Done attempting. 22:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:37 INFO - (blobuploader) - INFO - Done attempting. 22:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:39 INFO - (blobuploader) - INFO - Done attempting. 22:33:39 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:39 INFO - Return code: 0 22:33:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/894363f955fe477ef0efed7900c78611b82be07a20bbc3eaa3782bd9da65955cb79523b259f4020dae972527dd5be6fc0379293b8dc4853f4e55f1b355a7e2dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21fa6c756338b6ed84f318345e25bc555fd500c253850260f04dacd6d0e187c04699b4b493e8ea3561f72084a6686832d29face8ca23cb6ba3bf129a79322064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/604481ae68f8b4b650a8b2c762cc0dff8d5138cb1246aa4bd2e2d96774ce5a377c5851289dea0a8c026fd804a30f677b24b7be647f220ea6cd15aca408e5eb47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d289661541488b177855d64ca6d82dc757cbe80f82f639b7d370430e9951d8502c5195ab87e67bf7428c797e624eeedf48d894fad009658d032a3184ab579b27"} 22:33:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:39 INFO - Contents: 22:33:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/894363f955fe477ef0efed7900c78611b82be07a20bbc3eaa3782bd9da65955cb79523b259f4020dae972527dd5be6fc0379293b8dc4853f4e55f1b355a7e2dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21fa6c756338b6ed84f318345e25bc555fd500c253850260f04dacd6d0e187c04699b4b493e8ea3561f72084a6686832d29face8ca23cb6ba3bf129a79322064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/604481ae68f8b4b650a8b2c762cc0dff8d5138cb1246aa4bd2e2d96774ce5a377c5851289dea0a8c026fd804a30f677b24b7be647f220ea6cd15aca408e5eb47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d289661541488b177855d64ca6d82dc757cbe80f82f639b7d370430e9951d8502c5195ab87e67bf7428c797e624eeedf48d894fad009658d032a3184ab579b27"} 22:33:39 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:39 INFO - Copying logs to upload dir... 22:33:39 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.955295 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-20 22:33:39.857685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 22:33:39.860966) ========= 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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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/Graphics/sha512/894363f955fe477ef0efed7900c78611b82be07a20bbc3eaa3782bd9da65955cb79523b259f4020dae972527dd5be6fc0379293b8dc4853f4e55f1b355a7e2dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21fa6c756338b6ed84f318345e25bc555fd500c253850260f04dacd6d0e187c04699b4b493e8ea3561f72084a6686832d29face8ca23cb6ba3bf129a79322064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/604481ae68f8b4b650a8b2c762cc0dff8d5138cb1246aa4bd2e2d96774ce5a377c5851289dea0a8c026fd804a30f677b24b7be647f220ea6cd15aca408e5eb47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d289661541488b177855d64ca6d82dc757cbe80f82f639b7d370430e9951d8502c5195ab87e67bf7428c797e624eeedf48d894fad009658d032a3184ab579b27"} build_url:https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011122 build_url: 'https://queue.taskcluster.net/v1/task/AdT7rHOCSpG5oDSNybHw5A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/894363f955fe477ef0efed7900c78611b82be07a20bbc3eaa3782bd9da65955cb79523b259f4020dae972527dd5be6fc0379293b8dc4853f4e55f1b355a7e2dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21fa6c756338b6ed84f318345e25bc555fd500c253850260f04dacd6d0e187c04699b4b493e8ea3561f72084a6686832d29face8ca23cb6ba3bf129a79322064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/604481ae68f8b4b650a8b2c762cc0dff8d5138cb1246aa4bd2e2d96774ce5a377c5851289dea0a8c026fd804a30f677b24b7be647f220ea6cd15aca408e5eb47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d289661541488b177855d64ca6d82dc757cbe80f82f639b7d370430e9951d8502c5195ab87e67bf7428c797e624eeedf48d894fad009658d032a3184ab579b27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 22:33:39.896017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:33:39.896365) ========= 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.z5JoPOEzLf/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.DbqMKnSDGC/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.004567 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:33:39.944226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 22:33:39.944555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 22:33:39.944881) ========= ========= Total master_lag: 0.19 =========