builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0284 starttime: 1485270739.97 results: success (0) buildid: 20170124054448 builduid: e68c87fb07f2410aa2b298994700cd75 revision: b86ff4066687c7f880598820360b3c564b4f60d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:19.967969) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:19.968459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:19.968744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:19.996299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:19.996722) ========= 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.wPx51bEFq7/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.BLeUz9gXSS/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 07:12:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2017-01-24 07:12:20 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078359 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:20.101171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:20.101748) ========= 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.wPx51bEFq7/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.BLeUz9gXSS/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.025007 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:20.151499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:20.151903) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev b86ff4066687c7f880598820360b3c564b4f60d6 --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 b86ff4066687c7f880598820360b3c564b4f60d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wPx51bEFq7/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.BLeUz9gXSS/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 07:12:20,265 truncating revision to first 12 chars 2017-01-24 07:12:20,265 Setting DEBUG logging. 2017-01-24 07:12:20,265 attempt 1/10 2017-01-24 07:12:20,265 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/b86ff4066687?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 07:12:20,949 unpacking tar archive at: graphics-b86ff4066687/testing/mozharness/ program finished with exit code 0 elapsedTime=0.961449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:21.136934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:21.137272) ========= script_repo_revision: b86ff4066687c7f880598820360b3c564b4f60d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:21.137690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:21.137957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 07:12:21.157780) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-24 07:12:21.159406) ========= /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.wPx51bEFq7/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.BLeUz9gXSS/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:12:21 INFO - MultiFileLogger online at 20170124 07:12:21 in /builds/slave/test 07:12:21 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 07:12:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:21 INFO - {'append_to_log': False, 07:12:21 INFO - 'base_work_dir': '/builds/slave/test', 07:12:21 INFO - 'blob_upload_branch': 'Graphics', 07:12:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:21 INFO - 'branch': 'Graphics', 07:12:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:21 INFO - 'config_files': ('talos/mac_config.py',), 07:12:21 INFO - 'default_actions': ('clobber', 07:12:21 INFO - 'read-buildbot-config', 07:12:21 INFO - 'download-and-extract', 07:12:21 INFO - 'populate-webroot', 07:12:21 INFO - 'create-virtualenv', 07:12:21 INFO - 'install', 07:12:21 INFO - 'run-tests'), 07:12:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:21 INFO - 'download_minidump_stackwalk': True, 07:12:21 INFO - 'download_symbols': 'ondemand', 07:12:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:21 INFO - 'installer_path': 'installer.exe', 07:12:21 INFO - 'log_level': 'info', 07:12:21 INFO - 'log_name': 'talos', 07:12:21 INFO - 'log_to_console': True, 07:12:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:12:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:12:21 INFO - 'opt_config_files': (), 07:12:21 INFO - 'pip_index': False, 07:12:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:12:21 INFO - 'cmd': ('bash', 07:12:21 INFO - '-c', 07:12:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:12:21 INFO - 'enabled': True, 07:12:21 INFO - 'halt_on_failure': False, 07:12:21 INFO - 'name': 'check_screen_resolution'},), 07:12:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:12:21 INFO - 'cmd': ('bash', 07:12:21 INFO - '-c', 07:12:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:12:21 INFO - 'enabled': True, 07:12:21 INFO - 'halt_on_failure': False, 07:12:21 INFO - 'name': 'check_screen_resolution'},), 07:12:21 INFO - 'run_cmd_checks_enabled': True, 07:12:21 INFO - 'sps_profile': False, 07:12:21 INFO - 'sps_profile_interval': 0, 07:12:21 INFO - 'suite': 'dromaeojs', 07:12:21 INFO - 'system_bits': '32', 07:12:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:21 INFO - 'title': 't-yosemite-r7-0284', 07:12:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:21 INFO - 'use_talos_json': True, 07:12:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:21 INFO - 'work_dir': 'build'} 07:12:21 INFO - [mozharness: 2017-01-24 15:12:21.380864Z] Running clobber step. 07:12:21 INFO - Running pre-action listener: _resource_record_pre_action 07:12:21 INFO - Running main action method: clobber 07:12:21 INFO - rmtree: /builds/slave/test/build 07:12:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:23 INFO - Running post-action listener: _resource_record_post_action 07:12:23 INFO - [mozharness: 2017-01-24 15:12:23.872130Z] Finished clobber step (success) 07:12:23 INFO - [mozharness: 2017-01-24 15:12:23.872374Z] Running read-buildbot-config step. 07:12:23 INFO - Running pre-action listener: _resource_record_pre_action 07:12:23 INFO - Running main action method: read_buildbot_config 07:12:23 INFO - Using buildbot properties: 07:12:23 INFO - { 07:12:23 INFO - "project": "", 07:12:23 INFO - "product": "firefox", 07:12:23 INFO - "script_repo_revision": "default", 07:12:23 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 07:12:23 INFO - "repository": "", 07:12:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 07:12:23 INFO - "buildid": "20170124054448", 07:12:23 INFO - "pgo_build": "False", 07:12:23 INFO - "basedir": "/builds/slave/test", 07:12:23 INFO - "buildnumber": 14, 07:12:23 INFO - "slavename": "t-yosemite-r7-0284", 07:12:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:12:23 INFO - "platform": "yosemite_r7", 07:12:23 INFO - "scheduler": "tests-graphics-macosx64-talos", 07:12:23 INFO - "branch": "graphics", 07:12:23 INFO - "repo_path": "projects/graphics", 07:12:23 INFO - "revision": "b86ff4066687c7f880598820360b3c564b4f60d6", 07:12:23 INFO - "stage_platform": "macosx64", 07:12:23 INFO - "builduid": "e68c87fb07f2410aa2b298994700cd75", 07:12:23 INFO - "slavebuilddir": "test" 07:12:23 INFO - } 07:12:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 07:12:23 INFO - Running post-action listener: _resource_record_post_action 07:12:23 INFO - [mozharness: 2017-01-24 15:12:23.877942Z] Finished read-buildbot-config step (success) 07:12:23 INFO - [mozharness: 2017-01-24 15:12:23.878102Z] Running download-and-extract step. 07:12:23 INFO - Running pre-action listener: _resource_record_pre_action 07:12:23 INFO - Running main action method: download_and_extract 07:12:23 INFO - mkdir: /builds/slave/test/build/tests 07:12: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')]} 07:12:23 INFO - trying https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 07:12:23 INFO - Downloading https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 07:12:24 INFO - Downloaded 1199 bytes. 07:12:24 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:12:24 INFO - Using the following test package requirements: 07:12:24 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:12:24 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:12:24 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:12:24 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'jsshell-mac.zip'], 07:12:24 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:12:24 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:12:24 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:12:24 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:12:24 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:12:24 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:12:24 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:12:24 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:12:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:12:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:12:24 INFO - Fetch https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:12:26 INFO - Expected file size: 16351069 07:12:26 INFO - Obtained file size: 16351069 07:12:33 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:12:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:12:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:12:33 INFO - Fetch https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:12:33 INFO - Expected file size: 16351069 07:12:33 INFO - Obtained file size: 16351069 07:12:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 07:12:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:12:40 INFO - Fetch https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 07:12:41 INFO - Expected file size: 14403485 07:12:41 INFO - Obtained file size: 14403485 07:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:42 INFO - trying https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:12:42 INFO - Downloading https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 07:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 07:12:46 INFO - Downloaded 70100628 bytes. 07:12:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:12:46 INFO - mkdir: /builds/slave/test/properties 07:12:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:46 INFO - Contents: 07:12:46 INFO - build_url:https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:12:46 INFO - Running post-action listener: _resource_record_post_action 07:12:46 INFO - Running post-action listener: set_extra_try_arguments 07:12:46 INFO - [mozharness: 2017-01-24 15:12:46.812327Z] Finished download-and-extract step (success) 07:12:46 INFO - [mozharness: 2017-01-24 15:12:46.812461Z] Running populate-webroot step. 07:12:46 INFO - Running pre-action listener: _resource_record_pre_action 07:12:46 INFO - Running main action method: populate_webroot 07:12:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:12:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:12:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:12:46 INFO - '--tppagecycles', 07:12:46 INFO - '7'], 07:12:46 INFO - 'tests': ['tsvgm']}}, 07:12:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:12:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:12:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:12:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:12:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:12:46 INFO - 'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:12:46 INFO - 'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['damp', 'tps']}, 07:12:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:12:46 INFO - 'tests': ['damp', 'tps']}, 07:12:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['dromaeo_dom']}, 07:12:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['basic_compositor_video']}, 07:12:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:12:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['a11yr', 07:12:46 INFO - 'ts_paint', 07:12:46 INFO - 'tpaint', 07:12:46 INFO - 'sessionrestore', 07:12:46 INFO - 'sessionrestore_no_auto_restore', 07:12:46 INFO - 'tabpaint']}, 07:12:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:12:46 INFO - 'ts_paint', 07:12:46 INFO - 'tpaint', 07:12:46 INFO - 'sessionrestore', 07:12:46 INFO - 'sessionrestore_no_auto_restore', 07:12:46 INFO - 'tabpaint']}, 07:12:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:12:46 INFO - 'ts_paint', 07:12:46 INFO - 'tpaint', 07:12:46 INFO - 'sessionrestore', 07:12:46 INFO - 'sessionrestore_no_auto_restore', 07:12:46 INFO - 'tabpaint']}, 07:12:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:12:46 INFO - 'ts_paint', 07:12:46 INFO - 'tpaint', 07:12:46 INFO - 'sessionrestore', 07:12:46 INFO - 'sessionrestore_no_auto_restore', 07:12:46 INFO - 'tabpaint']}, 07:12:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['a11yr', 07:12:46 INFO - 'ts_paint', 07:12:46 INFO - 'tpaint', 07:12:46 INFO - 'sessionrestore', 07:12:46 INFO - 'sessionrestore_no_auto_restore', 07:12:46 INFO - 'tabpaint']}, 07:12:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['a11yr', 07:12:46 INFO - 'ts_paint', 07:12:46 INFO - 'tpaint', 07:12:46 INFO - 'sessionrestore', 07:12:46 INFO - 'sessionrestore_no_auto_restore', 07:12:46 INFO - 'tabpaint']}, 07:12:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['tsvgx', 07:12:46 INFO - 'tsvgr_opacity', 07:12:46 INFO - 'tart', 07:12:46 INFO - 'tscrollx', 07:12:46 INFO - 'cart', 07:12:46 INFO - 'tsvg_static']}, 07:12:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:12:46 INFO - 'tsvgr_opacity', 07:12:46 INFO - 'tart', 07:12:46 INFO - 'tscrollx', 07:12:46 INFO - 'cart', 07:12:46 INFO - 'tsvg_static']}, 07:12:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:12:46 INFO - 'talos_options': ['--disable-e10s'], 07:12:46 INFO - 'tests': ['tp5o']}, 07:12:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:12:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:12:46 INFO - 'talos_options': ['--disable-e10s', 07:12:46 INFO - '--xperf_path', 07:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:46 INFO - 'tests': ['tp5n']}, 07:12:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:12:46 INFO - 'talos_options': ['--xperf_path', 07:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:46 INFO - 'tests': ['tp5n']}}, 07:12:46 INFO - 'talos.zip': {'path': '', 07:12:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:12:46 INFO - Running post-action listener: _resource_record_post_action 07:12:46 INFO - [mozharness: 2017-01-24 15:12:46.830752Z] Finished populate-webroot step (success) 07:12:46 INFO - [mozharness: 2017-01-24 15:12:46.830855Z] Running create-virtualenv step. 07:12:46 INFO - Running pre-action listener: _resource_record_pre_action 07:12:46 INFO - Running main action method: create_virtualenv 07:12:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:46 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 07:12:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:12:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:46 INFO - Using real prefix '/tools/python27' 07:12:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:50 INFO - Installing pip.................done. 07:12:50 INFO - Return code: 0 07:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:12:50 INFO - Reading from file tmpfile_stdout 07:12:50 INFO - Output received: 07:12:50 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) 07:12:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:50 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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:12:50 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 07:12:50 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 07:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:50 INFO - 'HOME': '/Users/cltbld', 07:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:50 INFO - 'LOGNAME': 'cltbld', 07:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:50 INFO - 'MOZ_NO_REMOTE': '1', 07:12:50 INFO - 'NO_EM_RESTART': '1', 07:12:50 INFO - 'PAGER': '/bin/cat', 07:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:50 INFO - 'PWD': '/builds/slave/test', 07:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:50 INFO - 'SHELL': '/bin/bash', 07:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:12:50 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:50 INFO - 'USER': 'cltbld', 07:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:50 INFO - 'XPC_FLAGS': '0x0', 07:12:50 INFO - 'XPC_SERVICE_NAME': '0', 07:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:51 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 07:12:51 INFO - Cleaning up... 07:12:51 INFO - Return code: 0 07:12:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:12:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:12:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:51 INFO - 'HOME': '/Users/cltbld', 07:12:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:51 INFO - 'LOGNAME': 'cltbld', 07:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:51 INFO - 'MOZ_NO_REMOTE': '1', 07:12:51 INFO - 'NO_EM_RESTART': '1', 07:12:51 INFO - 'PAGER': '/bin/cat', 07:12:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:51 INFO - 'PWD': '/builds/slave/test', 07:12:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:51 INFO - 'SHELL': '/bin/bash', 07:12:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:12:51 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:12:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:51 INFO - 'USER': 'cltbld', 07:12:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:51 INFO - 'XPC_FLAGS': '0x0', 07:12:51 INFO - 'XPC_SERVICE_NAME': '0', 07:12:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:51 INFO - Downloading/unpacking psutil>=3.1.1 07:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:54 INFO - Installing collected packages: psutil 07:12:54 INFO - Running setup.py install for psutil 07:12:54 INFO - building 'psutil._psutil_osx' extension 07:12:54 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 07:12:55 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 07:12:55 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 07:12:55 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 07:12:55 INFO - building 'psutil._psutil_posix' extension 07:12:55 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 07:12:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:12:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:12:55 INFO - ^ 07:12:55 INFO - 1 warning generated. 07:12:55 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 07:12:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:55 INFO - Successfully installed psutil 07:12:55 INFO - Cleaning up... 07:12:55 INFO - Return code: 0 07:12:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:55 INFO - 'HOME': '/Users/cltbld', 07:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:55 INFO - 'LOGNAME': 'cltbld', 07:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:55 INFO - 'MOZ_NO_REMOTE': '1', 07:12:55 INFO - 'NO_EM_RESTART': '1', 07:12:55 INFO - 'PAGER': '/bin/cat', 07:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:55 INFO - 'PWD': '/builds/slave/test', 07:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:55 INFO - 'SHELL': '/bin/bash', 07:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:12:55 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:55 INFO - 'USER': 'cltbld', 07:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:55 INFO - 'XPC_FLAGS': '0x0', 07:12:55 INFO - 'XPC_SERVICE_NAME': '0', 07:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:12:56 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 07:12:56 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 07:12:56 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 07:12:56 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 07:12:56 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 07:12:56 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 07:12:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:12:58 INFO - Installing collected packages: mozsystemmonitor 07:12:58 INFO - Running setup.py install for mozsystemmonitor 07:12:59 INFO - Successfully installed mozsystemmonitor 07:12:59 INFO - Cleaning up... 07:12:59 INFO - Return code: 0 07:12:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:12:59 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')]} 07:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:59 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')]} 07:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:59 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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:12:59 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 07:12:59 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 07:12:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:12:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:59 INFO - 'HOME': '/Users/cltbld', 07:12:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:59 INFO - 'LOGNAME': 'cltbld', 07:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:59 INFO - 'MOZ_NO_REMOTE': '1', 07:12:59 INFO - 'NO_EM_RESTART': '1', 07:12:59 INFO - 'PAGER': '/bin/cat', 07:12:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:59 INFO - 'PWD': '/builds/slave/test', 07:12:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:59 INFO - 'SHELL': '/bin/bash', 07:12:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:12:59 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:12:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:59 INFO - 'USER': 'cltbld', 07:12:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:59 INFO - 'XPC_FLAGS': '0x0', 07:12:59 INFO - 'XPC_SERVICE_NAME': '0', 07:12:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:12:59 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 07:12:59 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 07:12:59 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 07:12:59 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 07:12:59 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 07:12:59 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 07:13:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:13:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07: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 07: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 07: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 07: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 07: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 07: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 07:13:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:13:02 INFO - warning: no files found matching '*.txt' 07:13:02 INFO - no previously-included directories found matching 'build' 07:13:02 INFO - no previously-included directories found matching 'dist' 07:13:02 INFO - no previously-included directories found matching '.git*' 07:13:02 INFO - Installing collected packages: jsonschema, functools32 07:13:02 INFO - Running setup.py install for functools32 07:13:02 INFO - warning: no files found matching '*.txt' 07:13:02 INFO - no previously-included directories found matching 'build' 07:13:02 INFO - no previously-included directories found matching 'dist' 07:13:02 INFO - no previously-included directories found matching '.git*' 07:13:02 INFO - Successfully installed jsonschema functools32 07:13:02 INFO - Cleaning up... 07:13:02 INFO - Return code: 0 07:13:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07: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')]} 07:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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', '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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07: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 functools32==3.2.3-2 07:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:02 INFO - 'HOME': '/Users/cltbld', 07:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:02 INFO - 'LOGNAME': 'cltbld', 07:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:02 INFO - 'MOZ_NO_REMOTE': '1', 07:13:02 INFO - 'NO_EM_RESTART': '1', 07:13:02 INFO - 'PAGER': '/bin/cat', 07:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:02 INFO - 'PWD': '/builds/slave/test', 07:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:02 INFO - 'SHELL': '/bin/bash', 07:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:13:02 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:02 INFO - 'USER': 'cltbld', 07:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:02 INFO - 'XPC_FLAGS': '0x0', 07:13:02 INFO - 'XPC_SERVICE_NAME': '0', 07:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:13:03 INFO - Cleaning up... 07:13:03 INFO - Return code: 0 07:13:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:03 INFO - 'HOME': '/Users/cltbld', 07:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:03 INFO - 'LOGNAME': 'cltbld', 07:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:03 INFO - 'MOZ_NO_REMOTE': '1', 07:13:03 INFO - 'NO_EM_RESTART': '1', 07:13:03 INFO - 'PAGER': '/bin/cat', 07:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:03 INFO - 'PWD': '/builds/slave/test', 07:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:03 INFO - 'SHELL': '/bin/bash', 07:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:13:03 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:03 INFO - 'USER': 'cltbld', 07:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:03 INFO - 'XPC_FLAGS': '0x0', 07:13:03 INFO - 'XPC_SERVICE_NAME': '0', 07:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:13:03 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 07:13:03 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 07:13:03 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 07:13:03 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 07:13:03 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 07:13:03 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 07:13:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:13:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:13:06 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 07:13:06 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 07:13:06 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 07:13:06 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 07:13:06 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 07:13:06 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 07:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:13:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:13:06 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 07:13:06 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 07:13:06 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 07:13:06 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 07:13:06 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 07:13:06 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 07:13:07 INFO - Downloading docopt-0.6.1.tar.gz 07:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:13:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:13:07 INFO - Running setup.py install for blobuploader 07:13:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:13:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:13:07 INFO - Running setup.py install for requests 07:13:07 INFO - Running setup.py install for docopt 07:13:08 INFO - Successfully installed blobuploader requests docopt 07:13:08 INFO - Cleaning up... 07:13:08 INFO - Return code: 0 07:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:08 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')]} 07:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:08 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')]} 07:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:08 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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:13:08 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 07:13:08 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 07:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:08 INFO - 'HOME': '/Users/cltbld', 07:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:08 INFO - 'LOGNAME': 'cltbld', 07:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:08 INFO - 'MOZ_NO_REMOTE': '1', 07:13:08 INFO - 'NO_EM_RESTART': '1', 07:13:08 INFO - 'PAGER': '/bin/cat', 07:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:08 INFO - 'PWD': '/builds/slave/test', 07:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:08 INFO - 'SHELL': '/bin/bash', 07:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:13:08 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:08 INFO - 'USER': 'cltbld', 07:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:08 INFO - 'XPC_FLAGS': '0x0', 07:13:08 INFO - 'XPC_SERVICE_NAME': '0', 07:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:08 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-gvDOIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:08 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-cXVNmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:08 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Ojn2Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:08 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-5Pj8m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:08 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-H1dUas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:08 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-NGUg_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-glGJBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-46M4Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-PPnhZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-dNspwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-NWRBqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-TGbW5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-1dQMiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-qkqOm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ee6auJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:09 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-hSOSK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:10 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-UhHM3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:13:10 INFO - Running setup.py install for manifestparser 07:13:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:13:10 INFO - Running setup.py install for mozcrash 07:13:10 INFO - Running setup.py install for mozdebug 07:13:10 INFO - Running setup.py install for mozdevice 07:13:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:13:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:13:10 INFO - Running setup.py install for mozfile 07:13:10 INFO - Running setup.py install for mozhttpd 07:13:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Running setup.py install for mozinfo 07:13:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Running setup.py install for mozInstall 07:13:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Running setup.py install for mozleak 07:13:11 INFO - Running setup.py install for mozlog 07:13:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Running setup.py install for moznetwork 07:13:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:13:11 INFO - Running setup.py install for mozprocess 07:13:11 INFO - Running setup.py install for mozprofile 07:13:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:13:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:13:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:13:12 INFO - Running setup.py install for mozrunner 07:13:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:13:12 INFO - Running setup.py install for mozscreenshot 07:13:12 INFO - Running setup.py install for moztest 07:13:12 INFO - Running setup.py install for mozversion 07:13:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:13:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:13:12 INFO - Cleaning up... 07:13:12 INFO - Return code: 0 07:13:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:13 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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:13:13 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 07:13:13 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 07:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:13 INFO - 'HOME': '/Users/cltbld', 07:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:13 INFO - 'LOGNAME': 'cltbld', 07:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:13 INFO - 'MOZ_NO_REMOTE': '1', 07:13:13 INFO - 'NO_EM_RESTART': '1', 07:13:13 INFO - 'PAGER': '/bin/cat', 07:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:13 INFO - 'PWD': '/builds/slave/test', 07:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:13 INFO - 'SHELL': '/bin/bash', 07:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:13:13 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:13 INFO - 'USER': 'cltbld', 07:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:13 INFO - 'XPC_FLAGS': '0x0', 07:13:13 INFO - 'XPC_SERVICE_NAME': '0', 07:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-vj09Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:13 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)) 07:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:13 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-BDOWtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-cXPSBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Dun4wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-w0mlFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-qXfxA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-aBZyuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-9bp9sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-3RIEwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-jKKzEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:14 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)) 07:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:14 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-CNXsoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:15 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)) 07:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:15 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ufWCd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:15 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-y3dJDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:15 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)) 07:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:15 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-YJRDVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:15 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)) 07:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:15 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-gKbZ2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:15 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)) 07:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:15 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-hsdu98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:15 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-MGk2Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:15 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)) 07:13:15 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)) 07:13:15 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)) 07:13:15 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)) 07:13:15 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)) 07:13:15 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)) 07:13:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:15 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 07:13:15 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 07:13:15 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 07:13:15 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 07:13:15 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 07:13:15 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 07:13:18 INFO - Downloading blessings-1.6.tar.gz 07:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:13:18 INFO - Installing collected packages: blessings 07:13:18 INFO - Running setup.py install for blessings 07:13:18 INFO - Successfully installed blessings 07:13:18 INFO - Cleaning up... 07:13:18 INFO - Return code: 0 07:13:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:19 INFO - Reading from file tmpfile_stdout 07:13:19 INFO - Current package versions: 07:13:19 INFO - blessings == 1.6 07:13:19 INFO - blobuploader == 1.2.4 07:13:19 INFO - docopt == 0.6.1 07:13:19 INFO - functools32 == 3.2.3-2 07:13:19 INFO - jsonschema == 2.5.1 07:13:19 INFO - manifestparser == 1.1 07:13:19 INFO - mozInstall == 1.12 07:13:19 INFO - mozcrash == 1.0 07:13:19 INFO - mozdebug == 0.1 07:13:19 INFO - mozdevice == 0.49 07:13:19 INFO - mozfile == 1.2 07:13:19 INFO - mozhttpd == 0.7 07:13:19 INFO - mozinfo == 0.9 07:13:19 INFO - mozleak == 0.1 07:13:19 INFO - mozlog == 3.4 07:13:19 INFO - moznetwork == 0.27 07:13:19 INFO - mozprocess == 0.24 07:13:19 INFO - mozprofile == 0.28 07:13:19 INFO - mozrunner == 6.13 07:13:19 INFO - mozscreenshot == 0.1 07:13:19 INFO - mozsystemmonitor == 0.3 07:13:19 INFO - moztest == 0.8 07:13:19 INFO - mozversion == 1.4 07:13:19 INFO - psutil == 3.1.1 07:13:19 INFO - requests == 1.2.3 07:13:19 INFO - wsgiref == 0.1.2 07:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07: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')]} 07:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:19 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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:13:19 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 07:13:19 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 07:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:19 INFO - 'HOME': '/Users/cltbld', 07:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:19 INFO - 'LOGNAME': 'cltbld', 07:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:19 INFO - 'MOZ_NO_REMOTE': '1', 07:13:19 INFO - 'NO_EM_RESTART': '1', 07:13:19 INFO - 'PAGER': '/bin/cat', 07:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:19 INFO - 'PWD': '/builds/slave/test', 07:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:19 INFO - 'SHELL': '/bin/bash', 07:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:13:19 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:19 INFO - 'USER': 'cltbld', 07:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:19 INFO - 'XPC_FLAGS': '0x0', 07:13:19 INFO - 'XPC_SERVICE_NAME': '0', 07:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 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)) 07:13:19 INFO - Cleaning up... 07:13:19 INFO - Return code: 0 07:13:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07: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')]} 07:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:19 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 0x10c2fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c300768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca99d76020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, '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.wPx51bEFq7/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.BLeUz9gXSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 07:13:19 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 07:13:19 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 07:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:19 INFO - 'HOME': '/Users/cltbld', 07:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:19 INFO - 'LOGNAME': 'cltbld', 07:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:19 INFO - 'MOZ_NO_REMOTE': '1', 07:13:19 INFO - 'NO_EM_RESTART': '1', 07:13:19 INFO - 'PAGER': '/bin/cat', 07:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:19 INFO - 'PWD': '/builds/slave/test', 07:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:19 INFO - 'SHELL': '/bin/bash', 07:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:13:19 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:19 INFO - 'USER': 'cltbld', 07:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:19 INFO - 'XPC_FLAGS': '0x0', 07:13:19 INFO - 'XPC_SERVICE_NAME': '0', 07:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:13:19 INFO - Cleaning up... 07:13:19 INFO - Return code: 0 07:13:19 INFO - Running post-action listener: _resource_record_post_action 07:13:19 INFO - Running post-action listener: _start_resource_monitoring 07:13:19 INFO - Starting resource monitoring. 07:13:19 INFO - [mozharness: 2017-01-24 15:13:19.785558Z] Finished create-virtualenv step (success) 07:13:19 INFO - [mozharness: 2017-01-24 15:13:19.786541Z] Running install step. 07:13:19 INFO - Running pre-action listener: _resource_record_pre_action 07:13:19 INFO - Running main action method: install 07:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:20 INFO - Reading from file tmpfile_stdout 07:13:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:13:20 INFO - Reading from file tmpfile_stdout 07:13:20 INFO - Output received: 07:13:20 INFO - Usage: mozinstall [options] installer 07:13:20 INFO - Options: 07:13:20 INFO - -h, --help show this help message and exit 07:13:20 INFO - -d DEST, --destination=DEST 07:13:20 INFO - Directory to install application into. [default: 07:13:20 INFO - "/builds/slave/test"] 07:13:20 INFO - --app=APP Application being installed. [default: firefox] 07:13:20 INFO - mkdir: /builds/slave/test/build/application 07:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:13:42 INFO - Reading from file tmpfile_stdout 07:13:42 INFO - Output received: 07:13:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:13:42 INFO - Running post-action listener: _resource_record_post_action 07:13:42 INFO - [mozharness: 2017-01-24 15:13:42.091916Z] Finished install step (success) 07:13:42 INFO - [mozharness: 2017-01-24 15:13:42.092052Z] Running run-tests step. 07:13:42 INFO - Running pre-action listener: _resource_record_pre_action 07:13:42 INFO - Running main action method: run_tests 07:13:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:13:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:13:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:13:42 INFO - 2017-01-24 07:13:42.106 screenresolution[1622:7358] starting screenresolution argv=screenresolution get 07:13:42 INFO - 2017-01-24 07:13:42.109 screenresolution[1622:7358] Display 0: 1600x1200x32@60 07:13:42 INFO - 2017-01-24 07:13:42.115 screenresolution[1623:7361] starting screenresolution argv=screenresolution list 07:13:42 INFO - Available Modes on Display 0 07:13:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:13:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:13:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:13:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:13:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:13:42 INFO - Intel Iris: 07:13:42 INFO - Chipset Model: Intel Iris 07:13:42 INFO - Type: GPU 07:13:42 INFO - Bus: Built-In 07:13:42 INFO - VRAM (Dynamic, Max): 1536 MB 07:13:42 INFO - Vendor: Intel (0x8086) 07:13:42 INFO - Device ID: 0x0a2e 07:13:42 INFO - Revision ID: 0x0009 07:13:42 INFO - Displays: 07:13:42 INFO - Display: 07:13:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:13:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:13:42 INFO - Display Serial Number: 1600x1200 60 07:13:42 INFO - Main Display: Yes 07:13:42 INFO - Mirror: Off 07:13:42 INFO - Online: Yes 07:13:42 INFO - Rotation: Supported 07:13:42 INFO - Return code: 0 07:13:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:42 INFO - Python 2.7.3 07:13:42 INFO - Return code: 0 07:13:42 INFO - grabbing minidump binary from tooltool 07:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:42 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 0x10c0dbd30>, '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 0x10c002db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:42 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 07:13:42 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 07:13:42 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 07:13:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:42 INFO - Return code: 0 07:13:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:13:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:13:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:42 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/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 07:13:42 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/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0284 --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 07:13:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wPx51bEFq7/Render', 07:13:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:42 INFO - 'HOME': '/Users/cltbld', 07:13:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:42 INFO - 'LOGNAME': 'cltbld', 07:13:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:42 INFO - 'MOZ_NO_REMOTE': '1', 07:13:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:42 INFO - 'NO_EM_RESTART': '1', 07:13:42 INFO - 'PAGER': '/bin/cat', 07:13:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:42 INFO - 'PWD': '/builds/slave/test', 07:13:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:42 INFO - 'SHELL': '/bin/bash', 07:13:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLeUz9gXSS/Listeners', 07:13:42 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 07:13:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:42 INFO - 'USER': 'cltbld', 07:13:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:42 INFO - 'XPC_FLAGS': '0x0', 07:13:42 INFO - 'XPC_SERVICE_NAME': '0', 07:13:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:42 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/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 07:13:42 INFO - mozversion application_buildid: 20170124054448 07:13:42 INFO - mozversion application_changeset: b86ff4066687c7f880598820360b3c564b4f60d6 07:13:42 INFO - mozversion application_display_name: Nightly 07:13:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:42 INFO - mozversion application_name: Firefox 07:13:42 INFO - mozversion application_remotingname: firefox 07:13:42 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 07:13:42 INFO - mozversion application_vendor: Mozilla 07:13:42 INFO - mozversion application_version: 54.0a1 07:13:42 INFO - mozversion platform_buildid: 20170124054448 07:13:42 INFO - mozversion platform_changeset: b86ff4066687c7f880598820360b3c564b4f60d6 07:13:42 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 07:13:42 INFO - mozversion platform_version: 54.0a1 07:13:42 INFO - using testdate: 1485270822 07:13:42 INFO - actual date: 1485270822 07:13:42 INFO - starting webserver on 'localhost:49241' 07:13:42 INFO - SUITE-START | Running 2 tests 07:13:42 INFO - TEST-START | dromaeo_css 07:13:42 INFO - operating with platform_type : mac_ 07:13:42 INFO - Initialising browser for dromaeo_css test... 07:13:42 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpGcHcQ0/profile http://localhost:49241/getInfo.html) 07:13:45 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 07:13:45 INFO - PROCESS | 1633 | colorDepth:24 07:13:45 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 07:13:45 INFO - PROCESS | 1633 | __metrics 07:13:45 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 07:13:45 INFO - PROCESS | 1633 | 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" 07:13:45 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:46 INFO - TEST-INFO | 1633: exit 0 07:13:46 INFO - Browser initialized. 07:13:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:46 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpGcHcQ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:58 INFO - PROCESS | 1635 | RSS: Main: 235474944 07:13:58 INFO - PROCESS | 1635 | 07:17:02 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 07:17:03 INFO - PROCESS | 1635 | RSS: Main: 343429120 07:17:03 INFO - PROCESS | 1635 | 07:18:47 INFO - PROCESS | 1635 | ************************* 07:18:47 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 07:18:47 INFO - PROCESS | 1635 | 07:18:47 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:18:47 INFO - PROCESS | 1635 | Full stack: 07:18:47 INFO - PROCESS | 1635 | ************************* 07:20:06 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 07:20:07 INFO - PROCESS | 1635 | RSS: Main: 367493120 07:20:07 INFO - PROCESS | 1635 | 07:23:09 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 07:23:10 INFO - PROCESS | 1635 | RSS: Main: 332935168 07:23:10 INFO - PROCESS | 1635 | 07:26:12 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:26:13 INFO - PROCESS | 1635 | RSS: Main: 354914304 07:26:13 INFO - PROCESS | 1635 | 07:29:16 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:29:17 INFO - PROCESS | 1635 | RSS: Main: 324218880 07:29:17 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:32:20 INFO - PROCESS | 1635 | RSS: Main: 510177280 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | __start_tp_report 07:32:20 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 07:32:20 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 07:32:20 INFO - PROCESS | 1635 | |i|pagename|runs| 07:32:20 INFO - PROCESS | 1635 | |0;dojo.html;3265.085775982724;3286.162028682687;3294.7364210863134;3322.9169270768243;3352.83235838208;3993.700472464562;5369.704666243355;5403.540699040582;5441.863953401167;5521.950829342427;5422.349318081826;5462.6995515246645;5479.424660410649;5496.862578435541;5499.807506737265;4979.651424400303;5005.54950054495;5024.422191447976;5054.469280725526;5066.113430149728;5004.074246264435;5124.564412024983;5183.3779946406485;5190.896182076356;5218.060749065166;5142.151544995071;5143.305653736754;5154.201098829687;5163.509466600685;5172.793088276483;5025.271335656309;5138.3577052868395;5139.049275883974;5177.585793136578;5208.5051920067535;4912.435069966964;5129.384473863123;5129.692218466904;5138.74306284688;5154.871128221787;5443.319585051869;5450.29146210994;5496.367917689477;5532.861678458031;5546.112621980504;6107.236595425572;6159.87680246397;6169;6174.197354343952;6180.84547886302;6112.877742445126;6192.28788689302;6194.690265486708;6198.721057552376;6210.7826226082325;5552.750126244369;5593;5610.018246806792;5621.8594535136135;5758.452946970031;6237.656928868956;6253.1245625612455;6280.685965701697;6297.905531417033;6307.936920630735;5996.880062398727;6025.638461692312;6028.939710602838;6036.978729532835;6088.969555152196;5991.850203744942;6050.757969681252;6094.146819445281;6152.107944348045;6162.599431036968;6043.365446628129;6098.054801505774;6099.298580663191;6112.7554897804475;6140.596275277727;6105.709757709155;6124.74712746768;6128.911607031542;6137.665489739718;6140.394703972021;4720;4842.346283251716;4842.491538388489;4846.80612775485;4909.77905994224;4252.4046633471335;4329.307310830252;4336.82652693895;4389.209942210433;4399.406080179199;5524.806631767869;5593.608447408724;5631.802886898939;5647.29408823897;5696.430356964271;4973.254011898244;5960.523158147338;6174.845628859314;6205.348438413992;6206.534509911775;5564.749586268627;5595.4124816894455;5606.6916319602815;5631.099024156116;5695.345035320991;5332.280142180756;5332.30680011596;5336.199570064444;5338.412774594792;5350.250964864922;6213.161223234986;6226.034964580497;6236.064590311489;6236.532260080421;6242.843928901813;4967.379077615298;5949.702514874326;5958.374370691188;6104.216637118914;6195.96902015487;6180.47465965398;6217.595856269509;6243.937560624518;6254.687265636791;6256.374362563707;6155.353687862889;6162.599431036968;6171.074338849208;6171.5988460751705;6171.660558669317;6026.578139530367;6051.334353221054;6099.207103076572;6139.201903752483;6181.103739957771;5885.55858310637;6035.9094613579955;6038.788642397495;6072.574919755575;6080.513558915188;5925.377835327228;5980.252468441445;6008.098785182257;6015.849603759766;6020.849478762891;5661.886762264814;5704.714764261853;5749.338826035059;5812.796552120655;5835.7373918174635;5877.706114694333;5888.852778680396;5899.911501327398;5965.880682386415;6038.184845045863;4761.1905975984855;5248.711320877388;5794.101914203306;5814.592978491465;5851.268591426072 07:32:20 INFO - PROCESS | 1635 | |1;ext.html;440.39445762077145;449.69870186974725;469.6172619315258;501.0330062978455;505.6763671250398;30522.694773052262;38818;41121.99999999996;41152.58847411525;41453.58546414535;42481.78759106208;42813.93570060936;42854.7857260714;42887.78556107215;42994.14011719764;7901.683932642702;9506.287028472858;9506.857397139049;9507.23942084635;9512.57193426294;8442.366822488308;8654.350923680719;9131.68039118631;11440.5423783049;11474.48364823585;11434.085273178125;11513.251638643504;11521.423928803568;11523.308601483895;11545.307281563091;10158.746031349201;10975.725606859813;11417.94291028548;11481.712957176054;11499.310041397459;8286.751397458025;8543.914560854375;10944.17918656096;11241.437928103562;11279.492422840993;35569.93290201272;38561.03597410059;40097;40521.392179117334;40676.98307542306;3717.925641487182;3921.8039098044983;4041.2927737645796;4052.128792309638;4058.2289365020847;29086.418271634662;30332.84833575818;30760;30819.537706934414;30845.537316940263;3139.309351942569;3263.4452143135486;3277.6066871975518;3332.3668502984597;3341.7159541439005;350014;350550;350907;352730;354726;59563;60070.69964650236;60103;60124.69937650284;60186.39813601808;62735.37264627386;62827.057594136124;62891.42771430751;62911.685441572496;63022.05466918;15507.069575825486;15937.920310398375;15939.203039847962;15944;15985.920070399807;11303.717407064889;12441.440135193938;12509.812352814715;12513.186642868184;12546.811797822857;14058.648533786738;14487.78268325976;15623.921880390526;15877.888547801544;16014.119223442589;6162.705831775377;6196.938030619726;6209.9068513972325;6242.750289988349;6275.466585340206;870.433220203631;873.9956300218458;879.7580665316962;895.1183084661603;911.2209061252667;29469.852650736608;29609.851950740107;29642.703572964427;30330.54504182439;30366;1002.2583288366557;1050.558765318568;1078.2398409121552;1091.956321747137;1108.6806700027103;15001;15408.922955385375;15425.305861236271;15585.688286234212;15803.8937274392;554856;556048;557038;557963;562601;59088.40911590829;59096.70451647714;59115;59188.40811591829;59464.40535594675;1432.5415866922692;1436.9353379097965;1451.2090910453828;1456.0753921260075;1456.2791418248034;24589.38526536851;27555.17334479969;27926.30184245329;30041.849790750908;30136.54795178118;49785.53645880282;50294.49705502898;50398.74800625973;50414;50488;438550;514249.4287528538;516847;517439;517707;23300;23723.40691482727;23911.28266152018;24530.386740331636;38960;35292.64707352893;38894.80552597219;40853.38719919263;41710.1657966845;42531.3620295702;35086;35199.64800352066;35363;36147;36329.27341453209;35162.824185878904;35267.82366088153;35876.103097422776;36358.8182059088;36530.634693652726;34517.706150713406;34802.9559113227;35301.64698353086;35501.46747798733;35581.82209088938;30342.393152137276;31568.052958411285;31647;31665.683343166274;32053.839730801195;23610.88194559016;23932.88033559821;24234.515309693354;24239.51520969606;24303.51392972166 07:32:20 INFO - PROCESS | 1635 | |2;jquery.html;383.14940831354386;390.8671051842373;390.972631915766;397.12235958531653;421.49210201706927;14488.637784055403;20498.282560110398;21051.2632057878;21932.013059412344;22018.559628807434;21416.9291535423;21660.89169554154;22004.8899755501;22028.559428811415;22238.88880555595;5610.719464026803;5933.792317268896;5935.554833387513;5938.9703051484685;5947.345791962903;4800.879978000543;5386.218998245252;5580.497755202031;5866.6480011199255;5875.206847075654;5843.065109582468;5847.532197424217;5851.648901065928;5853.8829223415505;5859.44335288147;5558.74928141169;5606.523445507137;5786.768529258846;5835.0372188588835;5847.590668653196;4764.4520880098535;5150.871228219287;5154.716490593016;5165.896682066375;5195.584353251731;26235.21294361172;27123.186304410898;27172.913083476837;27189.320266993287;27385.726142738517;2752.353196998704;2757.765589924859;2774.5005898938184;2779.6942336342986;2786.8467234302107;10548;12536.623901282976;14682.486112985995;15076.773848392282;16257.756133658004;1828.232142500153;1875.1749230338608;1876.2776331112484;1883.4349695091555;1885.3495544037285;139366.6063339364;139464;140241;142330.2883485576;143174;9648.469334186688;11859.407029648482;11967.820482692767;11986.940065299792;12091.395430228453;13855.674638086786;14435.133891966305;15724.528264152093;15772.526824195063;15789;6505.41451269388;6766.526343156031;8180.427370084156;8553.786155346043;8694.739157825275;8271.793205169799;8273.83452330962;8296.875546866802;8422.83154336922;8440.240378365976;4730.479647238801;4733.95266047342;4734.313524538922;4773.904521909542;4890.779914903838;1869.3454296849627;1982.1278637399498;2026.9189232430833;2034.298167132337;2034.52188735647;861.8879545659024;878.8637761147032;879.4785021912128;883.88067610873;911.193593669594;21450;21857.344279671634;22038;22070.22754203595;22085.558288834454;895.9059298773665;897.8967418746928;914.0996118822954;918.5407296351824;919.6827094652334;11031.503582338813;11315.15136364776;11334.546618135182;11372.054457166136;11582;713282;729365;732457;736046;739470.302648494;138093.6190638081;141285.29357353147;145858;146489;158925;950.1496160935924;988.8665030220828;1012.1548506996593;1012.8581998520214;1014.0873214107362;17957.37149199824;18557;18679.346222882134;18946.147423365706;18949.43151705451;57457;57978.55053623693;59273;59675;60518;84474;84820.24567174853;85960.71058934246;86493;86603.56698216469;8262.917370826215;8304.211099945496;8560.14398560139;8613.397062205586;8629.180227878593;11497.252678575866;13092.672683182996;13242.47030118823;13682.247476388895;13691.973102017588;10829.133669306595;11107.611233606785;11403.315801051964;11453.19827612059;11801.70495737579;5383.0579648562125;9479.383840050376;10205.84691229647;10814.808152578447;10954.890451095705;11014.39420831862;11230.831537527107;11399;11415.258008229439;11416.372099534605;8294.626741796514;8308.87536686938;8483.915160848559;8702.56487175626;8744.344174186834;10700.946495267473;10808.162612355762;10903.781924361627;10948.616798412017;11369.886301136883 07:32:20 INFO - PROCESS | 1635 | |3;mootools.html;1215.659615307714;1324.8873845723112;1467.5964109869785;1481.87404070654;1488.3228131200312;7934.365250779938;8340.958295208524;8354.206350396702;8368.958155209215;8374.37192210585;7460.552366857993;7608.201138880421;7619.314261716444;7672.539647621146;7675.616219189033;2215.5901158285687;2306.423394151462;2307.1694190091553;2316.247219653619;2320.9091726888337;2299.5630830142304;2322.512272422785;2341.6838726771925;2344.495933374324;2349.3421841884215;1614.8950318229336;1880.2385034061226;2295.391721193885;2306.5848147333472;2307.538492301538;2032.0754056904073;2052.7639321478073;2201.7137772089686;2210.071769856664;2296.0815673730476;2241.495663475705;2296.1733775840685;2306.273523840002;2307.957457649975;2310.4685922237977;8291.461055031403;8339.916600833974;8359.8328033439;8375.916240837636;8382.245597896157;4993.226049962262;5169.121249387613;5169.198774190007;5169.741512924339;5172;3446.672566106216;3457.481377793326;3485.1635607454027;3550.9112272193142;3560.572731272238;1214.7995580729169;1222.6515443098674;1235.7590269897373;1262.211118051218;1267.1130208853747;10679.893201068046;10718.464076796128;10727.302725322907;10730.087942524895;10735.194860385423;4286.185624731291;4593.242115050979;4649.628029757679;4684.461286951976;4697.577218050392;9395.248380129573;9403.670871519464;9414.388064775767;9423.858642120374;9432.858507122399;5088.109580823341;5089.847304580869;5097.796088156507;5189.481051894781;5191.2472691459525;4533.084324955898;4674.111918735497;4705.788239529229;4745.14587374269;4785.306130611111;3760.7179461540495;3809.1429428378947;3814.294355544233;3859.826307816155;3905.414187871842;1259.2696236182992;1259.3262604506544;1261.6278197931633;1275.8213850061;1283.9101262911506;810.9351251899834;834;847.093609837468;880.8062226310202;901.1709227510706;5017.8243761468175;5229.555487783505;5354.705491197944;5377.865553361197;5502.394736578973;562.1118632560544;563.7181409295353;573.7618888161367;575.2148317546519;577.6591810831545;3199.77601567888;3712.8514859405323;3734.2531493701367;3749.8125093745202;3810.942835857464;9514.429134251966;9693.369930954465;9906.950465247772;9920.007999200023;9923.801523969625;9302.674406395743;9850.950745246371;9862.112409883002;9867.259955503367;9882.505874706236;7337.596432196174;7818.843623127619;7823.843523129505;7833.2558406952385;7834.294913457702;4700.882477938079;5530.391656917655;5650.124230744241;5697.943020569741;5757.96356655806;8736.475811451333;8965.551722413984;9003.009668936542;9015.098490150933;9066.184043436122;8565.785855353666;9297.814043719223;9371.812563748823;9433.29250306216;9450.102240287162;6660.367265109807;6860;6863.416609588241;7013.929860701328;7270.818229544304;7851;7972.322352599862;8075.717349892726;8088.797780055545;8096;7062.611556364243;7110.964445177741;7128;7156.284371562802;7191.101112360955;6982.546134501241;7057;7058.11773528309;7109.502334836512;7145.214026456982;6242.53181011435;6367.777127800505;6369.585976911486;6378.77674281398;6395.616263024233;4372.978135109304;4834.7824347903725;4930.827421040246;4963.10664080469;4964.627652925973;4811.08589368019;4834.63740219492;4952.678075925053;5013.598912086952;5098.796048158032 07:32:20 INFO - PROCESS | 1635 | |4;prototype.html;299.60152996514637;346.80669190377336;366.89543480108165;372.5510759534761;375.25324604037974;5130.333056702632;5290.180022096576;5320.494553017466;5324.680519168853;5346.732663366831;5280.815171468999;5280.867978300535;5299.761510732017;5309.654872433289;5317.813876514313;3832.9076213279222;3951.960480395188;4102.692298077641;4200.954308126599;4244.957550424502;3380.340833537461;3792.715546334036;4012.916512541612;4110.938335924963;4173.853915112972;3536.257385948954;3591.892243232707;4113.773742444165;4135.06960933789;4139.503259608851;3461.809600471973;3901.4733011043713;4029.234445455354;4092.5498195198506;4177.227212965611;3595.46068089786;3668.486411902336;3673.246984368198;3679.197193375254;3703.3148867459336;5188.974055129738;5198.480151984809;5225.764840582183;5239.502247286502;5273.472652734734;4357.237483440417;4796.928046079277;4823.8422778532895;4853.3690620219495;4894.657373983822;5599.440055994409;5601;5610.803621873215;5639.646484843649;5677;3367.932641347184;3459.077079867508;3642.8542858285637;3764.3788774852114;3864.6908247340143;5746.9425305747245;5814.503873844689;5869.530437564985;5935.465808077251;5970.313413957407;3437.845296961643;3869.400242962345;3870.6129387061633;3897.2595206910596;3911.491506104245;3406.267652454734;3596.496490491333;3905.453236546886;3962.9009274767786;3964.2467931093;4296.4414626098405;4374.912501749947;4417.249067658441;4517.503074661785;4625.838095666702;5057.620678449131;5088.898222035613;5476.890462190813;5659.292588426447;5682.6306290091015;1087.9555626598396;1272.1603741530546;1286.5497076023505;1286.8713128687057;1289.7613941420868;802.6789284286332;829.4815740162398;868.9956550217208;877.5261358866269;878.3939082033504;4223.472065991751;4771.117343291502;5051.217061355495;5151.124308867502;5276.657017293864;5243.632945693841;5618.43815618443;5621.297337832771;5647.604667673306;5758.704291534371;3920.4315374270573;4061.735987160825;4757;4794.267267657402;4843.878903027382;2375.853931188672;2608.1612463213387;2659.029454249185;2823.3365159187574;2883.9711602883704;5132.79468821243;5347.598930080259;5536.972315138479;5719.8570035749435;5755.1871160585115;4751.667383283137;5348.358197016305;5643.428822653664;5648.802291919763;5678.772849086073;5264.5525130363585;5486.506214440719;5764.625299355528;5997.430244126801;6023.909641355295;5263.157894736823;5541.251930989265;5675.971620141873;5828;5834;5071.746412679425;5523.254360661259;5562.499375056264;5742.483176514133;5833.474987250998;5951.464368206882;5989.490893274121;5995.88008239824;6003.729832157651;6004.249468816398;3876.903077423087;3911.647951684362;3937.845572920596;3940.960590394059;3951.78265195417;4426.203283409017;4998.725070121032;5307.946920530745;5375.059364611099;5471.003083874437;5152.098382783073;5252.632315738015;5563.527100196528;5647.181158731879;5666.773329066791;4966.627502937222;5615.859603509945;5658.292713410824;5661.433856614306;5776.595638305278;4802.471728109975;5283.920741188962;5458.645188062763;5519.944800551943;5536.837264174407;4633.351330813756;4928.728919909439;5314.734263286898;5608.85977850557;5626.634268772516;5399.9190012149065;5442;5443.733759744122;5458.6724796512335;5520.282363292747 07:32:20 INFO - PROCESS | 1635 | |5;yui.html;718.4719231364943;720.6360787802159;771.5872008475463;826.140813553904;832.142892820395;12585.433655485502;14953.252337383141;14968.625784355383;14969.625759356022;14991.550253492385;14435.42258309669;14537.273136343167;14595.008023355187;14608.780868286958;14614.196219207939;686.1423220973783;868.3791089371114;887.3699673232013;892.1301730812471;892.7054072156172;700.3591713582066;710.7441321124392;846.7967687754956;871.3856731004627;887.4896934262824;943.9993606776839;947.5783276441986;948.1750876737214;949.2216382566298;951.9904800951971;939.5584075484511;940.8071345374182;940.8259471997702;941.4257303045136;942.6559305853383;531.1236459841255;546.97265136743;679.7858674517511;696.7839969609437;702.581963731584;15002.774958375632;15242.314095865713;15279.159646219454;15299.082055076731;15306.234688265653;12292.692682682915;13270.800937985938;14014.22921739304;14055.718885622231;14084.647883802885;10749.301295415773;11674.1244406669;12710.300933448656;12775;12931;4385.057212699253;4416.315471101984;4445.622122119624;4559.794809233559;4583.854036490878;106041;109717;109754;109955.45022274918;112946;10983.835242471368;11270.09839212861;11307.321560706385;11365.204435689422;11558.735504114598;22326.33021009372;22793.658095128587;22808.087676492756;22845.657315140284;22925.08299668028;7591.962040189764;7689.346405555479;7779.7666070017995;7860.3318717909615;7932.246436588515;3535.5934067582043;4233.682473814476;4265.3601959705675;4288.574373612405;4412.646988240933;2785.832850028964;3397.524346591479;3495.178633021238;3497.877574284888;3498.038039539147;587.9323877754113;624.8533940219747;631.0912286307703;646.2309851276965;657.2408867757747;622.3869488553771;645.2869579115104;646.4763541531281;650.0087366765625;652.6377860287586;8784.121587841293;9332;9378.390404623678;9714.22286217101;9922;609.9725512351955;639.5395315372924;639.7696829141598;643.1960049937578;657.8223879552589;4203.390508376268;4554.567316104964;4769.523047695203;4781.952180478151;4782;98093;101972;102545;102765.48617257015;104297;90829;90980.5450972741;93741.5312923431;93931.99999999863;95449;79697;83188.3362332762;83571;83658.58170709107;84665.15334846573;9065.184133428023;9271.165595096474;9271.907280927104;9339.906600933904;9382.765430864283;53450.73274633602;53615.73192134014;54094.18858717201;55173.82087442955;55792.44207557872;53065;64047.39881502814;64284;64523;71837.12651493882;10672.946635266773;12037.277763334228;13402.195868247936;13428.5685723709;14005.299735013004;14809.33357998871;15017.624559385666;15074.321655525308;15664.216789160724;15820.92089539591;13527.391267393188;13842.584722458343;14280.428782848985;14303.856961430252;14669.70660586761;12684.936575317064;13236.338183091;14348.641283967567;14457.98794084404;14583.635409114857;11438;12025.917667409974;13462.932685336511;13705.383257753225;14466.132032077689;10607.893921060691;10933.398663073607;10996.615118470816;11326.716832079264;11599.710007249887;9204.677836275967;10797.29817561856;10842.674719758419;11008.834867476835;11033.117350612092 07:32:20 INFO - PROCESS | 1635 | __end_tp_report 07:32:20 INFO - PROCESS | 1635 | __start_cc_report 07:32:20 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1153 07:32:20 INFO - PROCESS | 1635 | __end_cc_report 07:32:20 INFO - PROCESS | 1635 | __startTimestamp1485271940942__endTimestamp 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | ------- Summary: start ------- 07:32:20 INFO - PROCESS | 1635 | Number of tests: 6 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5605.37 Median:5794.10 stddev:653.61 (11.3%) stddev-sans-first:629.31 07:32:20 INFO - PROCESS | 1635 | Values: 3265.1 3286.2 3294.7 3322.9 3352.8 3993.7 5369.7 5403.5 5441.9 5522.0 5422.3 5462.7 5479.4 5496.9 5499.8 4979.7 5005.5 5024.4 5054.5 5066.1 5004.1 5124.6 5183.4 5190.9 5218.1 5142.2 5143.3 5154.2 5163.5 5172.8 5025.3 5138.4 5139.0 5177.6 5208.5 4912.4 5129.4 5129.7 5138.7 5154.9 5443.3 5450.3 5496.4 5532.9 5546.1 6107.2 6159.9 6169.0 6174.2 6180.8 6112.9 6192.3 6194.7 6198.7 6210.8 5552.8 5593.0 5610.0 5621.9 5758.5 6237.7 6253.1 6280.7 6297.9 6307.9 5996.9 6025.6 6028.9 6037.0 6089.0 5991.9 6050.8 6094.1 6152.1 6162.6 6043.4 6098.1 6099.3 6112.8 6140.6 6105.7 6124.7 6128.9 6137.7 6140.4 4720.0 4842.3 4842.5 4846.8 4909.8 4252.4 4329.3 4336.8 4389.2 4399.4 5524.8 5593.6 5631.8 5647.3 5696.4 4973.3 5960.5 6174.8 6205.3 6206.5 5564.7 5595.4 5606.7 5631.1 5695.3 5332.3 5332.3 5336.2 5338.4 5350.3 6213.2 6226.0 6236.1 6236.5 6242.8 4967.4 5949.7 5958.4 6104.2 6196.0 6180.5 6217.6 6243.9 6254.7 6256.4 6155.4 6162.6 6171.1 6171.6 6171.7 6026.6 6051.3 6099.2 6139.2 6181.1 5885.6 6035.9 6038.8 6072.6 6080.5 5925.4 5980.3 6008.1 6015.8 6020.8 5661.9 5704.7 5749.3 5812.8 5835.7 5877.7 5888.9 5899.9 5965.9 6038.2 4761.2 5248.7 5794.1 5814.6 5851.3 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:61340.69 Median:35297.15 stddev:127451.82 (361.1%) stddev-sans-first:127727.34 07:32:20 INFO - PROCESS | 1635 | Values: 440.4 449.7 469.6 501.0 505.7 30522.7 38818.0 41122.0 41152.6 41453.6 42481.8 42813.9 42854.8 42887.8 42994.1 7901.7 9506.3 9506.9 9507.2 9512.6 8442.4 8654.4 9131.7 11440.5 11474.5 11434.1 11513.3 11521.4 11523.3 11545.3 10158.7 10975.7 11417.9 11481.7 11499.3 8286.8 8543.9 10944.2 11241.4 11279.5 35569.9 38561.0 40097.0 40521.4 40677.0 3717.9 3921.8 4041.3 4052.1 4058.2 29086.4 30332.8 30760.0 30819.5 30845.5 3139.3 3263.4 3277.6 3332.4 3341.7 350014.0 350550.0 350907.0 352730.0 354726.0 59563.0 60070.7 60103.0 60124.7 60186.4 62735.4 62827.1 62891.4 62911.7 63022.1 15507.1 15937.9 15939.2 15944.0 15985.9 11303.7 12441.4 12509.8 12513.2 12546.8 14058.6 14487.8 15623.9 15877.9 16014.1 6162.7 6196.9 6209.9 6242.8 6275.5 870.4 874.0 879.8 895.1 911.2 29469.9 29609.9 29642.7 30330.5 30366.0 1002.3 1050.6 1078.2 1092.0 1108.7 15001.0 15408.9 15425.3 15585.7 15803.9 554856.0 556048.0 557038.0 557963.0 562601.0 59088.4 59096.7 59115.0 59188.4 59464.4 1432.5 1436.9 1451.2 1456.1 1456.3 24589.4 27555.2 27926.3 30041.8 30136.5 49785.5 50294.5 50398.7 50414.0 50488.0 438550.0 514249.4 516847.0 517439.0 517707.0 23300.0 23723.4 23911.3 24530.4 38960.0 35292.6 38894.8 40853.4 41710.2 42531.4 35086.0 35199.6 35363.0 36147.0 36329.3 35162.8 35267.8 35876.1 36358.8 36530.6 34517.7 34803.0 35301.6 35501.5 35581.8 30342.4 31568.1 31647.0 31665.7 32053.8 23610.9 23932.9 24234.5 24239.5 24303.5 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:40407.18 Median:2755.06 stddev:121755.02 (4419.3%) stddev-sans-first:122059.48 07:32:20 INFO - PROCESS | 1635 | Values: 383.1 390.9 391.0 397.1 421.5 14488.6 20498.3 21051.3 21932.0 22018.6 21416.9 21660.9 22004.9 22028.6 22238.9 5610.7 5933.8 5935.6 5939.0 5947.3 4800.9 5386.2 5580.5 5866.6 5875.2 5843.1 5847.5 5851.6 5853.9 5859.4 5558.7 5606.5 5786.8 5835.0 5847.6 4764.5 5150.9 5154.7 5165.9 5195.6 26235.2 27123.2 27172.9 27189.3 27385.7 2752.4 2757.8 2774.5 2779.7 2786.8 10548.0 12536.6 14682.5 15076.8 16257.8 1828.2 1875.2 1876.3 1883.4 1885.3 139366.6 139464.0 140241.0 142330.3 143174.0 9648.5 11859.4 11967.8 11986.9 12091.4 13855.7 14435.1 15724.5 15772.5 15789.0 6505.4 6766.5 8180.4 8553.8 8694.7 8271.8 8273.8 8296.9 8422.8 8440.2 4730.5 4734.0 4734.3 4773.9 4890.8 1869.3 1982.1 2026.9 2034.3 2034.5 861.9 878.9 879.5 883.9 911.2 21450.0 21857.3 22038.0 22070.2 22085.6 895.9 897.9 914.1 918.5 919.7 11031.5 11315.2 11334.5 11372.1 11582.0 713282.0 729365.0 732457.0 736046.0 739470.3 138093.6 141285.3 145858.0 146489.0 158925.0 950.1 988.9 1012.2 1012.9 1014.1 17957.4 18557.0 18679.3 18946.1 18949.4 57457.0 57978.6 59273.0 59675.0 60518.0 84474.0 84820.2 85960.7 86493.0 86603.6 8262.9 8304.2 8560.1 8613.4 8629.2 11497.3 13092.7 13242.5 13682.2 13692.0 10829.1 11107.6 11403.3 11453.2 11801.7 5383.1 9479.4 10205.8 10814.8 10954.9 11014.4 11230.8 11399.0 11415.3 11416.4 8294.6 8308.9 8483.9 8702.6 8744.3 10700.9 10808.2 10903.8 10948.6 11369.9 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5356.52 Median:5190.36 stddev:2940.09 (56.6%) stddev-sans-first:2931.86 07:32:20 INFO - PROCESS | 1635 | Values: 1215.7 1324.9 1467.6 1481.9 1488.3 7934.4 8341.0 8354.2 8369.0 8374.4 7460.6 7608.2 7619.3 7672.5 7675.6 2215.6 2306.4 2307.2 2316.2 2320.9 2299.6 2322.5 2341.7 2344.5 2349.3 1614.9 1880.2 2295.4 2306.6 2307.5 2032.1 2052.8 2201.7 2210.1 2296.1 2241.5 2296.2 2306.3 2308.0 2310.5 8291.5 8339.9 8359.8 8375.9 8382.2 4993.2 5169.1 5169.2 5169.7 5172.0 3446.7 3457.5 3485.2 3550.9 3560.6 1214.8 1222.7 1235.8 1262.2 1267.1 10679.9 10718.5 10727.3 10730.1 10735.2 4286.2 4593.2 4649.6 4684.5 4697.6 9395.2 9403.7 9414.4 9423.9 9432.9 5088.1 5089.8 5097.8 5189.5 5191.2 4533.1 4674.1 4705.8 4745.1 4785.3 3760.7 3809.1 3814.3 3859.8 3905.4 1259.3 1259.3 1261.6 1275.8 1283.9 810.9 834.0 847.1 880.8 901.2 5017.8 5229.6 5354.7 5377.9 5502.4 562.1 563.7 573.8 575.2 577.7 3199.8 3712.9 3734.3 3749.8 3810.9 9514.4 9693.4 9907.0 9920.0 9923.8 9302.7 9851.0 9862.1 9867.3 9882.5 7337.6 7818.8 7823.8 7833.3 7834.3 4700.9 5530.4 5650.1 5697.9 5758.0 8736.5 8965.6 9003.0 9015.1 9066.2 8565.8 9297.8 9371.8 9433.3 9450.1 6660.4 6860.0 6863.4 7013.9 7270.8 7851.0 7972.3 8075.7 8088.8 8096.0 7062.6 7111.0 7128.0 7156.3 7191.1 6982.5 7057.0 7058.1 7109.5 7145.2 6242.5 6367.8 6369.6 6378.8 6395.6 4373.0 4834.8 4930.8 4963.1 4964.6 4811.1 4834.6 4952.7 5013.6 5098.8 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4511.28 Median:5151.61 stddev:1395.53 (27.1%) stddev-sans-first:1363.18 07:32:20 INFO - PROCESS | 1635 | Values: 299.6 346.8 366.9 372.6 375.3 5130.3 5290.2 5320.5 5324.7 5346.7 5280.8 5280.9 5299.8 5309.7 5317.8 3832.9 3952.0 4102.7 4201.0 4245.0 3380.3 3792.7 4012.9 4110.9 4173.9 3536.3 3591.9 4113.8 4135.1 4139.5 3461.8 3901.5 4029.2 4092.5 4177.2 3595.5 3668.5 3673.2 3679.2 3703.3 5189.0 5198.5 5225.8 5239.5 5273.5 4357.2 4796.9 4823.8 4853.4 4894.7 5599.4 5601.0 5610.8 5639.6 5677.0 3367.9 3459.1 3642.9 3764.4 3864.7 5746.9 5814.5 5869.5 5935.5 5970.3 3437.8 3869.4 3870.6 3897.3 3911.5 3406.3 3596.5 3905.5 3962.9 3964.2 4296.4 4374.9 4417.2 4517.5 4625.8 5057.6 5088.9 5476.9 5659.3 5682.6 1088.0 1272.2 1286.5 1286.9 1289.8 802.7 829.5 869.0 877.5 878.4 4223.5 4771.1 5051.2 5151.1 5276.7 5243.6 5618.4 5621.3 5647.6 5758.7 3920.4 4061.7 4757.0 4794.3 4843.9 2375.9 2608.2 2659.0 2823.3 2884.0 5132.8 5347.6 5537.0 5719.9 5755.2 4751.7 5348.4 5643.4 5648.8 5678.8 5264.6 5486.5 5764.6 5997.4 6023.9 5263.2 5541.3 5676.0 5828.0 5834.0 5071.7 5523.3 5562.5 5742.5 5833.5 5951.5 5989.5 5995.9 6003.7 6004.2 3876.9 3911.6 3937.8 3941.0 3951.8 4426.2 4998.7 5307.9 5375.1 5471.0 5152.1 5252.6 5563.5 5647.2 5666.8 4966.6 5615.9 5658.3 5661.4 5776.6 4802.5 5283.9 5458.6 5519.9 5536.8 4633.4 4928.7 5314.7 5608.9 5626.6 5399.9 5442.0 5443.7 5458.7 5520.3 07:32:20 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:20836.71 Median:4430.97 stddev:30134.75 (680.1%) stddev-sans-first:30181.43 07:32:20 INFO - PROCESS | 1635 | Values: 718.5 720.6 771.6 826.1 832.1 12585.4 14953.3 14968.6 14969.6 14991.6 14435.4 14537.3 14595.0 14608.8 14614.2 686.1 868.4 887.4 892.1 892.7 700.4 710.7 846.8 871.4 887.5 944.0 947.6 948.2 949.2 952.0 939.6 940.8 940.8 941.4 942.7 531.1 547.0 679.8 696.8 702.6 15002.8 15242.3 15279.2 15299.1 15306.2 12292.7 13270.8 14014.2 14055.7 14084.6 10749.3 11674.1 12710.3 12775.0 12931.0 4385.1 4416.3 4445.6 4559.8 4583.9 106041.0 109717.0 109754.0 109955.5 112946.0 10983.8 11270.1 11307.3 11365.2 11558.7 22326.3 22793.7 22808.1 22845.7 22925.1 7592.0 7689.3 7779.8 7860.3 7932.2 3535.6 4233.7 4265.4 4288.6 4412.6 2785.8 3397.5 3495.2 3497.9 3498.0 587.9 624.9 631.1 646.2 657.2 622.4 645.3 646.5 650.0 652.6 8784.1 9332.0 9378.4 9714.2 9922.0 610.0 639.5 639.8 643.2 657.8 4203.4 4554.6 4769.5 4782.0 4782.0 98093.0 101972.0 102545.0 102765.5 104297.0 90829.0 90980.5 93741.5 93932.0 95449.0 79697.0 83188.3 83571.0 83658.6 84665.2 9065.2 9271.2 9271.9 9339.9 9382.8 53450.7 53615.7 54094.2 55173.8 55792.4 53065.0 64047.4 64284.0 64523.0 71837.1 10672.9 12037.3 13402.2 13428.6 14005.3 14809.3 15017.6 15074.3 15664.2 15820.9 13527.4 13842.6 14280.4 14303.9 14669.7 12684.9 13236.3 14348.6 14458.0 14583.6 11438.0 12025.9 13462.9 13705.4 14466.1 10607.9 10933.4 10996.6 11326.7 11599.7 9204.7 10797.3 10842.7 11008.8 11033.1 07:32:20 INFO - PROCESS | 1635 | -------- Summary: end -------- 07:32:20 INFO - PROCESS | 1635 | 07:32:21 INFO - TEST-INFO | 1635: exit 0 07:32:21 INFO - TEST-OK | dromaeo_css | took 1118920ms 07:32:21 INFO - TEST-START | kraken 07:32:21 INFO - operating with platform_type : mac_ 07:32:21 INFO - Initialising browser for kraken test... 07:32:21 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmphzRuSZ/profile http://localhost:49241/getInfo.html) 07:32:24 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 07:32:24 INFO - PROCESS | 1646 | colorDepth:24 07:32:24 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 07:32:24 INFO - PROCESS | 1646 | __metrics 07:32:24 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 07:32:24 INFO - PROCESS | 1646 | 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" 07:32:24 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:32:24 INFO - TEST-INFO | 1646: exit 0 07:32:24 INFO - Browser initialized. 07:32:24 INFO - Running cycle 1/1 for kraken test... 07:32:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmphzRuSZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:37 INFO - PROCESS | 1647 | RSS: Main: 227995648 07:32:37 INFO - PROCESS | 1647 | 07:32:39 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:40 INFO - PROCESS | 1647 | RSS: Main: 288100352 07:32:40 INFO - PROCESS | 1647 | 07:32:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:32:43 INFO - PROCESS | 1647 | RSS: Main: 290336768 07:32:43 INFO - PROCESS | 1647 | 07:32:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:32:47 INFO - PROCESS | 1647 | RSS: Main: 381128704 07:32:47 INFO - PROCESS | 1647 | 07:32:49 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:32:50 INFO - PROCESS | 1647 | RSS: Main: 281202688 07:32:50 INFO - PROCESS | 1647 | 07:32:52 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:53 INFO - PROCESS | 1647 | RSS: Main: 286560256 07:32:53 INFO - PROCESS | 1647 | 07:32:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:56 INFO - PROCESS | 1647 | RSS: Main: 326983680 07:32:56 INFO - PROCESS | 1647 | 07:32:59 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:00 INFO - PROCESS | 1647 | RSS: Main: 329703424 07:33:00 INFO - PROCESS | 1647 | 07:33:02 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:33:03 INFO - PROCESS | 1647 | RSS: Main: 326451200 07:33:03 INFO - PROCESS | 1647 | 07:33:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:05 INFO - PROCESS | 1647 | RSS: Main: 303562752 07:33:05 INFO - PROCESS | 1647 | 07:33:07 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:08 INFO - PROCESS | 1647 | RSS: Main: 307630080 07:33:08 INFO - PROCESS | 1647 | 07:33:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:11 INFO - PROCESS | 1647 | RSS: Main: 312659968 07:33:11 INFO - PROCESS | 1647 | 07:33:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:14 INFO - PROCESS | 1647 | RSS: Main: 328605696 07:33:14 INFO - PROCESS | 1647 | 07:33:17 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:18 INFO - PROCESS | 1647 | RSS: Main: 322961408 07:33:18 INFO - PROCESS | 1647 | 07:33:19 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:33:20 INFO - PROCESS | 1647 | RSS: Main: 367050752 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | __start_tp_report 07:33:20 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 07:33:20 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 07:33:20 INFO - PROCESS | 1647 | |i|pagename|runs| 07:33:20 INFO - PROCESS | 1647 | |0;ai-astar;111;114;113;115;113;115;113;114;114;114 07:33:20 INFO - PROCESS | 1647 | |1;audio-beat-detection;140;111;107;149;109;112;110;111;130;109 07:33:20 INFO - PROCESS | 1647 | |2;audio-dft;185;186;183;186;185;182;182;181;183;184 07:33:20 INFO - PROCESS | 1647 | |3;audio-fft;81;57;58;107;86;84;58;58;74;60 07:33:20 INFO - PROCESS | 1647 | |4;audio-oscillator;87;71;86;70;68;70;82;69;69;83 07:33:20 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;88;85;88;85;88;88;89;86;88;85 07:33:20 INFO - PROCESS | 1647 | |6;imaging-darkroom;96;97;96;96;96;96;96;96;95;97 07:33:20 INFO - PROCESS | 1647 | |7;imaging-desaturate;86;87;86;87;87;85;87;85;84;87 07:33:20 INFO - PROCESS | 1647 | |8;json-parse-financial;57;55;56;56;56;55;54;55;54;54 07:33:20 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;69;71;71;76;73;71;72;72;71;72 07:33:20 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;89;87;87;85;90;87;87;91;90;87 07:33:20 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;141;141;139;138;139;138;141;140;177;149 07:33:20 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;177;175;177;173;175;175;174;174;174;174 07:33:20 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;69;68;68;66;67;69;65;66;67;66 07:33:20 INFO - PROCESS | 1647 | __end_tp_report 07:33:20 INFO - PROCESS | 1647 | __start_cc_report 07:33:20 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1970 07:33:20 INFO - PROCESS | 1647 | __end_cc_report 07:33:20 INFO - PROCESS | 1647 | __startTimestamp1485272000172__endTimestamp 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | ------- Summary: start ------- 07:33:20 INFO - PROCESS | 1647 | Number of tests: 14 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.17 (1.0%) stddev-sans-first:0.78 07:33:20 INFO - PROCESS | 1647 | Values: 111.0 114.0 113.0 115.0 113.0 115.0 113.0 114.0 114.0 114.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:111.50 stddev:15.14 (13.6%) stddev-sans-first:13.98 07:33:20 INFO - PROCESS | 1647 | Values: 140.0 111.0 107.0 149.0 109.0 112.0 110.0 111.0 130.0 109.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:1.77 (1.0%) stddev-sans-first:1.81 07:33:20 INFO - PROCESS | 1647 | Values: 185.0 186.0 183.0 186.0 185.0 182.0 182.0 181.0 183.0 184.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:72.30 Median:67.00 stddev:17.02 (25.4%) stddev-sans-first:17.76 07:33:20 INFO - PROCESS | 1647 | Values: 81.0 57.0 58.0 107.0 86.0 84.0 58.0 58.0 74.0 60.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.50 stddev:7.91 (10.3%) stddev-sans-first:7.21 07:33:20 INFO - PROCESS | 1647 | Values: 87.0 71.0 86.0 70.0 68.0 70.0 82.0 69.0 69.0 83.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 07:33:20 INFO - PROCESS | 1647 | Values: 88.0 85.0 88.0 85.0 88.0 88.0 89.0 86.0 88.0 85.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:33:20 INFO - PROCESS | 1647 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:87.00 stddev:1.10 (1.3%) stddev-sans-first:1.17 07:33:20 INFO - PROCESS | 1647 | Values: 86.0 87.0 86.0 87.0 87.0 85.0 87.0 85.0 84.0 87.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.03 (1.9%) stddev-sans-first:0.87 07:33:20 INFO - PROCESS | 1647 | Values: 57.0 55.0 56.0 56.0 56.0 55.0 54.0 55.0 54.0 54.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:1.81 (2.5%) stddev-sans-first:1.62 07:33:20 INFO - PROCESS | 1647 | Values: 69.0 71.0 71.0 76.0 73.0 71.0 72.0 72.0 71.0 72.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.00 stddev:1.89 (2.1%) stddev-sans-first:1.96 07:33:20 INFO - PROCESS | 1647 | Values: 89.0 87.0 87.0 85.0 90.0 87.0 87.0 91.0 90.0 87.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:141.00 stddev:11.92 (8.5%) stddev-sans-first:12.58 07:33:20 INFO - PROCESS | 1647 | Values: 141.0 141.0 139.0 138.0 139.0 138.0 141.0 140.0 177.0 149.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:1.32 (0.8%) stddev-sans-first:1.13 07:33:20 INFO - PROCESS | 1647 | Values: 177.0 175.0 177.0 173.0 175.0 175.0 174.0 174.0 174.0 174.0 07:33:20 INFO - PROCESS | 1647 | 07:33:20 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.37 (2.0%) stddev-sans-first:1.27 07:33:20 INFO - PROCESS | 1647 | Values: 69.0 68.0 68.0 66.0 67.0 69.0 65.0 66.0 67.0 66.0 07:33:20 INFO - PROCESS | 1647 | -------- Summary: end -------- 07:33:20 INFO - PROCESS | 1647 | 07:33:21 INFO - TEST-INFO | 1647: exit 0 07:33:21 INFO - TEST-OK | kraken | took 59498ms 07:33:21 INFO - SUITE-END | took 1178s 07:33:21 INFO - Completed test suite (00:19:38) 07:33:21 INFO - javascript benchmark 07:33:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.085775982724, 3286.162028682687, 3294.7364210863134, 3322.9169270768243, 3352.83235838208, 3993.700472464562, 5369.704666243355, 5403.540699040582, 5441.863953401167, 5521.950829342427, 5422.349318081826, 5462.6995515246645, 5479.424660410649, 5496.862578435541, 5499.807506737265, 4979.651424400303, 5005.54950054495, 5024.422191447976, 5054.469280725526, 5066.113430149728, 5004.074246264435, 5124.564412024983, 5183.3779946406485, 5190.896182076356, 5218.060749065166, 5142.151544995071, 5143.305653736754, 5154.201098829687, 5163.509466600685, 5172.793088276483, 5025.271335656309, 5138.3577052868395, 5139.049275883974, 5177.585793136578, 5208.5051920067535, 4912.435069966964, 5129.384473863123, 5129.692218466904, 5138.74306284688, 5154.871128221787, 5443.319585051869, 5450.29146210994, 5496.367917689477, 5532.861678458031, 5546.112621980504, 6107.236595425572, 6159.87680246397, 6169.0, 6174.197354343952, 6180.84547886302, 6112.877742445126, 6192.28788689302, 6194.690265486708, 6198.721057552376, 6210.7826226082325, 5552.750126244369, 5593.0, 5610.018246806792, 5621.8594535136135, 5758.452946970031, 6237.656928868956, 6253.1245625612455, 6280.685965701697, 6297.905531417033, 6307.936920630735, 5996.880062398727, 6025.638461692312, 6028.939710602838, 6036.978729532835, 6088.969555152196, 5991.850203744942, 6050.757969681252, 6094.146819445281, 6152.107944348045, 6162.599431036968, 6043.365446628129, 6098.054801505774, 6099.298580663191, 6112.7554897804475, 6140.596275277727, 6105.709757709155, 6124.74712746768, 6128.911607031542, 6137.665489739718, 6140.394703972021, 4720.0, 4842.346283251716, 4842.491538388489, 4846.80612775485, 4909.77905994224, 4252.4046633471335, 4329.307310830252, 4336.82652693895, 4389.209942210433, 4399.406080179199, 5524.806631767869, 5593.608447408724, 5631.802886898939, 5647.29408823897, 5696.430356964271, 4973.254011898244, 5960.523158147338, 6174.845628859314, 6205.348438413992, 6206.534509911775, 5564.749586268627, 5595.4124816894455, 5606.6916319602815, 5631.099024156116, 5695.345035320991, 5332.280142180756, 5332.30680011596, 5336.199570064444, 5338.412774594792, 5350.250964864922, 6213.161223234986, 6226.034964580497, 6236.064590311489, 6236.532260080421, 6242.843928901813, 4967.379077615298, 5949.702514874326, 5958.374370691188, 6104.216637118914, 6195.96902015487, 6180.47465965398, 6217.595856269509, 6243.937560624518, 6254.687265636791, 6256.374362563707, 6155.353687862889, 6162.599431036968, 6171.074338849208, 6171.5988460751705, 6171.660558669317, 6026.578139530367, 6051.334353221054, 6099.207103076572, 6139.201903752483, 6181.103739957771, 5885.55858310637, 6035.9094613579955, 6038.788642397495, 6072.574919755575, 6080.513558915188, 5925.377835327228, 5980.252468441445, 6008.098785182257, 6015.849603759766, 6020.849478762891, 5661.886762264814, 5704.714764261853, 5749.338826035059, 5812.796552120655, 5835.7373918174635, 5877.706114694333, 5888.852778680396, 5899.911501327398, 5965.880682386415, 6038.184845045863, 4761.1905975984855, 5248.711320877388, 5794.101914203306, 5814.592978491465, 5851.268591426072], "value": 5564.070101323204, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.39445762077145, 449.69870186974725, 469.6172619315258, 501.0330062978455, 505.6763671250398, 30522.694773052262, 38818.0, 41121.99999999996, 41152.58847411525, 41453.58546414535, 42481.78759106208, 42813.93570060936, 42854.7857260714, 42887.78556107215, 42994.14011719764, 7901.683932642702, 9506.287028472858, 9506.857397139049, 9507.23942084635, 9512.57193426294, 8442.366822488308, 8654.350923680719, 9131.68039118631, 11440.5423783049, 11474.48364823585, 11434.085273178125, 11513.251638643504, 11521.423928803568, 11523.308601483895, 11545.307281563091, 10158.746031349201, 10975.725606859813, 11417.94291028548, 11481.712957176054, 11499.310041397459, 8286.751397458025, 8543.914560854375, 10944.17918656096, 11241.437928103562, 11279.492422840993, 35569.93290201272, 38561.03597410059, 40097.0, 40521.392179117334, 40676.98307542306, 3717.925641487182, 3921.8039098044983, 4041.2927737645796, 4052.128792309638, 4058.2289365020847, 29086.418271634662, 30332.84833575818, 30760.0, 30819.537706934414, 30845.537316940263, 3139.309351942569, 3263.4452143135486, 3277.6066871975518, 3332.3668502984597, 3341.7159541439005, 350014.0, 350550.0, 350907.0, 352730.0, 354726.0, 59563.0, 60070.69964650236, 60103.0, 60124.69937650284, 60186.39813601808, 62735.37264627386, 62827.057594136124, 62891.42771430751, 62911.685441572496, 63022.05466918, 15507.069575825486, 15937.920310398375, 15939.203039847962, 15944.0, 15985.920070399807, 11303.717407064889, 12441.440135193938, 12509.812352814715, 12513.186642868184, 12546.811797822857, 14058.648533786738, 14487.78268325976, 15623.921880390526, 15877.888547801544, 16014.119223442589, 6162.705831775377, 6196.938030619726, 6209.9068513972325, 6242.750289988349, 6275.466585340206, 870.433220203631, 873.9956300218458, 879.7580665316962, 895.1183084661603, 911.2209061252667, 29469.852650736608, 29609.851950740107, 29642.703572964427, 30330.54504182439, 30366.0, 1002.2583288366557, 1050.558765318568, 1078.2398409121552, 1091.956321747137, 1108.6806700027103, 15001.0, 15408.922955385375, 15425.305861236271, 15585.688286234212, 15803.8937274392, 554856.0, 556048.0, 557038.0, 557963.0, 562601.0, 59088.40911590829, 59096.70451647714, 59115.0, 59188.40811591829, 59464.40535594675, 1432.5415866922692, 1436.9353379097965, 1451.2090910453828, 1456.0753921260075, 1456.2791418248034, 24589.38526536851, 27555.17334479969, 27926.30184245329, 30041.849790750908, 30136.54795178118, 49785.53645880282, 50294.49705502898, 50398.74800625973, 50414.0, 50488.0, 438550.0, 514249.4287528538, 516847.0, 517439.0, 517707.0, 23300.0, 23723.40691482727, 23911.28266152018, 24530.386740331636, 38960.0, 35292.64707352893, 38894.80552597219, 40853.38719919263, 41710.1657966845, 42531.3620295702, 35086.0, 35199.64800352066, 35363.0, 36147.0, 36329.27341453209, 35162.824185878904, 35267.82366088153, 35876.103097422776, 36358.8182059088, 36530.634693652726, 34517.706150713406, 34802.9559113227, 35301.64698353086, 35501.46747798733, 35581.82209088938, 30342.393152137276, 31568.052958411285, 31647.0, 31665.683343166274, 32053.839730801195, 23610.88194559016, 23932.88033559821, 24234.515309693354, 24239.51520969606, 24303.51392972166], "value": 19279.476778614946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.14940831354386, 390.8671051842373, 390.972631915766, 397.12235958531653, 421.49210201706927, 14488.637784055403, 20498.282560110398, 21051.2632057878, 21932.013059412344, 22018.559628807434, 21416.9291535423, 21660.89169554154, 22004.8899755501, 22028.559428811415, 22238.88880555595, 5610.719464026803, 5933.792317268896, 5935.554833387513, 5938.9703051484685, 5947.345791962903, 4800.879978000543, 5386.218998245252, 5580.497755202031, 5866.6480011199255, 5875.206847075654, 5843.065109582468, 5847.532197424217, 5851.648901065928, 5853.8829223415505, 5859.44335288147, 5558.74928141169, 5606.523445507137, 5786.768529258846, 5835.0372188588835, 5847.590668653196, 4764.4520880098535, 5150.871228219287, 5154.716490593016, 5165.896682066375, 5195.584353251731, 26235.21294361172, 27123.186304410898, 27172.913083476837, 27189.320266993287, 27385.726142738517, 2752.353196998704, 2757.765589924859, 2774.5005898938184, 2779.6942336342986, 2786.8467234302107, 10548.0, 12536.623901282976, 14682.486112985995, 15076.773848392282, 16257.756133658004, 1828.232142500153, 1875.1749230338608, 1876.2776331112484, 1883.4349695091555, 1885.3495544037285, 139366.6063339364, 139464.0, 140241.0, 142330.2883485576, 143174.0, 9648.469334186688, 11859.407029648482, 11967.820482692767, 11986.940065299792, 12091.395430228453, 13855.674638086786, 14435.133891966305, 15724.528264152093, 15772.526824195063, 15789.0, 6505.41451269388, 6766.526343156031, 8180.427370084156, 8553.786155346043, 8694.739157825275, 8271.793205169799, 8273.83452330962, 8296.875546866802, 8422.83154336922, 8440.240378365976, 4730.479647238801, 4733.95266047342, 4734.313524538922, 4773.904521909542, 4890.779914903838, 1869.3454296849627, 1982.1278637399498, 2026.9189232430833, 2034.298167132337, 2034.52188735647, 861.8879545659024, 878.8637761147032, 879.4785021912128, 883.88067610873, 911.193593669594, 21450.0, 21857.344279671634, 22038.0, 22070.22754203595, 22085.558288834454, 895.9059298773665, 897.8967418746928, 914.0996118822954, 918.5407296351824, 919.6827094652334, 11031.503582338813, 11315.15136364776, 11334.546618135182, 11372.054457166136, 11582.0, 713282.0, 729365.0, 732457.0, 736046.0, 739470.302648494, 138093.6190638081, 141285.29357353147, 145858.0, 146489.0, 158925.0, 950.1496160935924, 988.8665030220828, 1012.1548506996593, 1012.8581998520214, 1014.0873214107362, 17957.37149199824, 18557.0, 18679.346222882134, 18946.147423365706, 18949.43151705451, 57457.0, 57978.55053623693, 59273.0, 59675.0, 60518.0, 84474.0, 84820.24567174853, 85960.71058934246, 86493.0, 86603.56698216469, 8262.917370826215, 8304.211099945496, 8560.14398560139, 8613.397062205586, 8629.180227878593, 11497.252678575866, 13092.672683182996, 13242.47030118823, 13682.247476388895, 13691.973102017588, 10829.133669306595, 11107.611233606785, 11403.315801051964, 11453.19827612059, 11801.70495737579, 5383.0579648562125, 9479.383840050376, 10205.84691229647, 10814.808152578447, 10954.890451095705, 11014.39420831862, 11230.831537527107, 11399.0, 11415.258008229439, 11416.372099534605, 8294.626741796514, 8308.87536686938, 8483.915160848559, 8702.56487175626, 8744.344174186834, 10700.946495267473, 10808.162612355762, 10903.781924361627, 10948.616798412017, 11369.886301136883], "value": 9895.716487063972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.659615307714, 1324.8873845723112, 1467.5964109869785, 1481.87404070654, 1488.3228131200312, 7934.365250779938, 8340.958295208524, 8354.206350396702, 8368.958155209215, 8374.37192210585, 7460.552366857993, 7608.201138880421, 7619.314261716444, 7672.539647621146, 7675.616219189033, 2215.5901158285687, 2306.423394151462, 2307.1694190091553, 2316.247219653619, 2320.9091726888337, 2299.5630830142304, 2322.512272422785, 2341.6838726771925, 2344.495933374324, 2349.3421841884215, 1614.8950318229336, 1880.2385034061226, 2295.391721193885, 2306.5848147333472, 2307.538492301538, 2032.0754056904073, 2052.7639321478073, 2201.7137772089686, 2210.071769856664, 2296.0815673730476, 2241.495663475705, 2296.1733775840685, 2306.273523840002, 2307.957457649975, 2310.4685922237977, 8291.461055031403, 8339.916600833974, 8359.8328033439, 8375.916240837636, 8382.245597896157, 4993.226049962262, 5169.121249387613, 5169.198774190007, 5169.741512924339, 5172.0, 3446.672566106216, 3457.481377793326, 3485.1635607454027, 3550.9112272193142, 3560.572731272238, 1214.7995580729169, 1222.6515443098674, 1235.7590269897373, 1262.211118051218, 1267.1130208853747, 10679.893201068046, 10718.464076796128, 10727.302725322907, 10730.087942524895, 10735.194860385423, 4286.185624731291, 4593.242115050979, 4649.628029757679, 4684.461286951976, 4697.577218050392, 9395.248380129573, 9403.670871519464, 9414.388064775767, 9423.858642120374, 9432.858507122399, 5088.109580823341, 5089.847304580869, 5097.796088156507, 5189.481051894781, 5191.2472691459525, 4533.084324955898, 4674.111918735497, 4705.788239529229, 4745.14587374269, 4785.306130611111, 3760.7179461540495, 3809.1429428378947, 3814.294355544233, 3859.826307816155, 3905.414187871842, 1259.2696236182992, 1259.3262604506544, 1261.6278197931633, 1275.8213850061, 1283.9101262911506, 810.9351251899834, 834.0, 847.093609837468, 880.8062226310202, 901.1709227510706, 5017.8243761468175, 5229.555487783505, 5354.705491197944, 5377.865553361197, 5502.394736578973, 562.1118632560544, 563.7181409295353, 573.7618888161367, 575.2148317546519, 577.6591810831545, 3199.77601567888, 3712.8514859405323, 3734.2531493701367, 3749.8125093745202, 3810.942835857464, 9514.429134251966, 9693.369930954465, 9906.950465247772, 9920.007999200023, 9923.801523969625, 9302.674406395743, 9850.950745246371, 9862.112409883002, 9867.259955503367, 9882.505874706236, 7337.596432196174, 7818.843623127619, 7823.843523129505, 7833.2558406952385, 7834.294913457702, 4700.882477938079, 5530.391656917655, 5650.124230744241, 5697.943020569741, 5757.96356655806, 8736.475811451333, 8965.551722413984, 9003.009668936542, 9015.098490150933, 9066.184043436122, 8565.785855353666, 9297.814043719223, 9371.812563748823, 9433.29250306216, 9450.102240287162, 6660.367265109807, 6860.0, 6863.416609588241, 7013.929860701328, 7270.818229544304, 7851.0, 7972.322352599862, 8075.717349892726, 8088.797780055545, 8096.0, 7062.611556364243, 7110.964445177741, 7128.0, 7156.284371562802, 7191.101112360955, 6982.546134501241, 7057.0, 7058.11773528309, 7109.502334836512, 7145.214026456982, 6242.53181011435, 6367.777127800505, 6369.585976911486, 6378.77674281398, 6395.616263024233, 4372.978135109304, 4834.7824347903725, 4930.827421040246, 4963.10664080469, 4964.627652925973, 4811.08589368019, 4834.63740219492, 4952.678075925053, 5013.598912086952, 5098.796048158032], "value": 4301.839906866347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.60152996514637, 346.80669190377336, 366.89543480108165, 372.5510759534761, 375.25324604037974, 5130.333056702632, 5290.180022096576, 5320.494553017466, 5324.680519168853, 5346.732663366831, 5280.815171468999, 5280.867978300535, 5299.761510732017, 5309.654872433289, 5317.813876514313, 3832.9076213279222, 3951.960480395188, 4102.692298077641, 4200.954308126599, 4244.957550424502, 3380.340833537461, 3792.715546334036, 4012.916512541612, 4110.938335924963, 4173.853915112972, 3536.257385948954, 3591.892243232707, 4113.773742444165, 4135.06960933789, 4139.503259608851, 3461.809600471973, 3901.4733011043713, 4029.234445455354, 4092.5498195198506, 4177.227212965611, 3595.46068089786, 3668.486411902336, 3673.246984368198, 3679.197193375254, 3703.3148867459336, 5188.974055129738, 5198.480151984809, 5225.764840582183, 5239.502247286502, 5273.472652734734, 4357.237483440417, 4796.928046079277, 4823.8422778532895, 4853.3690620219495, 4894.657373983822, 5599.440055994409, 5601.0, 5610.803621873215, 5639.646484843649, 5677.0, 3367.932641347184, 3459.077079867508, 3642.8542858285637, 3764.3788774852114, 3864.6908247340143, 5746.9425305747245, 5814.503873844689, 5869.530437564985, 5935.465808077251, 5970.313413957407, 3437.845296961643, 3869.400242962345, 3870.6129387061633, 3897.2595206910596, 3911.491506104245, 3406.267652454734, 3596.496490491333, 3905.453236546886, 3962.9009274767786, 3964.2467931093, 4296.4414626098405, 4374.912501749947, 4417.249067658441, 4517.503074661785, 4625.838095666702, 5057.620678449131, 5088.898222035613, 5476.890462190813, 5659.292588426447, 5682.6306290091015, 1087.9555626598396, 1272.1603741530546, 1286.5497076023505, 1286.8713128687057, 1289.7613941420868, 802.6789284286332, 829.4815740162398, 868.9956550217208, 877.5261358866269, 878.3939082033504, 4223.472065991751, 4771.117343291502, 5051.217061355495, 5151.124308867502, 5276.657017293864, 5243.632945693841, 5618.43815618443, 5621.297337832771, 5647.604667673306, 5758.704291534371, 3920.4315374270573, 4061.735987160825, 4757.0, 4794.267267657402, 4843.878903027382, 2375.853931188672, 2608.1612463213387, 2659.029454249185, 2823.3365159187574, 2883.9711602883704, 5132.79468821243, 5347.598930080259, 5536.972315138479, 5719.8570035749435, 5755.1871160585115, 4751.667383283137, 5348.358197016305, 5643.428822653664, 5648.802291919763, 5678.772849086073, 5264.5525130363585, 5486.506214440719, 5764.625299355528, 5997.430244126801, 6023.909641355295, 5263.157894736823, 5541.251930989265, 5675.971620141873, 5828.0, 5834.0, 5071.746412679425, 5523.254360661259, 5562.499375056264, 5742.483176514133, 5833.474987250998, 5951.464368206882, 5989.490893274121, 5995.88008239824, 6003.729832157651, 6004.249468816398, 3876.903077423087, 3911.647951684362, 3937.845572920596, 3940.960590394059, 3951.78265195417, 4426.203283409017, 4998.725070121032, 5307.946920530745, 5375.059364611099, 5471.003083874437, 5152.098382783073, 5252.632315738015, 5563.527100196528, 5647.181158731879, 5666.773329066791, 4966.627502937222, 5615.859603509945, 5658.292713410824, 5661.433856614306, 5776.595638305278, 4802.471728109975, 5283.920741188962, 5458.645188062763, 5519.944800551943, 5536.837264174407, 4633.351330813756, 4928.728919909439, 5314.734263286898, 5608.85977850557, 5626.634268772516, 5399.9190012149065, 5442.0, 5443.733759744122, 5458.6724796512335, 5520.282363292747], "value": 4072.667545388582, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4719231364943, 720.6360787802159, 771.5872008475463, 826.140813553904, 832.142892820395, 12585.433655485502, 14953.252337383141, 14968.625784355383, 14969.625759356022, 14991.550253492385, 14435.42258309669, 14537.273136343167, 14595.008023355187, 14608.780868286958, 14614.196219207939, 686.1423220973783, 868.3791089371114, 887.3699673232013, 892.1301730812471, 892.7054072156172, 700.3591713582066, 710.7441321124392, 846.7967687754956, 871.3856731004627, 887.4896934262824, 943.9993606776839, 947.5783276441986, 948.1750876737214, 949.2216382566298, 951.9904800951971, 939.5584075484511, 940.8071345374182, 940.8259471997702, 941.4257303045136, 942.6559305853383, 531.1236459841255, 546.97265136743, 679.7858674517511, 696.7839969609437, 702.581963731584, 15002.774958375632, 15242.314095865713, 15279.159646219454, 15299.082055076731, 15306.234688265653, 12292.692682682915, 13270.800937985938, 14014.22921739304, 14055.718885622231, 14084.647883802885, 10749.301295415773, 11674.1244406669, 12710.300933448656, 12775.0, 12931.0, 4385.057212699253, 4416.315471101984, 4445.622122119624, 4559.794809233559, 4583.854036490878, 106041.0, 109717.0, 109754.0, 109955.45022274918, 112946.0, 10983.835242471368, 11270.09839212861, 11307.321560706385, 11365.204435689422, 11558.735504114598, 22326.33021009372, 22793.658095128587, 22808.087676492756, 22845.657315140284, 22925.08299668028, 7591.962040189764, 7689.346405555479, 7779.7666070017995, 7860.3318717909615, 7932.246436588515, 3535.5934067582043, 4233.682473814476, 4265.3601959705675, 4288.574373612405, 4412.646988240933, 2785.832850028964, 3397.524346591479, 3495.178633021238, 3497.877574284888, 3498.038039539147, 587.9323877754113, 624.8533940219747, 631.0912286307703, 646.2309851276965, 657.2408867757747, 622.3869488553771, 645.2869579115104, 646.4763541531281, 650.0087366765625, 652.6377860287586, 8784.121587841293, 9332.0, 9378.390404623678, 9714.22286217101, 9922.0, 609.9725512351955, 639.5395315372924, 639.7696829141598, 643.1960049937578, 657.8223879552589, 4203.390508376268, 4554.567316104964, 4769.523047695203, 4781.952180478151, 4782.0, 98093.0, 101972.0, 102545.0, 102765.48617257015, 104297.0, 90829.0, 90980.5450972741, 93741.5312923431, 93931.99999999863, 95449.0, 79697.0, 83188.3362332762, 83571.0, 83658.58170709107, 84665.15334846573, 9065.184133428023, 9271.165595096474, 9271.907280927104, 9339.906600933904, 9382.765430864283, 53450.73274633602, 53615.73192134014, 54094.18858717201, 55173.82087442955, 55792.44207557872, 53065.0, 64047.39881502814, 64284.0, 64523.0, 71837.12651493882, 10672.946635266773, 12037.277763334228, 13402.195868247936, 13428.5685723709, 14005.299735013004, 14809.33357998871, 15017.624559385666, 15074.321655525308, 15664.216789160724, 15820.92089539591, 13527.391267393188, 13842.584722458343, 14280.428782848985, 14303.856961430252, 14669.70660586761, 12684.936575317064, 13236.338183091, 14348.641283967567, 14457.98794084404, 14583.635409114857, 11438.0, 12025.917667409974, 13462.932685336511, 13705.383257753225, 14466.132032077689, 10607.893921060691, 10933.398663073607, 10996.615118470816, 11326.716832079264, 11599.710007249887, 9204.677836275967, 10797.29817561856, 10842.674719758419, 11008.834867476835, 11033.117350612092], "value": 7522.139379089294, "unit": "score"}], "name": "dromaeo_css", "value": 7205.148973401855, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 115.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 107.0, 149.0, 109.0, 112.0, 110.0, 111.0, 130.0, 109.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 183.0, 186.0, 185.0, 182.0, 182.0, 181.0, 183.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 107.0, 86.0, 84.0, 58.0, 58.0, 74.0, 60.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 86.0, 70.0, 68.0, 70.0, 82.0, 69.0, 69.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 88.0, 89.0, 86.0, 88.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 87.0, 87.0, 85.0, 87.0, 85.0, 84.0, 87.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 56.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 71.0, 76.0, 73.0, 71.0, 72.0, 72.0, 71.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 85.0, 90.0, 87.0, 87.0, 91.0, 90.0, 87.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 139.0, 138.0, 139.0, 138.0, 141.0, 140.0, 177.0, 149.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 177.0, 173.0, 175.0, 175.0, 174.0, 174.0, 174.0, 174.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 66.0, 67.0, 69.0, 65.0, 66.0, 67.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1434.2999999999997, "alertThreshold": 2.0}]} 07:33:21 INFO - Return code: 0 07:33:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:33:21 ERROR - # TBPL SUCCESS # 07:33:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:21 INFO - 2017-01-24 07:33:21.475 screenresolution[1651:9709] starting screenresolution argv=screenresolution get 07:33:21 INFO - 2017-01-24 07:33:21.477 screenresolution[1651:9709] Display 0: 1600x1200x32@60 07:33:21 INFO - 2017-01-24 07:33:21.484 screenresolution[1652:9712] starting screenresolution argv=screenresolution list 07:33:21 INFO - Available Modes on Display 0 07:33:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:21 INFO - Intel Iris: 07:33:21 INFO - Chipset Model: Intel Iris 07:33:21 INFO - Type: GPU 07:33:21 INFO - Bus: Built-In 07:33:21 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:21 INFO - Vendor: Intel (0x8086) 07:33:21 INFO - Device ID: 0x0a2e 07:33:21 INFO - Revision ID: 0x0009 07:33:21 INFO - Displays: 07:33:21 INFO - Display: 07:33:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:21 INFO - Display Serial Number: 1600x1200 60 07:33:21 INFO - Main Display: Yes 07:33:21 INFO - Mirror: Off 07:33:21 INFO - Online: Yes 07:33:21 INFO - Rotation: Supported 07:33:21 INFO - Return code: 0 07:33:21 INFO - Running post-action listener: _resource_record_post_action 07:33:21 INFO - [mozharness: 2017-01-24 15:33:21.724746Z] Finished run-tests step (success) 07:33:21 INFO - Running post-run listener: _resource_record_post_run 07:33:21 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37688320; Write bytes: 553354240; Read time: 238; Write time: 1648 07:33:21 INFO - TinderboxPrint: CPU usage
53.6% 07:33:21 INFO - TinderboxPrint: I/O read bytes / time
37,688,320 / 238 07:33:21 INFO - TinderboxPrint: I/O write bytes / time
553,354,240 / 1,648 07:33:21 INFO - TinderboxPrint: CPU idle
2,227.8 (46.4%) 07:33:21 INFO - TinderboxPrint: CPU system
955.3 (19.9%) 07:33:21 INFO - TinderboxPrint: CPU user
1,622.5 (33.8%) 07:33:21 INFO - TinderboxPrint: Swap in / out
289,054,720 / 0 07:33:21 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247769600; Write bytes: 242604032; Read time: 18146; Write time: 503 07:33:21 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35599360; Write bytes: 297131008; Read time: 218; Write time: 1105 07:33:22 INFO - Running post-run listener: _upload_blobber_files 07:33:22 INFO - Blob upload gear active. 07:33:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:33:22 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 07:33:22 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'] 07:33:22 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 07:33:22 INFO - (blobuploader) - INFO - Open directory for files ... 07:33:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:33:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:24 INFO - (blobuploader) - INFO - Done attempting. 07:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:24 INFO - (blobuploader) - INFO - Done attempting. 07:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:33:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:25 INFO - (blobuploader) - INFO - Done attempting. 07:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:33:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:28 INFO - (blobuploader) - INFO - Done attempting. 07:33:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:33:28 INFO - Return code: 0 07:33:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:33:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:33:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c793fc8bb27e90dbb2d0cfa95dab6f85611c843f4479ce755e5fa6bffaa3f1cef924e64f17c844d52e31bf25e7157f83204a253cffe37eb578a2850adce907cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f441bea2608ad767557e048727644b5cc92afba5faef21f909ca3e9cc7dfb2b0105e4bd56a1dad2f66fa70d14f892357943254c8ecb0eb1ac940ac207b28bf79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70106139a4f73a9784c0ab26407f2dfd239a90b7e19d0feedf5137e8dd331637977c944ef9a6383c3d1269fb9ee8a3b3a42918af7afa15794bda24c9fc792b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dd92dc55bec98d852445bb9cdc180d8391a4530d373e914828275774265dcf7560a2d9530f0485d390ad56d3f0cff07ce07c01345cbfe70d04f569fd77b8896a"} 07:33:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:33:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:33:28 INFO - Contents: 07:33:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c793fc8bb27e90dbb2d0cfa95dab6f85611c843f4479ce755e5fa6bffaa3f1cef924e64f17c844d52e31bf25e7157f83204a253cffe37eb578a2850adce907cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f441bea2608ad767557e048727644b5cc92afba5faef21f909ca3e9cc7dfb2b0105e4bd56a1dad2f66fa70d14f892357943254c8ecb0eb1ac940ac207b28bf79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70106139a4f73a9784c0ab26407f2dfd239a90b7e19d0feedf5137e8dd331637977c944ef9a6383c3d1269fb9ee8a3b3a42918af7afa15794bda24c9fc792b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dd92dc55bec98d852445bb9cdc180d8391a4530d373e914828275774265dcf7560a2d9530f0485d390ad56d3f0cff07ce07c01345cbfe70d04f569fd77b8896a"} 07:33:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:33:28 INFO - Copying logs to upload dir... 07:33:28 INFO - mkdir: /builds/slave/test/build/upload/logs 07:33:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.084746 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-24 07:33:28.283959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 07:33:28.287774) ========= 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.wPx51bEFq7/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.BLeUz9gXSS/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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/c793fc8bb27e90dbb2d0cfa95dab6f85611c843f4479ce755e5fa6bffaa3f1cef924e64f17c844d52e31bf25e7157f83204a253cffe37eb578a2850adce907cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f441bea2608ad767557e048727644b5cc92afba5faef21f909ca3e9cc7dfb2b0105e4bd56a1dad2f66fa70d14f892357943254c8ecb0eb1ac940ac207b28bf79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70106139a4f73a9784c0ab26407f2dfd239a90b7e19d0feedf5137e8dd331637977c944ef9a6383c3d1269fb9ee8a3b3a42918af7afa15794bda24c9fc792b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dd92dc55bec98d852445bb9cdc180d8391a4530d373e914828275774265dcf7560a2d9530f0485d390ad56d3f0cff07ce07c01345cbfe70d04f569fd77b8896a"} build_url:https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/W0cmVVraSwuTOlEJwpbtmQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c793fc8bb27e90dbb2d0cfa95dab6f85611c843f4479ce755e5fa6bffaa3f1cef924e64f17c844d52e31bf25e7157f83204a253cffe37eb578a2850adce907cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f441bea2608ad767557e048727644b5cc92afba5faef21f909ca3e9cc7dfb2b0105e4bd56a1dad2f66fa70d14f892357943254c8ecb0eb1ac940ac207b28bf79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70106139a4f73a9784c0ab26407f2dfd239a90b7e19d0feedf5137e8dd331637977c944ef9a6383c3d1269fb9ee8a3b3a42918af7afa15794bda24c9fc792b9c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dd92dc55bec98d852445bb9cdc180d8391a4530d373e914828275774265dcf7560a2d9530f0485d390ad56d3f0cff07ce07c01345cbfe70d04f569fd77b8896a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 07:33:28.321856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:33:28.322192) ========= 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.wPx51bEFq7/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.BLeUz9gXSS/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.005180 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 07:33:28.371273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 07:33:28.371607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 07:33:28.371949) ========= ========= Total master_lag: 0.18 =========