builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0299 starttime: 1481384754.99 results: success (0) buildid: 20161210063617 builduid: cd2d573b9bab410380505a1063b3706b revision: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:54.987932) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:54.988398) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:54.988805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:55.014118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:55.014577) ========= 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.aHq1j3afIp/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.RmC8LijjHP/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-10 07:45:55-- 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% 9.82M=0.001s 2016-12-10 07:45:55 (9.82 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.484558 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:55.547539) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:55.547919) ========= 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.aHq1j3afIp/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.RmC8LijjHP/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.019714 ========= master_lag: 0.73 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:56.299008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:56.299420) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aHq1j3afIp/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.RmC8LijjHP/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-10 07:45:56,441 truncating revision to first 12 chars 2016-12-10 07:45:56,441 Setting DEBUG logging. 2016-12-10 07:45:56,441 attempt 1/10 2016-12-10 07:45:56,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97c0626d8789?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-10 07:45:57,086 unpacking tar archive at: mozilla-central-97c0626d8789/testing/mozharness/ program finished with exit code 0 elapsedTime=0.905471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:57.229347) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:57.229650) ========= script_repo_revision: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:57.230089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:57.230361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 07:45:57.264610) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-10 07:45:57.264965) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aHq1j3afIp/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.RmC8LijjHP/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:45:57 INFO - MultiFileLogger online at 20161210 07:45:57 in /builds/slave/test 07:45:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:45:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:45:57 INFO - {'append_to_log': False, 07:45:57 INFO - 'base_work_dir': '/builds/slave/test', 07:45:57 INFO - 'blob_upload_branch': 'Firefox', 07:45:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:45:57 INFO - 'branch': 'Firefox', 07:45:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:45:57 INFO - 'config_files': ('talos/mac_config.py',), 07:45:57 INFO - 'default_actions': ('clobber', 07:45:57 INFO - 'read-buildbot-config', 07:45:57 INFO - 'download-and-extract', 07:45:57 INFO - 'populate-webroot', 07:45:57 INFO - 'create-virtualenv', 07:45:57 INFO - 'install', 07:45:57 INFO - 'run-tests'), 07:45:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:45:57 INFO - 'download_minidump_stackwalk': True, 07:45:57 INFO - 'download_symbols': 'ondemand', 07:45:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:45:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:45:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:45:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:45:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:45:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:45:57 INFO - 'installer_path': 'installer.exe', 07:45:57 INFO - 'log_level': 'info', 07:45:57 INFO - 'log_name': 'talos', 07:45:57 INFO - 'log_to_console': True, 07:45:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:45:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:45:57 INFO - 'opt_config_files': (), 07:45:57 INFO - 'pip_index': False, 07:45:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:57 INFO - 'cmd': ('bash', 07:45:57 INFO - '-c', 07:45:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:57 INFO - 'enabled': True, 07:45:57 INFO - 'halt_on_failure': False, 07:45:57 INFO - 'name': 'check_screen_resolution'},), 07:45:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:57 INFO - 'cmd': ('bash', 07:45:57 INFO - '-c', 07:45:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:57 INFO - 'enabled': True, 07:45:57 INFO - 'halt_on_failure': False, 07:45:57 INFO - 'name': 'check_screen_resolution'},), 07:45:57 INFO - 'run_cmd_checks_enabled': True, 07:45:57 INFO - 'sps_profile': False, 07:45:57 INFO - 'sps_profile_interval': 0, 07:45:57 INFO - 'suite': 'dromaeojs', 07:45:57 INFO - 'system_bits': '32', 07:45:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:45:57 INFO - 'title': 't-yosemite-r7-0299', 07:45:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:45:57 INFO - 'use_talos_json': True, 07:45:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:45:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:45:57 INFO - 'work_dir': 'build'} 07:45:57 INFO - [mozharness: 2016-12-10 15:45:57.522569Z] Running clobber step. 07:45:57 INFO - Running pre-action listener: _resource_record_pre_action 07:45:57 INFO - Running main action method: clobber 07:45:57 INFO - rmtree: /builds/slave/test/build 07:45:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:45:59 INFO - Running post-action listener: _resource_record_post_action 07:45:59 INFO - [mozharness: 2016-12-10 15:45:59.035323Z] Finished clobber step (success) 07:45:59 INFO - [mozharness: 2016-12-10 15:45:59.035471Z] Running read-buildbot-config step. 07:45:59 INFO - Running pre-action listener: _resource_record_pre_action 07:45:59 INFO - Running main action method: read_buildbot_config 07:45:59 INFO - Using buildbot properties: 07:45:59 INFO - { 07:45:59 INFO - "project": "", 07:45:59 INFO - "product": "firefox", 07:45:59 INFO - "script_repo_revision": "production", 07:45:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:45:59 INFO - "repository": "", 07:45:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:45:59 INFO - "buildid": "20161210063617", 07:45:59 INFO - "pgo_build": "False", 07:45:59 INFO - "basedir": "/builds/slave/test", 07:45:59 INFO - "buildnumber": 34, 07:45:59 INFO - "slavename": "t-yosemite-r7-0299", 07:45:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:45:59 INFO - "platform": "yosemite_r7", 07:45:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:45:59 INFO - "branch": "mozilla-central", 07:45:59 INFO - "repo_path": "mozilla-central", 07:45:59 INFO - "revision": "97c0626d8789b7bcaaa04e4661bf36f58f3fb82b", 07:45:59 INFO - "stage_platform": "macosx64", 07:45:59 INFO - "builduid": "cd2d573b9bab410380505a1063b3706b", 07:45:59 INFO - "slavebuilddir": "test" 07:45:59 INFO - } 07:45:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 07:45:59 INFO - Running post-action listener: _resource_record_post_action 07:45:59 INFO - [mozharness: 2016-12-10 15:45:59.038717Z] Finished read-buildbot-config step (success) 07:45:59 INFO - [mozharness: 2016-12-10 15:45:59.038823Z] Running download-and-extract step. 07:45:59 INFO - Running pre-action listener: _resource_record_pre_action 07:45:59 INFO - Running main action method: download_and_extract 07:45:59 INFO - mkdir: /builds/slave/test/build/tests 07:45: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:45:59 INFO - trying https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 07:45:59 INFO - Downloading https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 07:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 07:46:00 INFO - Downloaded 1235 bytes. 07:46:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 07:46:00 INFO - Using the following test package requirements: 07:46:00 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 07:46:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 07:46:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 07:46:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'jsshell-mac64.zip'], 07:46:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 07:46:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 07:46:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 07:46:00 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 07:46:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 07:46:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 07:46:00 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 07:46:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 07:46:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 07:46:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 07:46:00 INFO - Fetch https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 07:46:02 INFO - Expected file size: 16287270 07:46:02 INFO - Obtained file size: 16287270 07:46:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 07:46:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 07:46:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 07:46:08 INFO - Fetch https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 07:46:09 INFO - Expected file size: 16287270 07:46:09 INFO - Obtained file size: 16287270 07:46:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 07:46:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 07:46:15 INFO - Fetch https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 07:46:17 INFO - Expected file size: 14409734 07:46:17 INFO - Obtained file size: 14409734 07:46:17 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:46:17 INFO - trying https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 07:46:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 07:46:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 07:46:20 INFO - Downloaded 69676839 bytes. 07:46:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 07:46:20 INFO - mkdir: /builds/slave/test/properties 07:46:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:20 INFO - Contents: 07:46:20 INFO - build_url:https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 07:46:21 INFO - Running post-action listener: _resource_record_post_action 07:46:21 INFO - Running post-action listener: set_extra_try_arguments 07:46:21 INFO - [mozharness: 2016-12-10 15:46:21.559550Z] Finished download-and-extract step (success) 07:46:21 INFO - [mozharness: 2016-12-10 15:46:21.559671Z] Running populate-webroot step. 07:46:21 INFO - Running pre-action listener: _resource_record_pre_action 07:46:21 INFO - Running main action method: populate_webroot 07:46:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:21 INFO - '--tppagecycles', 07:46:21 INFO - '7'], 07:46:21 INFO - 'tests': ['tsvgm']}}, 07:46:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:46:21 INFO - 'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:46:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:46:21 INFO - 'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['damp', 'tps']}, 07:46:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:46:21 INFO - 'tests': ['damp', 'tps']}, 07:46:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['dromaeo_dom']}, 07:46:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['basic_compositor_video']}, 07:46:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:46:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['a11yr', 07:46:21 INFO - 'ts_paint', 07:46:21 INFO - 'tpaint', 07:46:21 INFO - 'sessionrestore', 07:46:21 INFO - 'sessionrestore_no_auto_restore', 07:46:21 INFO - 'tabpaint']}, 07:46:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['tsvgx', 07:46:21 INFO - 'tsvgr_opacity', 07:46:21 INFO - 'tart', 07:46:21 INFO - 'tscrollx', 07:46:21 INFO - 'cart', 07:46:21 INFO - 'tsvg_static']}, 07:46:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:21 INFO - 'tsvgr_opacity', 07:46:21 INFO - 'tart', 07:46:21 INFO - 'tscrollx', 07:46:21 INFO - 'cart', 07:46:21 INFO - 'tsvg_static']}, 07:46:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:46:21 INFO - 'talos_options': ['--disable-e10s'], 07:46:21 INFO - 'tests': ['tp5o']}, 07:46:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:46:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:46:21 INFO - 'talos_options': ['--disable-e10s', 07:46:21 INFO - '--xperf_path', 07:46:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:21 INFO - 'tests': ['tp5n']}, 07:46:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:46:21 INFO - 'talos_options': ['--xperf_path', 07:46:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:21 INFO - 'tests': ['tp5n']}}, 07:46:21 INFO - 'talos.zip': {'path': '', 07:46:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:21 INFO - Running post-action listener: _resource_record_post_action 07:46:21 INFO - [mozharness: 2016-12-10 15:46:21.578416Z] Finished populate-webroot step (success) 07:46:21 INFO - [mozharness: 2016-12-10 15:46:21.578547Z] Running create-virtualenv step. 07:46:21 INFO - Running pre-action listener: _resource_record_pre_action 07:46:21 INFO - Running main action method: create_virtualenv 07:46:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:21 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:46:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:21 INFO - Using real prefix '/tools/python27' 07:46:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:25 INFO - Installing pip.................done. 07:46:25 INFO - Return code: 0 07:46:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:46:25 INFO - Reading from file tmpfile_stdout 07:46:25 INFO - Output received: 07:46:25 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:46:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:25 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:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:25 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:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:25 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:25 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:46:25 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:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:25 INFO - 'HOME': '/Users/cltbld', 07:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:25 INFO - 'LOGNAME': 'cltbld', 07:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:25 INFO - 'MOZ_NO_REMOTE': '1', 07:46:25 INFO - 'NO_EM_RESTART': '1', 07:46:25 INFO - 'PAGER': '/bin/cat', 07:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:25 INFO - 'PWD': '/builds/slave/test', 07:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:25 INFO - 'SHELL': '/bin/bash', 07:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:25 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:25 INFO - 'USER': 'cltbld', 07:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:25 INFO - 'XPC_FLAGS': '0x0', 07:46:25 INFO - 'XPC_SERVICE_NAME': '0', 07:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:25 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:46:25 INFO - Cleaning up... 07:46:25 INFO - Return code: 0 07:46:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:25 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:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:25 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:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:25 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:25 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:46:25 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:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:25 INFO - 'HOME': '/Users/cltbld', 07:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:25 INFO - 'LOGNAME': 'cltbld', 07:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:25 INFO - 'MOZ_NO_REMOTE': '1', 07:46:25 INFO - 'NO_EM_RESTART': '1', 07:46:25 INFO - 'PAGER': '/bin/cat', 07:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:25 INFO - 'PWD': '/builds/slave/test', 07:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:25 INFO - 'SHELL': '/bin/bash', 07:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:25 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:25 INFO - 'USER': 'cltbld', 07:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:25 INFO - 'XPC_FLAGS': '0x0', 07:46:25 INFO - 'XPC_SERVICE_NAME': '0', 07:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:26 INFO - Downloading/unpacking psutil>=3.1.1 07:46:26 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:46:26 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:46:26 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:46:26 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:46:26 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:46:26 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:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:29 INFO - Installing collected packages: psutil 07:46:29 INFO - Running setup.py install for psutil 07:46:30 INFO - building 'psutil._psutil_osx' extension 07:46:30 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:46:30 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:46:30 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:46:30 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:46:30 INFO - building 'psutil._psutil_posix' extension 07:46:30 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:46:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:46:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:46:30 INFO - ^ 07:46:30 INFO - 1 warning generated. 07:46:30 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:46:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:30 INFO - Successfully installed psutil 07:46:30 INFO - Cleaning up... 07:46:30 INFO - Return code: 0 07:46:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:30 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:30 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:46:30 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:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:30 INFO - 'HOME': '/Users/cltbld', 07:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:30 INFO - 'LOGNAME': 'cltbld', 07:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:30 INFO - 'MOZ_NO_REMOTE': '1', 07:46:30 INFO - 'NO_EM_RESTART': '1', 07:46:30 INFO - 'PAGER': '/bin/cat', 07:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:30 INFO - 'PWD': '/builds/slave/test', 07:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:30 INFO - 'SHELL': '/bin/bash', 07:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:30 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:30 INFO - 'USER': 'cltbld', 07:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:30 INFO - 'XPC_FLAGS': '0x0', 07:46:30 INFO - 'XPC_SERVICE_NAME': '0', 07:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:31 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:46:31 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:46:31 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:46:31 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:46:31 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:46:31 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:46:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:33 INFO - Installing collected packages: mozsystemmonitor 07:46:33 INFO - Running setup.py install for mozsystemmonitor 07:46:33 INFO - Successfully installed mozsystemmonitor 07:46:33 INFO - Cleaning up... 07:46:33 INFO - Return code: 0 07:46:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:33 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:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 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:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:33 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:46:33 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:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:33 INFO - 'HOME': '/Users/cltbld', 07:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:33 INFO - 'LOGNAME': 'cltbld', 07:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:33 INFO - 'MOZ_NO_REMOTE': '1', 07:46:33 INFO - 'NO_EM_RESTART': '1', 07:46:33 INFO - 'PAGER': '/bin/cat', 07:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:33 INFO - 'PWD': '/builds/slave/test', 07:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:33 INFO - 'SHELL': '/bin/bash', 07:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:33 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:33 INFO - 'USER': 'cltbld', 07:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:33 INFO - 'XPC_FLAGS': '0x0', 07:46:33 INFO - 'XPC_SERVICE_NAME': '0', 07:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:34 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:34 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:46:34 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:46:34 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:46:34 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:46:34 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:46:34 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:46:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:37 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:37 INFO - warning: no files found matching '*.txt' 07:46:37 INFO - no previously-included directories found matching 'build' 07:46:37 INFO - no previously-included directories found matching 'dist' 07:46:37 INFO - no previously-included directories found matching '.git*' 07:46:37 INFO - Installing collected packages: jsonschema, functools32 07:46:37 INFO - Running setup.py install for functools32 07:46:37 INFO - warning: no files found matching '*.txt' 07:46:37 INFO - no previously-included directories found matching 'build' 07:46:37 INFO - no previously-included directories found matching 'dist' 07:46:37 INFO - no previously-included directories found matching '.git*' 07:46:37 INFO - Successfully installed jsonschema functools32 07:46:37 INFO - Cleaning up... 07:46:37 INFO - Return code: 0 07:46:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:37 INFO - 'HOME': '/Users/cltbld', 07:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:37 INFO - 'LOGNAME': 'cltbld', 07:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:37 INFO - 'MOZ_NO_REMOTE': '1', 07:46:37 INFO - 'NO_EM_RESTART': '1', 07:46:37 INFO - 'PAGER': '/bin/cat', 07:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:37 INFO - 'PWD': '/builds/slave/test', 07:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:37 INFO - 'SHELL': '/bin/bash', 07:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:37 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:37 INFO - 'USER': 'cltbld', 07:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:37 INFO - 'XPC_FLAGS': '0x0', 07:46:37 INFO - 'XPC_SERVICE_NAME': '0', 07:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:46:37 INFO - Cleaning up... 07:46:37 INFO - Return code: 0 07:46:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:37 INFO - 'HOME': '/Users/cltbld', 07:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:37 INFO - 'LOGNAME': 'cltbld', 07:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:37 INFO - 'MOZ_NO_REMOTE': '1', 07:46:37 INFO - 'NO_EM_RESTART': '1', 07:46:37 INFO - 'PAGER': '/bin/cat', 07:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:37 INFO - 'PWD': '/builds/slave/test', 07:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:37 INFO - 'SHELL': '/bin/bash', 07:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:37 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:37 INFO - 'USER': 'cltbld', 07:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:37 INFO - 'XPC_FLAGS': '0x0', 07:46:37 INFO - 'XPC_SERVICE_NAME': '0', 07:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:40 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:46:40 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:46:40 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:46:40 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:46:40 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:46:40 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:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 INFO - Downloading docopt-0.6.1.tar.gz 07:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:42 INFO - Running setup.py install for blobuploader 07:46:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:42 INFO - Running setup.py install for requests 07:46:42 INFO - Running setup.py install for docopt 07:46:42 INFO - Successfully installed blobuploader requests docopt 07:46:42 INFO - Cleaning up... 07:46:42 INFO - Return code: 0 07:46:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46: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:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:42 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:42 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:46:42 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:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:42 INFO - 'HOME': '/Users/cltbld', 07:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:42 INFO - 'LOGNAME': 'cltbld', 07:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:42 INFO - 'MOZ_NO_REMOTE': '1', 07:46:42 INFO - 'NO_EM_RESTART': '1', 07:46:42 INFO - 'PAGER': '/bin/cat', 07:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:42 INFO - 'PWD': '/builds/slave/test', 07:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:42 INFO - 'SHELL': '/bin/bash', 07:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:42 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:42 INFO - 'USER': 'cltbld', 07:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:42 INFO - 'XPC_FLAGS': '0x0', 07:46:42 INFO - 'XPC_SERVICE_NAME': '0', 07:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-4sEnrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-VfiIG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-X8eqBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-GwM4B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-tonxNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Oin2_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-0CqFAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Bpvy3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-c0Hp6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-hJ8g0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-p8zlZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-sy2mKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-cIlgGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-tMgj7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-2kk0QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-jmqhXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-wy8W_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:44 INFO - Running setup.py install for manifestparser 07:46:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:45 INFO - Running setup.py install for mozcrash 07:46:45 INFO - Running setup.py install for mozdebug 07:46:45 INFO - Running setup.py install for mozdevice 07:46:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:46:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:45 INFO - Running setup.py install for mozfile 07:46:45 INFO - Running setup.py install for mozhttpd 07:46:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:45 INFO - Running setup.py install for mozinfo 07:46:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:45 INFO - Running setup.py install for mozInstall 07:46:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Running setup.py install for mozleak 07:46:46 INFO - Running setup.py install for mozlog 07:46:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Running setup.py install for moznetwork 07:46:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Running setup.py install for mozprocess 07:46:46 INFO - Running setup.py install for mozprofile 07:46:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:46 INFO - Running setup.py install for mozrunner 07:46:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:47 INFO - Running setup.py install for mozscreenshot 07:46:47 INFO - Running setup.py install for moztest 07:46:47 INFO - Running setup.py install for mozversion 07:46:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:47 INFO - Cleaning up... 07:46:47 INFO - Return code: 0 07:46:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:47 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:46:47 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:46:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:47 INFO - 'HOME': '/Users/cltbld', 07:46:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:47 INFO - 'LOGNAME': 'cltbld', 07:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:47 INFO - 'MOZ_NO_REMOTE': '1', 07:46:47 INFO - 'NO_EM_RESTART': '1', 07:46:47 INFO - 'PAGER': '/bin/cat', 07:46:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:47 INFO - 'PWD': '/builds/slave/test', 07:46:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:47 INFO - 'SHELL': '/bin/bash', 07:46:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:47 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:47 INFO - 'USER': 'cltbld', 07:46:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:47 INFO - 'XPC_FLAGS': '0x0', 07:46:47 INFO - 'XPC_SERVICE_NAME': '0', 07:46:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:47 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xPXzBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:47 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:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:47 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9Pdvj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:47 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:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:47 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-V5T1N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-pRiD5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-KjfUD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-w73AFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-6S5a0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-i96Zj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-f4KVXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Qhsow_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-XuTyUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:48 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:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-kqCBzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9xG2yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:49 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:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-7vrbIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:49 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:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-IBaLxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:49 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:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-U2zGyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-0S4Xrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:52 INFO - Downloading blessings-1.6.tar.gz 07:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:52 INFO - Installing collected packages: blessings 07:46:52 INFO - Running setup.py install for blessings 07:46:52 INFO - Successfully installed blessings 07:46:52 INFO - Cleaning up... 07:46:52 INFO - Return code: 0 07:46:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:52 INFO - Reading from file tmpfile_stdout 07:46:52 INFO - Current package versions: 07:46:52 INFO - blessings == 1.6 07:46:52 INFO - blobuploader == 1.2.4 07:46:52 INFO - docopt == 0.6.1 07:46:52 INFO - functools32 == 3.2.3-2 07:46:52 INFO - jsonschema == 2.5.1 07:46:52 INFO - manifestparser == 1.1 07:46:52 INFO - mozInstall == 1.12 07:46:52 INFO - mozcrash == 1.0 07:46:52 INFO - mozdebug == 0.1 07:46:52 INFO - mozdevice == 0.49 07:46:52 INFO - mozfile == 1.2 07:46:52 INFO - mozhttpd == 0.7 07:46:52 INFO - mozinfo == 0.9 07:46:52 INFO - mozleak == 0.1 07:46:52 INFO - mozlog == 3.4 07:46:52 INFO - moznetwork == 0.27 07:46:52 INFO - mozprocess == 0.23 07:46:52 INFO - mozprofile == 0.28 07:46:52 INFO - mozrunner == 6.13 07:46:52 INFO - mozscreenshot == 0.1 07:46:52 INFO - mozsystemmonitor == 0.3 07:46:52 INFO - moztest == 0.7 07:46:52 INFO - mozversion == 1.4 07:46:52 INFO - psutil == 3.1.1 07:46:52 INFO - requests == 1.2.3 07:46:52 INFO - wsgiref == 0.1.2 07:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:52 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:52 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:46:52 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:46:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:52 INFO - 'HOME': '/Users/cltbld', 07:46:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:52 INFO - 'LOGNAME': 'cltbld', 07:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:52 INFO - 'MOZ_NO_REMOTE': '1', 07:46:52 INFO - 'NO_EM_RESTART': '1', 07:46:52 INFO - 'PAGER': '/bin/cat', 07:46:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:52 INFO - 'PWD': '/builds/slave/test', 07:46:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:52 INFO - 'SHELL': '/bin/bash', 07:46:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:52 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:52 INFO - 'USER': 'cltbld', 07:46:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:52 INFO - 'XPC_FLAGS': '0x0', 07:46:52 INFO - 'XPC_SERVICE_NAME': '0', 07:46:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:53 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:46:53 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:46:53 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:46:53 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:46:53 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:46:53 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:46:53 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:46:53 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:46:53 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:46:53 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:46:53 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:46:53 INFO - Cleaning up... 07:46:53 INFO - Return code: 0 07:46:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:53 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 0x10fec33f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86da49d4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, '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.aHq1j3afIp/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.RmC8LijjHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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:46:53 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:46:53 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:46:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:46:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:53 INFO - 'HOME': '/Users/cltbld', 07:46:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:53 INFO - 'LOGNAME': 'cltbld', 07:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:53 INFO - 'MOZ_NO_REMOTE': '1', 07:46:53 INFO - 'NO_EM_RESTART': '1', 07:46:53 INFO - 'PAGER': '/bin/cat', 07:46:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:53 INFO - 'PWD': '/builds/slave/test', 07:46:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:53 INFO - 'SHELL': '/bin/bash', 07:46:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:46:53 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:46:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:53 INFO - 'USER': 'cltbld', 07:46:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:53 INFO - 'XPC_FLAGS': '0x0', 07:46:53 INFO - 'XPC_SERVICE_NAME': '0', 07:46:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:46:53 INFO - Cleaning up... 07:46:53 INFO - Return code: 0 07:46:53 INFO - Running post-action listener: _resource_record_post_action 07:46:53 INFO - Running post-action listener: _start_resource_monitoring 07:46:53 INFO - Starting resource monitoring. 07:46:53 INFO - [mozharness: 2016-12-10 15:46:53.365713Z] Finished create-virtualenv step (success) 07:46:53 INFO - [mozharness: 2016-12-10 15:46:53.366689Z] Running install step. 07:46:53 INFO - Running pre-action listener: _resource_record_pre_action 07:46:53 INFO - Running main action method: install 07:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:53 INFO - Reading from file tmpfile_stdout 07:46:53 INFO - Detecting whether we're running mozinstall >=1.0... 07:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:46:53 INFO - Reading from file tmpfile_stdout 07:46:53 INFO - Output received: 07:46:53 INFO - Usage: mozinstall [options] installer 07:46:53 INFO - Options: 07:46:53 INFO - -h, --help show this help message and exit 07:46:53 INFO - -d DEST, --destination=DEST 07:46:53 INFO - Directory to install application into. [default: 07:46:53 INFO - "/builds/slave/test"] 07:46:53 INFO - --app=APP Application being installed. [default: firefox] 07:46:53 INFO - mkdir: /builds/slave/test/build/application 07:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 07:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 07:47:15 INFO - Reading from file tmpfile_stdout 07:47:15 INFO - Output received: 07:47:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:47:15 INFO - Running post-action listener: _resource_record_post_action 07:47:15 INFO - [mozharness: 2016-12-10 15:47:15.421389Z] Finished install step (success) 07:47:15 INFO - [mozharness: 2016-12-10 15:47:15.421533Z] Running run-tests step. 07:47:15 INFO - Running pre-action listener: _resource_record_pre_action 07:47:15 INFO - Running main action method: run_tests 07:47:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:15 INFO - 2016-12-10 07:47:15.436 screenresolution[1918:13680] starting screenresolution argv=screenresolution get 07:47:15 INFO - 2016-12-10 07:47:15.438 screenresolution[1918:13680] Display 0: 1600x1200x32@60 07:47:15 INFO - 2016-12-10 07:47:15.444 screenresolution[1919:13682] starting screenresolution argv=screenresolution list 07:47:15 INFO - Available Modes on Display 0 07:47:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:15 INFO - Intel Iris: 07:47:15 INFO - Chipset Model: Intel Iris 07:47:15 INFO - Type: GPU 07:47:15 INFO - Bus: Built-In 07:47:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:15 INFO - Vendor: Intel (0x8086) 07:47:15 INFO - Device ID: 0x0a2e 07:47:15 INFO - Revision ID: 0x0009 07:47:15 INFO - Displays: 07:47:15 INFO - Display: 07:47:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:15 INFO - Display Serial Number: 1600x1200 60 07:47:15 INFO - Main Display: Yes 07:47:15 INFO - Mirror: Off 07:47:15 INFO - Online: Yes 07:47:15 INFO - Rotation: Supported 07:47:15 INFO - Return code: 0 07:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:15 INFO - Python 2.7.3 07:47:15 INFO - Return code: 0 07:47:15 INFO - grabbing minidump binary from tooltool 07:47:15 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:47:15 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 0x10fcd8d30>, '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 0x10fb3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:15 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:47:15 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:47:15 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:47:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:15 INFO - Return code: 0 07:47:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:47:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:47:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0299 --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:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aHq1j3afIp/Render', 07:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:15 INFO - 'HOME': '/Users/cltbld', 07:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:15 INFO - 'LOGNAME': 'cltbld', 07:47:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:15 INFO - 'MOZ_NO_REMOTE': '1', 07:47:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:15 INFO - 'NO_EM_RESTART': '1', 07:47:15 INFO - 'PAGER': '/bin/cat', 07:47:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:15 INFO - 'PWD': '/builds/slave/test', 07:47:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:15 INFO - 'SHELL': '/bin/bash', 07:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RmC8LijjHP/Listeners', 07:47:15 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:15 INFO - 'USER': 'cltbld', 07:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:15 INFO - 'XPC_FLAGS': '0x0', 07:47:15 INFO - 'XPC_SERVICE_NAME': '0', 07:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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:47:16 INFO - mozversion application_buildid: 20161210063617 07:47:16 INFO - mozversion application_changeset: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b 07:47:16 INFO - mozversion application_display_name: Nightly 07:47:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:16 INFO - mozversion application_name: Firefox 07:47:16 INFO - mozversion application_remotingname: firefox 07:47:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:47:16 INFO - mozversion application_vendor: Mozilla 07:47:16 INFO - mozversion application_version: 53.0a1 07:47:16 INFO - mozversion platform_buildid: 20161210063617 07:47:16 INFO - mozversion platform_changeset: 97c0626d8789b7bcaaa04e4661bf36f58f3fb82b 07:47:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:47:16 INFO - mozversion platform_version: 53.0a1 07:47:16 INFO - using testdate: 1481384836 07:47:16 INFO - actual date: 1481384836 07:47:16 INFO - starting webserver on 'localhost:51497' 07:47:16 INFO - SUITE-START | Running 2 tests 07:47:16 INFO - TEST-START | dromaeo_css 07:47:16 INFO - operating with platform_type : mac_ 07:47:16 INFO - Initialising browser for dromaeo_css test... 07:47:16 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpU2cr0f/profile http://localhost:51497/getInfo.html) 07:47:18 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 07:47:18 INFO - PROCESS | 1929 | colorDepth:24 07:47:18 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 07:47:18 INFO - PROCESS | 1929 | __metrics 07:47:18 INFO - PROCESS | 1929 | 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:47:18 INFO - PROCESS | 1929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:19 INFO - TEST-INFO | 1929: exit 0 07:47:19 INFO - Browser initialized. 07:47:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:19 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpU2cr0f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:31 INFO - PROCESS | 1931 | RSS: Main: 236728320 07:47:31 INFO - PROCESS | 1931 | 07:48:22 INFO - PROCESS | 1931 | 1481384902390 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:50:36 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51497/tests/dromaeo/cssquery-ext.html) 07:50:38 INFO - PROCESS | 1931 | RSS: Main: 365666304 07:50:38 INFO - PROCESS | 1931 | 07:53:41 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-ext.html (next: http://localhost:51497/tests/dromaeo/cssquery-jquery.html) 07:53:42 INFO - PROCESS | 1931 | RSS: Main: 372494336 07:53:42 INFO - PROCESS | 1931 | 07:56:44 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51497/tests/dromaeo/cssquery-mootools.html) 07:56:45 INFO - PROCESS | 1931 | RSS: Main: 365096960 07:56:45 INFO - PROCESS | 1931 | 07:59:47 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51497/tests/dromaeo/cssquery-prototype.html) 07:59:48 INFO - PROCESS | 1931 | RSS: Main: 334704640 07:59:48 INFO - PROCESS | 1931 | 08:02:52 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51497/tests/dromaeo/cssquery-yui.html) 08:02:52 INFO - PROCESS | 1931 | RSS: Main: 334241792 08:02:52 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51497/tests/dromaeo/cssquery-yui.html (next: http://localhost:51497/tests/dromaeo/cssquery-dojo.html) 08:05:56 INFO - PROCESS | 1931 | RSS: Main: 487673856 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | __start_tp_report 08:05:56 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 08:05:56 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 08:05:56 INFO - PROCESS | 1931 | |i|pagename|runs| 08:05:56 INFO - PROCESS | 1931 | |0;dojo.html;3124.9687503124965;3298.983505082474;3311.387393332233;3312.089175476745;3355.932881342373;5508.889822203553;5550.611457197998;5557.555395568355;5579.776808927638;5589.27339445872;5515.227868098469;5569.387367389584;5593.720313984295;5603.159526071091;5620.550355971523;5091.618128640348;5104.668196567211;5136.64043516954;5170;5213.218017297398;5181.844544663666;5228.424873263938;5234.7120908350025;5271.182966640177;5281.023010743005;5147.613928955325;5163.948360516384;5173.844784656448;5176.5341119299255;5205.297284866551;5177.45636708144;5222.791088356461;5231.006108839309;5234.7120908350025;5253.947460525423;4963.578095861856;4999.9500004999845;5018.447970723254;5130.84607461773;5157.071727089123;5432.994895944263;5511.366192887829;5542.057850165482;5549.056660367747;5560.471755183251;6017.909731354033;6018.759249630009;6018.8495287617725;6018.939810601882;6028.156058151862;6011.879762404771;6076.422739839708;6114.449699527019;6185.443310102068;6187.597806142587;5586.748596313176;5641.548676105902;5647.604667673223;5650.378458369576;5713.971430142906;6288.654124023131;6324.241091069009;6328.335524769925;6338;6345.111684364193;5907.49786268172;5938.940610593925;5941.7623295067715;5954.225950626391;6015.007523758618;5006.3992320921;6009.489193418521;6015.759369625166;6075.696215189223;6129.11127886454;6044.304904935901;6060.727267272983;6061.939160646869;6084.726187321581;6109.175261339662;6102.328743838174;6108.4807791338235;6111.144439778434;6111.960966635594;6118.1434599156155;4760.571548560646;4782.306565547976;4808.855734327975;4810.350602668665;4832.226843705061;4352.455943007124;4400.207962566705;4402.713823601455;4406.867793966187;4427;5615.831525054173;5616.382197958222;5638.379778224392;5650.802221922213;5670.631408958405;6129.938700613026;6163.1679723237685;6165.414285642857;6177.227846519185;6215.595986260969;5470.699111548903;5567.9420910026965;5571.721413929287;5645.435456454322;5645.661260324394;5295.205719142159;5300.681959082391;5302.416734159239;5309.495597918269;5310.840674779763;6297.244330680348;6312.715927783261;6318.399752023551;6321.399467050623;6328.398802113792;6112;6190.226221722285;6216.7824126155365;6219.689015549295;6222.62664240147;6363.3636636336;6378.649174295459;6396.616203027833;6397.840053998501;6398.0402939559435;5838.591298609056;5902.970485147547;6065.059915713072;6081.5742897996715;6085.69571521431;5877.35349111606;6065.878682426239;6084.574079814548;6134.834601026268;6143.38905964972;5915.2310199675485;5925.259342582177;5926.970365148147;5938.198343223782;5938.406159384027;5754.539636829128;5879.353271140086;5892.587518873809;5899.410058994066;5923;5689.914651280152;5707.258056452634;5719.056355701263;5750.367459579359;5835.94164058354;5910.290765108214;5913.379095194942;5913.822585322448;5935.584509084322;5938.703064846827;5761.884762304814;5763.193152958673;5778.191053252464;5796.130580412803;5861.677607731615 08:05:56 INFO - PROCESS | 1931 | |1;ext.html;402.30200601955585;443.41469260576054;455.1057172655731;456.63925498855906;468.115262154528;30025.699743002562;31936.411128052587;39874.003149921264;41478.585214147846;41726.7913660432;41937;42473.93815154623;42530.787346063225;42604.9348766281;42701;9273.258139348853;9492.81014379712;9516.238700903945;9521.047895210493;9544;8526.74419767408;8723.302135829119;9317.860232096524;11131.888681113207;11425.542978280859;11299.209055366127;11353.545858165664;11370.441650628625;11389.487473063731;11397.373144477091;11275.943620281887;11388.772224555545;11395.943020284845;11407.144464165222;11412.372319522423;8345.707900223524;8582.914170858274;8600.526971016592;8687.913120868774;8691.826163476759;39009.609903900884;39684.20631587381;39692.40461393081;41779;41787.373189402184;3407.4718418645148;3515.33208690348;3732.328180927432;3739.2334571412794;3973.145773658677;27225.45549089027;27634.944807747866;30330;30565;31351.84324078365;3149.0710240479116;3189.8086114833186;3211.5824942757527;3288.293017001356;3326.7172290355347;409620.9518952416;409792;410405;410457.9477102625;411555;56801;57087.714561426925;57089.85820283571;57117.85764284774;61769.69115154396;63240.68379658072;63247;63256.36743632597;63555;63643.681781591724;15617;15637.530874073796;15836.44572439982;16147.677046459004;16151.192440377934;11029.944850275857;12343.321117338633;12429.440675169639;12441.813372799415;12490.500379984698;14410.42358305656;15263.542093737206;15436.536903892902;17456.47630571085;17542.75459040056;6421.711023003976;6525.412712855866;6559.311272316433;6591.505637077238;6591.638264485147;851.5061264466594;894.8076163624852;985.3693636072919;1002.4085789384153;1008.9949550252202;28285.858570707016;29197.27006824804;29350.853245733633;30269.243268918453;30360.392792144034;997.6607953295915;1031.2677998620914;1071.7534966957644;1073;1186.489809381974;13460.932695336656;14713.55859324222;15216.619584510476;15233.542993710207;15608.083453712045;618795;622080;622082;623060;625139.7486025173;42081;52133.7393313031;52144.21783673248;52183.73908130435;52398.73800630972;1329.1427029565875;1363.372848489686;1383.515769480714;1388.125480946997;1388.167099740148;26842.865785670947;27546.86226568854;28062;28154.71845281521;28221.15336539907;41349;41413.792931036354;41537.96155096147;41548.58451415447;41585.37621935613;458285;460468;461283;462232.3776762189;552908;21709.78290217141;22411.43971400728;23814.761852381947;24302.756972430758;24360.26919192427;39630;40008;40720.79639601783;40787.59212407838;40912.59087409088;33951.4907276396;34196.82901585476;34231.82884085563;34722.826385867906;35893.641063590076;34143.82928085344;34416.48375274423;34883.30233395267;35337.64662353344;35479;33744.83127584346;34300.48549271813;34537.827310863286;34600;34605.82697086498;28653.713462865937;28797.56803647989;29945;30673.386532269677;30710.23224419318;20231;22636.434089147246;22981.88509057444;23564.410889727893;23719.16982905659 08:05:56 INFO - PROCESS | 1931 | |2;jquery.html;369.23752451188295;372.3353813443004;377.78843847445427;388.20418142807273;396.59151074393367;18611.534711632215;19853.900730496363;20310.695339569917;20679.896600517015;21040.158393664235;17177.82822171778;19952.30166944157;20358.389248322535;20379.082941267643;20735.06692198851;4958.281049247857;5549.889002219963;5853.063509838426;5876.529877609781;6523.119378883861;6482.384173503509;6490.123833282493;6542.116814230066;6547.901781473258;6576.506761992846;5609.439056094398;6205.131281620576;6502.447291980187;6551.901721474182;6567.277599464055;5599.832005039855;6457.418832305091;6505.121808555856;6512.283648798629;6535.0524173994745;5673.574481913873;5811.970940145315;5814.796482123148;5816.069428891399;5819;13034.674133146747;13245.536406225736;13255.536056237985;13341.266230357327;13447.856932160777;2200.460887082659;2208.4810069633622;2274.943126421836;2319.5476882008015;2846.9430611387656;9950;10302.536385862653;10581.418022008786;10683.314256581467;15723.13522756248;1680.3446655804246;1787.8659100567509;1792.8117547657569;1840.411068458094;1910.4173227165709;96667.51666241624;113063;121322.78677213291;121368;121718.78281217163;11306.477409036452;11440.370779607036;11477;11498.665387037832;11680.474378652982;14580.0522966009;14605.488807891672;14620.122792632475;14648.414063437343;14718.926405367905;8064.193580642006;8386.664533418594;8416.789580260542;8535.658573656985;8538.06081331053;8009.799755006172;8168.06067302256;8236.04371906097;8277.917220827836;8488.702895398632;4374.803133858984;4491.685582009228;4506.954930450654;4597.862064138081;4613.008203236321;1849.5561065344489;1900.429871038683;1905.1902941250191;1905.285517930776;1914.0716752375365;797.6330887791565;855.7518319687221;870.3559366069063;871.877937088808;923.5613083785282;16087.517374478784;20247.797522024885;20543.28098516545;20873.47816304574;20932.79067209339;816.4595077548934;877.9385443018928;887.3273878738624;910.39003867409;946.9157814302584;10463.633772817915;10971.780564388668;11060.889391106148;11086.889131108586;11099.72250693739;463461;468994;474752;474770;554442;97901.03523601436;97911.97340346407;131181.75272988973;131269;144961;950.4582388038751;986.8963758805365;990.0891180114312;1039.599754094664;1047.7275908263907;17982.733626586072;18532.166052527937;18970.810291896905;19225;19545.70681439808;36521.817390912875;43052.78473607612;49527;54292.45707542874;54535.09127180529;73882.63058684672;73896.63051684707;74467.62766186135;75392.62303688447;75890;7773.222677732181;7972;8090.433669643068;8212.589370531568;8237.176282371714;9714;12354.320512371547;12377.62867113952;12693.746125077632;12812.679683008;10651.57393704243;11003;11017.504212310625;11079.833802492807;11091;10824.67525974222;10835.458227088457;11039.227254092137;11152.498137583665;11186.552537898719;7617.238276172338;7624.428167887319;7912.723054693058;8088.474249173785;8307.626156822836;11282.7743445129;11494.712632184262;12561.37193140321;12613;12626.810597840857;11568.190226684052;11759.941200293944;11788.764224715285;11792.469338879599;11959.701007474883 08:05:56 INFO - PROCESS | 1931 | |3;mootools.html;1267.911246212765;1488.3079368093838;1599.8000249968754;1759.4457745810078;1812.5649844037434;7988.92011079889;8413.074561798197;8425.157484251571;8434.91565084349;8446.535440550768;7207.459440541954;7386.74146404876;7401.444891633136;7934.761957141295;8202.384821138408;2271.931842044737;2330.3940975346363;2332.644029530178;2332.9650055249185;2337.532493501298;2314.96527552086;2345.812335013203;2350.9647355289685;2353.188150088217;2369.0286982337243;1971.4085774267735;2308.2613563659634;2330.9300720978313;2336.8597884127007;2341.531693661266;2273.238465114189;2283.577538155438;2309.642005489152;2311.884405779713;2314.756950520188;2302.7121609798774;2314.849534780234;2326.8487548309304;2331.825113116523;2339.6841426407386;8042.316403105743;8179.386546009073;8217.219364160455;8301.501909885366;8328.7084952027;4997.825076122354;5156.896862062776;5159.484051594848;5163.7159956202395;5165.354330708661;3150;3235.902922912316;3412.283420481702;3414.641462646411;3429.159855835311;999.4053538144865;1043.3896170740127;1075.6289080267295;1079.3254216114929;1080.9675709728722;10727.731806704816;10905.454727263685;10911.127109831194;10921.617743378943;10940.56237750497;4468.932966005513;4493;4667.743274119888;4718.811247550128;4768.237082066853;8607.827843443096;8656.177663121993;8695.217430431292;8709.346798990102;8718.912810871938;5085.872853178626;5092.770825312869;5092.796288148506;5095.15929871567;5099.158638824552;4239.788010599457;4435.223835828781;4513.345564893138;4696.600788932979;4775.785089670973;3426.109211605001;3555.964440355615;3604.3151801157696;3667.8166091695307;3671.871484498083;1093.436880006797;1129.5030186717818;1134.8184290513477;1136.2273653915418;1145.3128123126223;800.7597720683888;860.9268212201907;881.7090360181124;929.7117893453051;934.6495064350869;5459.863503412367;5605.887882242332;5641.069223578063;5717.542596592262;5959;820.8440396324798;887.3699673231948;888.3248730964384;922.1786970732883;926.9629214831331;3618.1859081706407;3632.473291372789;3713.1088538751046;3721.813909304578;3805.3827123472415;9414.15272625467;9672.516374181263;9887.752806179904;10004.599816007423;10022.498875056364;9922.50387480623;9931.10620044185;9941.353812002197;9942.502874856229;9960.80078398428;7425.368843648351;7615.5430674159725;7723.884141737878;7819.882701759479;7848.175941526058;4668.323093151406;5551.278333816578;5764.020116580107;5855.03391940325;5875.471207591338;9183.908160918572;9211.309151813506;9246.630134794803;9258.305627077862;9419.105185007413;9183.448993060438;9390;9425.245980321695;9447;9520.428774273565;6555.410013098844;7019.403350715246;7169.964150179216;7187.928120718726;7188.137423509213;7019.543729657556;7469.887951680837;7667.769966901002;7771.650275737718;7908.960455197687;6193.566450348432;6720.924652055648;6840.247572767091;6958.269381714847;7098.396636285974;6754.662266886734;6774.085498457842;6787.457003439812;6828.556143850634;6837.521373504006;6479.902801457888;6511.283758786435;6583.473322134122;6620.337966203341;6624.8012559623285;4690.249560070372;4745.383100196952;4792.353032340589;4823.517648235148;4988.376452943382;4760.309755085424;4761.166795810788;4778.116048531033;4804.375431193923;4892.192788189909 08:05:56 INFO - PROCESS | 1931 | |4;prototype.html;346.4076429305887;350.6756250468316;357.8264541697277;367.2196582262692;371.49662207708553;4685;4910.508949105088;4984.750762461871;5079.187330027196;5253.79162792558;3966.0084978755312;4519.615832654228;4715.339852420664;5154.561862241714;5196.324477817888;3814.713896457763;4032.2741906456827;4087.0599762054744;4117.023828562292;4119.567445418233;3828.272628200647;4066.8169932353117;4077.97961010196;4100.528439229482;4122.319817230168;2808.4102338508937;3399.5721796845382;3942.664873485757;3990.421388898608;4052.305217030686;3514.5782506099176;3759.868404605853;3945.9210815783813;3961.2869683456966;3979.582143874895;3462.774919630216;3463.4631632097066;3467.959612116355;3472.791632502033;3487.459443786217;4451.840857184263;4628.120657075145;4854;5090.389153301628;5106.876487172816;3713.554373475173;4013.678905687538;4076.9592304077173;4223.176480586256;4312.611864932172;4603.792829322689;5038.39539255288;5446.019716451037;5464.453554644543;5519.371785323339;3254.528093426464;3759.6052414496357;3762.548494180716;3764.2283331917165;3775.4714339992424;5464.6994415307145;5519.475649813261;5701.885962280731;5728.28151554532;5761.654300741969;3373.5614370132216;3792.805266341149;3795.7342985991268;3804.923901521954;3809.466674665549;3115.2679120406688;3554.8400321985573;3635.163912300133;3847;3888.0862997195636;3999.440078389028;4295.463067116611;4426.8671939841215;4502.707324023928;4518.480374756879;4470.374147619336;5047.97476012625;5503.780288531254;5521.972390138024;5550.47270509301;1043.7286305560608;1129.193953026728;1152.6426807689643;1180.7166280092715;1246.507629486348;690.3441730356182;804.9195080491904;814.3241109878904;848.8132610825609;864.7924498120532;4391.363252328394;4840.2255639098275;4864.343313652612;4879.951200488021;4919.680220785637;4740.549647783455;4782.641301902371;5239.563602924658;5321.787128514893;5376.7739356385855;4573.3368661544555;4596.954030459719;4794.736289504111;4851.719691744875;4963.404391473046;2336.9649455258186;2795.95241187107;2816.690164081949;2823.0966090851143;2825.8445785481995;4929.87675308113;5537.732737684705;5538.086215774352;5579.218909352694;5585.1901474286005;4801.759912004386;5032.659813186886;5322.33470816148;5460.726963651801;5487.64330318536;4595.058013107305;4691.601213896789;4918.19662792205;5001.149574657327;5387.821185500574;4587.72473651582;5080.602834220471;5115.462876397924;5123;5306.416294207557;4534.820946553986;5648.881669373985;5662.008284159575;5689.601727879009;5757.61817163886;5155.917257375843;5471.370792358771;5880.411958804086;5961.374055724086;5979.222701048836;2973.3813899579945;3313.7904664797657;3390.4914262859784;3456.481527770754;3742.7835953315825;5413.133898576209;5582.9720851397105;5667.234923285304;5672.914906276326;5744.770209191585;4535.433070866142;5059.392872855281;5573.8507743125;5596.642014791093;5605.355384130877;4893.266010098514;5090.4655011223285;5248.553872920845;5527.866787308672;5617.859553511195;4721.7403042832975;4846.806127754991;5310.044192045469;5443.755031023693;5447.754851031634;4908;4943.7640589852535;5038.823641172541;5404.378876245097;5531.9723401382735;4924.433690125681;5008.772850651613;5416.783328666809;5434.239206511171;5441.993231252231 08:05:56 INFO - PROCESS | 1931 | |5;yui.html;710.6944014073948;730.404720153075;739.974100906468;785.0069661877726;822.7284995951337;16769.580760480978;17506.912465437672;17581.7362739559;17585.472435826912;17649.382271620496;15662.216889155554;16325.83674163258;16460.423885164022;16466.83533164668;16529.504114876574;688.7864761923795;853.355716434093;881.8104107616861;887.8002449448887;889.4129874282975;702.5679207287533;713.8679344321291;822.3256929317962;848.1815048478218;863.6372723456132;918.2837386838277;918.7703074231442;919.6413398774483;920.4753290624346;922.5525620074259;916.715818096389;917.4220241248038;917.495377542349;918.4948278446827;919.2737737187614;525.188583638276;543.2774410034644;656.3534918105662;677.1163631460942;679.3071067511111;14799.334029968677;14822.665960063647;15129.319180636898;15305.770413443808;15369.923150384288;13219.405126769318;13263.602091937257;13268.535601254007;13311.201327920357;13386;12511.311877846714;12682.36588170597;12832.871671283354;12980.675483112904;13136.60590182296;4409.5149533551285;4418.160549495586;4482.910341793146;4582.473015603215;4598.770061496912;105382.47308763408;106520.46739766252;107836;110733;113907.86092139056;10336.17310615149;10503.107235884883;10618.415987120628;10714.46427678613;10750.139988800876;20474.18103275882;20643.27748528794;20729.792702072788;20824.062917168765;20847.1661133556;7502.17476077631;7510.549367037996;7609.961950190213;7628.427867909929;7769.572673503011;4231.9576804231565;4296.312589985588;4313.266744653416;4417.580329868657;4444.2444784386735;3336.649651786576;3360.22714775603;3386.051905466424;3436.244026314207;3443.1564266754804;617.3240301869446;632.3265722006049;644.2912795924445;644.7775517446473;652.100101859431;509.1065180608009;586.4956137721556;589.8348462430527;609.7195290166574;622.8287221014257;8168.714095006646;8679.482949944571;8732.8690069649;8817.911820881838;8894.510801905828;497.8083437876371;568.2243737298558;568.5849329989048;589.5990726306153;601.1433706967641;3473.4616134499192;4020.19596080785;4194.077302993336;4224.746515209097;4328.462073764813;76711.61644191743;90107;96637;98586.50706746565;98741;83921.58039209765;84256;87971.56014219888;88048;88978.55510722405;77681;77961;77972;78285.60857195678;78413.60793195998;8308.169183081643;8337.416380853281;8354.987207174083;8406;8604.225619694007;45992;50051.499485004686;52390.738046309525;53591.196132057274;53607.46392536024;55672.32983010516;65198.67400662966;66576;68697.65651171713;69113.30886691068;12649.557265495663;12848.229106253655;13314.46742130304;13344.332783360987;13634.181949083088;14634.560963171121;14692.632684182981;14926.253687315373;15417.691646167239;15513.146776927377;13368.859019033733;13610.895096807388;13723.656908577366;13893.861061389256;14063.507777227747;13649.317534123453;13716.314184290546;13947.790783138058;13949.16305021702;14061.578152655436;12310.384480775747;12562.555306139911;13245.139065960682;13276.26980516081;13507.39216735269;10956.726081848017;11039.119015346805;11396.886031139582;11414.315141091562;11859.466324015268;10573.246497493587;10591.5233814477;11228.66314010581;11294.058911632552;11628.709282267673 08:05:56 INFO - PROCESS | 1931 | __end_tp_report 08:05:56 INFO - PROCESS | 1931 | __start_cc_report 08:05:56 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,1436 08:05:56 INFO - PROCESS | 1931 | __end_cc_report 08:05:56 INFO - PROCESS | 1931 | __startTimestamp1481385956550__endTimestamp 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | ------- Summary: start ------- 08:05:56 INFO - PROCESS | 1931 | Number of tests: 6 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | [#0] dojo.html Cycles:165 Average:5635.01 Median:5763.19 stddev:626.74 (10.9%) stddev-sans-first:596.93 08:05:56 INFO - PROCESS | 1931 | Values: 3125.0 3299.0 3311.4 3312.1 3355.9 5508.9 5550.6 5557.6 5579.8 5589.3 5515.2 5569.4 5593.7 5603.2 5620.6 5091.6 5104.7 5136.6 5170.0 5213.2 5181.8 5228.4 5234.7 5271.2 5281.0 5147.6 5163.9 5173.8 5176.5 5205.3 5177.5 5222.8 5231.0 5234.7 5253.9 4963.6 5000.0 5018.4 5130.8 5157.1 5433.0 5511.4 5542.1 5549.1 5560.5 6017.9 6018.8 6018.8 6018.9 6028.2 6011.9 6076.4 6114.4 6185.4 6187.6 5586.7 5641.5 5647.6 5650.4 5714.0 6288.7 6324.2 6328.3 6338.0 6345.1 5907.5 5938.9 5941.8 5954.2 6015.0 5006.4 6009.5 6015.8 6075.7 6129.1 6044.3 6060.7 6061.9 6084.7 6109.2 6102.3 6108.5 6111.1 6112.0 6118.1 4760.6 4782.3 4808.9 4810.4 4832.2 4352.5 4400.2 4402.7 4406.9 4427.0 5615.8 5616.4 5638.4 5650.8 5670.6 6129.9 6163.2 6165.4 6177.2 6215.6 5470.7 5567.9 5571.7 5645.4 5645.7 5295.2 5300.7 5302.4 5309.5 5310.8 6297.2 6312.7 6318.4 6321.4 6328.4 6112.0 6190.2 6216.8 6219.7 6222.6 6363.4 6378.6 6396.6 6397.8 6398.0 5838.6 5903.0 6065.1 6081.6 6085.7 5877.4 6065.9 6084.6 6134.8 6143.4 5915.2 5925.3 5927.0 5938.2 5938.4 5754.5 5879.4 5892.6 5899.4 5923.0 5689.9 5707.3 5719.1 5750.4 5835.9 5910.3 5913.4 5913.8 5935.6 5938.7 5761.9 5763.2 5778.2 5796.1 5861.7 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | [#1] ext.html Cycles:180 Average:63275.27 Median:34664.33 stddev:136793.08 (394.6%) stddev-sans-first:137095.37 08:05:56 INFO - PROCESS | 1931 | Values: 402.3 443.4 455.1 456.6 468.1 30025.7 31936.4 39874.0 41478.6 41726.8 41937.0 42473.9 42530.8 42604.9 42701.0 9273.3 9492.8 9516.2 9521.0 9544.0 8526.7 8723.3 9317.9 11131.9 11425.5 11299.2 11353.5 11370.4 11389.5 11397.4 11275.9 11388.8 11395.9 11407.1 11412.4 8345.7 8582.9 8600.5 8687.9 8691.8 39009.6 39684.2 39692.4 41779.0 41787.4 3407.5 3515.3 3732.3 3739.2 3973.1 27225.5 27634.9 30330.0 30565.0 31351.8 3149.1 3189.8 3211.6 3288.3 3326.7 409621.0 409792.0 410405.0 410457.9 411555.0 56801.0 57087.7 57089.9 57117.9 61769.7 63240.7 63247.0 63256.4 63555.0 63643.7 15617.0 15637.5 15836.4 16147.7 16151.2 11029.9 12343.3 12429.4 12441.8 12490.5 14410.4 15263.5 15436.5 17456.5 17542.8 6421.7 6525.4 6559.3 6591.5 6591.6 851.5 894.8 985.4 1002.4 1009.0 28285.9 29197.3 29350.9 30269.2 30360.4 997.7 1031.3 1071.8 1073.0 1186.5 13460.9 14713.6 15216.6 15233.5 15608.1 618795.0 622080.0 622082.0 623060.0 625139.7 42081.0 52133.7 52144.2 52183.7 52398.7 1329.1 1363.4 1383.5 1388.1 1388.2 26842.9 27546.9 28062.0 28154.7 28221.2 41349.0 41413.8 41538.0 41548.6 41585.4 458285.0 460468.0 461283.0 462232.4 552908.0 21709.8 22411.4 23814.8 24302.8 24360.3 39630.0 40008.0 40720.8 40787.6 40912.6 33951.5 34196.8 34231.8 34722.8 35893.6 34143.8 34416.5 34883.3 35337.6 35479.0 33744.8 34300.5 34537.8 34600.0 34605.8 28653.7 28797.6 29945.0 30673.4 30710.2 20231.0 22636.4 22981.9 23564.4 23719.2 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | [#2] jquery.html Cycles:180 Average:31112.92 Median:2583.25 stddev:82442.48 (3191.4%) stddev-sans-first:82641.44 08:05:56 INFO - PROCESS | 1931 | Values: 369.2 372.3 377.8 388.2 396.6 18611.5 19853.9 20310.7 20679.9 21040.2 17177.8 19952.3 20358.4 20379.1 20735.1 4958.3 5549.9 5853.1 5876.5 6523.1 6482.4 6490.1 6542.1 6547.9 6576.5 5609.4 6205.1 6502.4 6551.9 6567.3 5599.8 6457.4 6505.1 6512.3 6535.1 5673.6 5812.0 5814.8 5816.1 5819.0 13034.7 13245.5 13255.5 13341.3 13447.9 2200.5 2208.5 2274.9 2319.5 2846.9 9950.0 10302.5 10581.4 10683.3 15723.1 1680.3 1787.9 1792.8 1840.4 1910.4 96667.5 113063.0 121322.8 121368.0 121718.8 11306.5 11440.4 11477.0 11498.7 11680.5 14580.1 14605.5 14620.1 14648.4 14718.9 8064.2 8386.7 8416.8 8535.7 8538.1 8009.8 8168.1 8236.0 8277.9 8488.7 4374.8 4491.7 4507.0 4597.9 4613.0 1849.6 1900.4 1905.2 1905.3 1914.1 797.6 855.8 870.4 871.9 923.6 16087.5 20247.8 20543.3 20873.5 20932.8 816.5 877.9 887.3 910.4 946.9 10463.6 10971.8 11060.9 11086.9 11099.7 463461.0 468994.0 474752.0 474770.0 554442.0 97901.0 97912.0 131181.8 131269.0 144961.0 950.5 986.9 990.1 1039.6 1047.7 17982.7 18532.2 18970.8 19225.0 19545.7 36521.8 43052.8 49527.0 54292.5 54535.1 73882.6 73896.6 74467.6 75392.6 75890.0 7773.2 7972.0 8090.4 8212.6 8237.2 9714.0 12354.3 12377.6 12693.7 12812.7 10651.6 11003.0 11017.5 11079.8 11091.0 10824.7 10835.5 11039.2 11152.5 11186.6 7617.2 7624.4 7912.7 8088.5 8307.6 11282.8 11494.7 12561.4 12613.0 12626.8 11568.2 11759.9 11788.8 11792.5 11959.7 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | [#3] mootools.html Cycles:180 Average:5345.61 Median:5164.54 stddev:2917.52 (56.5%) stddev-sans-first:2909.60 08:05:56 INFO - PROCESS | 1931 | Values: 1267.9 1488.3 1599.8 1759.4 1812.6 7988.9 8413.1 8425.2 8434.9 8446.5 7207.5 7386.7 7401.4 7934.8 8202.4 2271.9 2330.4 2332.6 2333.0 2337.5 2315.0 2345.8 2351.0 2353.2 2369.0 1971.4 2308.3 2330.9 2336.9 2341.5 2273.2 2283.6 2309.6 2311.9 2314.8 2302.7 2314.8 2326.8 2331.8 2339.7 8042.3 8179.4 8217.2 8301.5 8328.7 4997.8 5156.9 5159.5 5163.7 5165.4 3150.0 3235.9 3412.3 3414.6 3429.2 999.4 1043.4 1075.6 1079.3 1081.0 10727.7 10905.5 10911.1 10921.6 10940.6 4468.9 4493.0 4667.7 4718.8 4768.2 8607.8 8656.2 8695.2 8709.3 8718.9 5085.9 5092.8 5092.8 5095.2 5099.2 4239.8 4435.2 4513.3 4696.6 4775.8 3426.1 3556.0 3604.3 3667.8 3671.9 1093.4 1129.5 1134.8 1136.2 1145.3 800.8 860.9 881.7 929.7 934.6 5459.9 5605.9 5641.1 5717.5 5959.0 820.8 887.4 888.3 922.2 927.0 3618.2 3632.5 3713.1 3721.8 3805.4 9414.2 9672.5 9887.8 10004.6 10022.5 9922.5 9931.1 9941.4 9942.5 9960.8 7425.4 7615.5 7723.9 7819.9 7848.2 4668.3 5551.3 5764.0 5855.0 5875.5 9183.9 9211.3 9246.6 9258.3 9419.1 9183.4 9390.0 9425.2 9447.0 9520.4 6555.4 7019.4 7170.0 7187.9 7188.1 7019.5 7469.9 7667.8 7771.7 7909.0 6193.6 6720.9 6840.2 6958.3 7098.4 6754.7 6774.1 6787.5 6828.6 6837.5 6479.9 6511.3 6583.5 6620.3 6624.8 4690.2 4745.4 4792.4 4823.5 4988.4 4760.3 4761.2 4778.1 4804.4 4892.2 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | [#4] prototype.html Cycles:180 Average:4320.50 Median:4820.99 stddev:1336.98 (27.7%) stddev-sans-first:1307.03 08:05:56 INFO - PROCESS | 1931 | Values: 346.4 350.7 357.8 367.2 371.5 4685.0 4910.5 4984.8 5079.2 5253.8 3966.0 4519.6 4715.3 5154.6 5196.3 3814.7 4032.3 4087.1 4117.0 4119.6 3828.3 4066.8 4078.0 4100.5 4122.3 2808.4 3399.6 3942.7 3990.4 4052.3 3514.6 3759.9 3945.9 3961.3 3979.6 3462.8 3463.5 3468.0 3472.8 3487.5 4451.8 4628.1 4854.0 5090.4 5106.9 3713.6 4013.7 4077.0 4223.2 4312.6 4603.8 5038.4 5446.0 5464.5 5519.4 3254.5 3759.6 3762.5 3764.2 3775.5 5464.7 5519.5 5701.9 5728.3 5761.7 3373.6 3792.8 3795.7 3804.9 3809.5 3115.3 3554.8 3635.2 3847.0 3888.1 3999.4 4295.5 4426.9 4502.7 4518.5 4470.4 5048.0 5503.8 5522.0 5550.5 1043.7 1129.2 1152.6 1180.7 1246.5 690.3 804.9 814.3 848.8 864.8 4391.4 4840.2 4864.3 4880.0 4919.7 4740.5 4782.6 5239.6 5321.8 5376.8 4573.3 4597.0 4794.7 4851.7 4963.4 2337.0 2796.0 2816.7 2823.1 2825.8 4929.9 5537.7 5538.1 5579.2 5585.2 4801.8 5032.7 5322.3 5460.7 5487.6 4595.1 4691.6 4918.2 5001.1 5387.8 4587.7 5080.6 5115.5 5123.0 5306.4 4534.8 5648.9 5662.0 5689.6 5757.6 5155.9 5471.4 5880.4 5961.4 5979.2 2973.4 3313.8 3390.5 3456.5 3742.8 5413.1 5583.0 5667.2 5672.9 5744.8 4535.4 5059.4 5573.9 5596.6 5605.4 4893.3 5090.5 5248.6 5527.9 5617.9 4721.7 4846.8 5310.0 5443.8 5447.8 4908.0 4943.8 5038.8 5404.4 5532.0 4924.4 5008.8 5416.8 5434.2 5442.0 08:05:56 INFO - PROCESS | 1931 | 08:05:56 INFO - PROCESS | 1931 | [#5] yui.html Cycles:180 Average:20190.30 Median:4431.20 stddev:28650.63 (646.6%) stddev-sans-first:28693.67 08:05:56 INFO - PROCESS | 1931 | Values: 710.7 730.4 740.0 785.0 822.7 16769.6 17506.9 17581.7 17585.5 17649.4 15662.2 16325.8 16460.4 16466.8 16529.5 688.8 853.4 881.8 887.8 889.4 702.6 713.9 822.3 848.2 863.6 918.3 918.8 919.6 920.5 922.6 916.7 917.4 917.5 918.5 919.3 525.2 543.3 656.4 677.1 679.3 14799.3 14822.7 15129.3 15305.8 15369.9 13219.4 13263.6 13268.5 13311.2 13386.0 12511.3 12682.4 12832.9 12980.7 13136.6 4409.5 4418.2 4482.9 4582.5 4598.8 105382.5 106520.5 107836.0 110733.0 113907.9 10336.2 10503.1 10618.4 10714.5 10750.1 20474.2 20643.3 20729.8 20824.1 20847.2 7502.2 7510.5 7610.0 7628.4 7769.6 4232.0 4296.3 4313.3 4417.6 4444.2 3336.6 3360.2 3386.1 3436.2 3443.2 617.3 632.3 644.3 644.8 652.1 509.1 586.5 589.8 609.7 622.8 8168.7 8679.5 8732.9 8817.9 8894.5 497.8 568.2 568.6 589.6 601.1 3473.5 4020.2 4194.1 4224.7 4328.5 76711.6 90107.0 96637.0 98586.5 98741.0 83921.6 84256.0 87971.6 88048.0 88978.6 77681.0 77961.0 77972.0 78285.6 78413.6 8308.2 8337.4 8355.0 8406.0 8604.2 45992.0 50051.5 52390.7 53591.2 53607.5 55672.3 65198.7 66576.0 68697.7 69113.3 12649.6 12848.2 13314.5 13344.3 13634.2 14634.6 14692.6 14926.3 15417.7 15513.1 13368.9 13610.9 13723.7 13893.9 14063.5 13649.3 13716.3 13947.8 13949.2 14061.6 12310.4 12562.6 13245.1 13276.3 13507.4 10956.7 11039.1 11396.9 11414.3 11859.5 10573.2 10591.5 11228.7 11294.1 11628.7 08:05:56 INFO - PROCESS | 1931 | -------- Summary: end -------- 08:05:56 INFO - PROCESS | 1931 | 08:05:57 INFO - TEST-INFO | 1931: exit 0 08:05:57 INFO - TEST-OK | dromaeo_css | took 1121163ms 08:05:57 INFO - TEST-START | kraken 08:05:57 INFO - operating with platform_type : mac_ 08:05:57 INFO - Initialising browser for kraken test... 08:05:57 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpWRtBhN/profile http://localhost:51497/getInfo.html) 08:05:59 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 08:05:59 INFO - PROCESS | 1936 | colorDepth:24 08:05:59 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 08:05:59 INFO - PROCESS | 1936 | __metrics 08:05:59 INFO - PROCESS | 1936 | 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" 08:05:59 INFO - PROCESS | 1936 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:00 INFO - TEST-INFO | 1936: exit 0 08:06:00 INFO - Browser initialized. 08:06:00 INFO - Running cycle 1/1 for kraken test... 08:06:00 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpWRtBhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:12 INFO - PROCESS | 1937 | RSS: Main: 238329856 08:06:12 INFO - PROCESS | 1937 | 08:06:15 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:16 INFO - PROCESS | 1937 | RSS: Main: 289144832 08:06:16 INFO - PROCESS | 1937 | 08:06:18 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-dft) 08:06:19 INFO - PROCESS | 1937 | RSS: Main: 290177024 08:06:19 INFO - PROCESS | 1937 | 08:06:22 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-fft) 08:06:23 INFO - PROCESS | 1937 | RSS: Main: 384065536 08:06:23 INFO - PROCESS | 1937 | 08:06:25 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51497/tests/kraken/driver.html?testName=audio-oscillator) 08:06:25 INFO - PROCESS | 1937 | RSS: Main: 286883840 08:06:25 INFO - PROCESS | 1937 | 08:06:27 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:28 INFO - PROCESS | 1937 | RSS: Main: 289329152 08:06:28 INFO - PROCESS | 1937 | 08:06:31 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51497/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:32 INFO - PROCESS | 1937 | RSS: Main: 331382784 08:06:32 INFO - PROCESS | 1937 | 08:06:35 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51497/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:35 INFO - PROCESS | 1937 | RSS: Main: 332140544 08:06:35 INFO - PROCESS | 1937 | 08:06:38 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51497/tests/kraken/driver.html?testName=json-parse-financial) 08:06:39 INFO - PROCESS | 1937 | RSS: Main: 330661888 08:06:39 INFO - PROCESS | 1937 | 08:06:41 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:41 INFO - PROCESS | 1937 | RSS: Main: 305508352 08:06:41 INFO - PROCESS | 1937 | 08:06:43 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:44 INFO - PROCESS | 1937 | RSS: Main: 308494336 08:06:44 INFO - PROCESS | 1937 | 08:06:46 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:47 INFO - PROCESS | 1937 | RSS: Main: 315740160 08:06:47 INFO - PROCESS | 1937 | 08:06:50 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:51 INFO - PROCESS | 1937 | RSS: Main: 320122880 08:06:51 INFO - PROCESS | 1937 | 08:06:54 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:54 INFO - PROCESS | 1937 | RSS: Main: 320970752 08:06:54 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51497/tests/kraken/driver.html?testName=ai-astar) 08:06:56 INFO - PROCESS | 1937 | RSS: Main: 365191168 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | __start_tp_report 08:06:56 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 08:06:56 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 08:06:56 INFO - PROCESS | 1937 | |i|pagename|runs| 08:06:56 INFO - PROCESS | 1937 | |0;ai-astar;113;112;113;113;112;114;113;113;113;113 08:06:56 INFO - PROCESS | 1937 | |1;audio-beat-detection;151;114;109;149;116;116;117;98;152;143 08:06:56 INFO - PROCESS | 1937 | |2;audio-dft;183;185;184;188;184;181;183;182;184;181 08:06:56 INFO - PROCESS | 1937 | |3;audio-fft;80;57;61;88;62;60;60;60;92;82 08:06:56 INFO - PROCESS | 1937 | |4;audio-oscillator;92;69;87;70;69;68;84;70;69;83 08:06:56 INFO - PROCESS | 1937 | |5;imaging-gaussian-blur;111;112;111;114;110;96;153;114;110;129 08:06:56 INFO - PROCESS | 1937 | |6;imaging-darkroom;93;96;94;94;93;94;94;118;144;93 08:06:56 INFO - PROCESS | 1937 | |7;imaging-desaturate;86;87;84;89;69;128;131;85;87;86 08:06:56 INFO - PROCESS | 1937 | |8;json-parse-financial;57;55;54;53;55;55;56;55;54;54 08:06:56 INFO - PROCESS | 1937 | |9;json-stringify-tinderbox;65;96;99;109;86;69;70;69;71;71 08:06:56 INFO - PROCESS | 1937 | |10;stanford-crypto-aes;93;92;92;91;92;92;93;92;127;93 08:06:56 INFO - PROCESS | 1937 | |11;stanford-crypto-ccm;156;152;141;148;150;146;151;155;187;141 08:06:56 INFO - PROCESS | 1937 | |12;stanford-crypto-pbkdf2;190;234;178;178;180;182;180;178;174;177 08:06:56 INFO - PROCESS | 1937 | |13;stanford-crypto-sha256-iterative;68;69;69;69;72;80;86;83;79;67 08:06:56 INFO - PROCESS | 1937 | __end_tp_report 08:06:56 INFO - PROCESS | 1937 | __start_cc_report 08:06:56 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,2018 08:06:56 INFO - PROCESS | 1937 | __end_cc_report 08:06:56 INFO - PROCESS | 1937 | __startTimestamp1481386016850__endTimestamp 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | ------- Summary: start ------- 08:06:56 INFO - PROCESS | 1937 | Number of tests: 14 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:06:56 INFO - PROCESS | 1937 | Values: 113.0 112.0 113.0 113.0 112.0 114.0 113.0 113.0 113.0 113.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#1] audio-beat-detection Cycles:10 Average:126.50 Median:146.00 stddev:20.04 (13.7%) stddev-sans-first:19.19 08:06:56 INFO - PROCESS | 1937 | Values: 151.0 114.0 109.0 149.0 116.0 116.0 117.0 98.0 152.0 143.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:2.07 (1.1%) stddev-sans-first:2.19 08:06:56 INFO - PROCESS | 1937 | Values: 183.0 185.0 184.0 188.0 184.0 181.0 183.0 182.0 184.0 181.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#3] audio-fft Cycles:10 Average:70.20 Median:71.00 stddev:13.60 (19.2%) stddev-sans-first:13.96 08:06:56 INFO - PROCESS | 1937 | Values: 80.0 57.0 61.0 88.0 62.0 60.0 60.0 60.0 92.0 82.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:76.50 stddev:9.27 (12.1%) stddev-sans-first:7.84 08:06:56 INFO - PROCESS | 1937 | Values: 92.0 69.0 87.0 70.0 69.0 68.0 84.0 70.0 69.0 83.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:114.00 stddev:15.22 (13.3%) stddev-sans-first:16.03 08:06:56 INFO - PROCESS | 1937 | Values: 111.0 112.0 111.0 114.0 110.0 96.0 153.0 114.0 110.0 129.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.00 stddev:16.83 (17.9%) stddev-sans-first:17.58 08:06:56 INFO - PROCESS | 1937 | Values: 93.0 96.0 94.0 94.0 93.0 94.0 94.0 118.0 144.0 93.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:86.00 stddev:19.93 (23.2%) stddev-sans-first:20.97 08:06:56 INFO - PROCESS | 1937 | Values: 86.0 87.0 84.0 89.0 69.0 128.0 131.0 85.0 87.0 86.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:0.88 08:06:56 INFO - PROCESS | 1937 | Values: 57.0 55.0 54.0 53.0 55.0 55.0 56.0 55.0 54.0 54.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#9] json-stringify-tinderbox Cycles:10 Average:80.50 Median:71.00 stddev:15.71 (22.1%) stddev-sans-first:15.63 08:06:56 INFO - PROCESS | 1937 | Values: 65.0 96.0 99.0 109.0 86.0 69.0 70.0 69.0 71.0 71.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#10] stanford-crypto-aes Cycles:10 Average:95.70 Median:92.00 stddev:11.02 (12.0%) stddev-sans-first:11.64 08:06:56 INFO - PROCESS | 1937 | Values: 93.0 92.0 92.0 91.0 92.0 92.0 93.0 92.0 127.0 93.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:151.50 stddev:13.10 (8.6%) stddev-sans-first:13.84 08:06:56 INFO - PROCESS | 1937 | Values: 156.0 152.0 141.0 148.0 150.0 146.0 151.0 155.0 187.0 141.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:180.00 stddev:17.69 (9.8%) stddev-sans-first:18.68 08:06:56 INFO - PROCESS | 1937 | Values: 190.0 234.0 178.0 178.0 180.0 182.0 180.0 178.0 174.0 177.0 08:06:56 INFO - PROCESS | 1937 | 08:06:56 INFO - PROCESS | 1937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:75.50 stddev:7.07 (9.4%) stddev-sans-first:7.13 08:06:56 INFO - PROCESS | 1937 | Values: 68.0 69.0 69.0 69.0 72.0 80.0 86.0 83.0 79.0 67.0 08:06:56 INFO - PROCESS | 1937 | -------- Summary: end -------- 08:06:56 INFO - PROCESS | 1937 | 08:06:57 INFO - TEST-INFO | 1937: exit 0 08:06:57 INFO - TEST-OK | kraken | took 60741ms 08:06:57 INFO - SUITE-END | took 1181s 08:06:58 INFO - Completed test suite (00:19:41) 08:06:58 INFO - javascript benchmark 08:06:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.9687503124965, 3298.983505082474, 3311.387393332233, 3312.089175476745, 3355.932881342373, 5508.889822203553, 5550.611457197998, 5557.555395568355, 5579.776808927638, 5589.27339445872, 5515.227868098469, 5569.387367389584, 5593.720313984295, 5603.159526071091, 5620.550355971523, 5091.618128640348, 5104.668196567211, 5136.64043516954, 5170.0, 5213.218017297398, 5181.844544663666, 5228.424873263938, 5234.7120908350025, 5271.182966640177, 5281.023010743005, 5147.613928955325, 5163.948360516384, 5173.844784656448, 5176.5341119299255, 5205.297284866551, 5177.45636708144, 5222.791088356461, 5231.006108839309, 5234.7120908350025, 5253.947460525423, 4963.578095861856, 4999.9500004999845, 5018.447970723254, 5130.84607461773, 5157.071727089123, 5432.994895944263, 5511.366192887829, 5542.057850165482, 5549.056660367747, 5560.471755183251, 6017.909731354033, 6018.759249630009, 6018.8495287617725, 6018.939810601882, 6028.156058151862, 6011.879762404771, 6076.422739839708, 6114.449699527019, 6185.443310102068, 6187.597806142587, 5586.748596313176, 5641.548676105902, 5647.604667673223, 5650.378458369576, 5713.971430142906, 6288.654124023131, 6324.241091069009, 6328.335524769925, 6338.0, 6345.111684364193, 5907.49786268172, 5938.940610593925, 5941.7623295067715, 5954.225950626391, 6015.007523758618, 5006.3992320921, 6009.489193418521, 6015.759369625166, 6075.696215189223, 6129.11127886454, 6044.304904935901, 6060.727267272983, 6061.939160646869, 6084.726187321581, 6109.175261339662, 6102.328743838174, 6108.4807791338235, 6111.144439778434, 6111.960966635594, 6118.1434599156155, 4760.571548560646, 4782.306565547976, 4808.855734327975, 4810.350602668665, 4832.226843705061, 4352.455943007124, 4400.207962566705, 4402.713823601455, 4406.867793966187, 4427.0, 5615.831525054173, 5616.382197958222, 5638.379778224392, 5650.802221922213, 5670.631408958405, 6129.938700613026, 6163.1679723237685, 6165.414285642857, 6177.227846519185, 6215.595986260969, 5470.699111548903, 5567.9420910026965, 5571.721413929287, 5645.435456454322, 5645.661260324394, 5295.205719142159, 5300.681959082391, 5302.416734159239, 5309.495597918269, 5310.840674779763, 6297.244330680348, 6312.715927783261, 6318.399752023551, 6321.399467050623, 6328.398802113792, 6112.0, 6190.226221722285, 6216.7824126155365, 6219.689015549295, 6222.62664240147, 6363.3636636336, 6378.649174295459, 6396.616203027833, 6397.840053998501, 6398.0402939559435, 5838.591298609056, 5902.970485147547, 6065.059915713072, 6081.5742897996715, 6085.69571521431, 5877.35349111606, 6065.878682426239, 6084.574079814548, 6134.834601026268, 6143.38905964972, 5915.2310199675485, 5925.259342582177, 5926.970365148147, 5938.198343223782, 5938.406159384027, 5754.539636829128, 5879.353271140086, 5892.587518873809, 5899.410058994066, 5923.0, 5689.914651280152, 5707.258056452634, 5719.056355701263, 5750.367459579359, 5835.94164058354, 5910.290765108214, 5913.379095194942, 5913.822585322448, 5935.584509084322, 5938.703064846827, 5761.884762304814, 5763.193152958673, 5778.191053252464, 5796.130580412803, 5861.677607731615], "value": 5594.51169617387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.30200601955585, 443.41469260576054, 455.1057172655731, 456.63925498855906, 468.115262154528, 30025.699743002562, 31936.411128052587, 39874.003149921264, 41478.585214147846, 41726.7913660432, 41937.0, 42473.93815154623, 42530.787346063225, 42604.9348766281, 42701.0, 9273.258139348853, 9492.81014379712, 9516.238700903945, 9521.047895210493, 9544.0, 8526.74419767408, 8723.302135829119, 9317.860232096524, 11131.888681113207, 11425.542978280859, 11299.209055366127, 11353.545858165664, 11370.441650628625, 11389.487473063731, 11397.373144477091, 11275.943620281887, 11388.772224555545, 11395.943020284845, 11407.144464165222, 11412.372319522423, 8345.707900223524, 8582.914170858274, 8600.526971016592, 8687.913120868774, 8691.826163476759, 39009.609903900884, 39684.20631587381, 39692.40461393081, 41779.0, 41787.373189402184, 3407.4718418645148, 3515.33208690348, 3732.328180927432, 3739.2334571412794, 3973.145773658677, 27225.45549089027, 27634.944807747866, 30330.0, 30565.0, 31351.84324078365, 3149.0710240479116, 3189.8086114833186, 3211.5824942757527, 3288.293017001356, 3326.7172290355347, 409620.9518952416, 409792.0, 410405.0, 410457.9477102625, 411555.0, 56801.0, 57087.714561426925, 57089.85820283571, 57117.85764284774, 61769.69115154396, 63240.68379658072, 63247.0, 63256.36743632597, 63555.0, 63643.681781591724, 15617.0, 15637.530874073796, 15836.44572439982, 16147.677046459004, 16151.192440377934, 11029.944850275857, 12343.321117338633, 12429.440675169639, 12441.813372799415, 12490.500379984698, 14410.42358305656, 15263.542093737206, 15436.536903892902, 17456.47630571085, 17542.75459040056, 6421.711023003976, 6525.412712855866, 6559.311272316433, 6591.505637077238, 6591.638264485147, 851.5061264466594, 894.8076163624852, 985.3693636072919, 1002.4085789384153, 1008.9949550252202, 28285.858570707016, 29197.27006824804, 29350.853245733633, 30269.243268918453, 30360.392792144034, 997.6607953295915, 1031.2677998620914, 1071.7534966957644, 1073.0, 1186.489809381974, 13460.932695336656, 14713.55859324222, 15216.619584510476, 15233.542993710207, 15608.083453712045, 618795.0, 622080.0, 622082.0, 623060.0, 625139.7486025173, 42081.0, 52133.7393313031, 52144.21783673248, 52183.73908130435, 52398.73800630972, 1329.1427029565875, 1363.372848489686, 1383.515769480714, 1388.125480946997, 1388.167099740148, 26842.865785670947, 27546.86226568854, 28062.0, 28154.71845281521, 28221.15336539907, 41349.0, 41413.792931036354, 41537.96155096147, 41548.58451415447, 41585.37621935613, 458285.0, 460468.0, 461283.0, 462232.3776762189, 552908.0, 21709.78290217141, 22411.43971400728, 23814.761852381947, 24302.756972430758, 24360.26919192427, 39630.0, 40008.0, 40720.79639601783, 40787.59212407838, 40912.59087409088, 33951.4907276396, 34196.82901585476, 34231.82884085563, 34722.826385867906, 35893.641063590076, 34143.82928085344, 34416.48375274423, 34883.30233395267, 35337.64662353344, 35479.0, 33744.83127584346, 34300.48549271813, 34537.827310863286, 34600.0, 34605.82697086498, 28653.713462865937, 28797.56803647989, 29945.0, 30673.386532269677, 30710.23224419318, 20231.0, 22636.434089147246, 22981.88509057444, 23564.410889727893, 23719.16982905659], "value": 18879.418961191575, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.23752451188295, 372.3353813443004, 377.78843847445427, 388.20418142807273, 396.59151074393367, 18611.534711632215, 19853.900730496363, 20310.695339569917, 20679.896600517015, 21040.158393664235, 17177.82822171778, 19952.30166944157, 20358.389248322535, 20379.082941267643, 20735.06692198851, 4958.281049247857, 5549.889002219963, 5853.063509838426, 5876.529877609781, 6523.119378883861, 6482.384173503509, 6490.123833282493, 6542.116814230066, 6547.901781473258, 6576.506761992846, 5609.439056094398, 6205.131281620576, 6502.447291980187, 6551.901721474182, 6567.277599464055, 5599.832005039855, 6457.418832305091, 6505.121808555856, 6512.283648798629, 6535.0524173994745, 5673.574481913873, 5811.970940145315, 5814.796482123148, 5816.069428891399, 5819.0, 13034.674133146747, 13245.536406225736, 13255.536056237985, 13341.266230357327, 13447.856932160777, 2200.460887082659, 2208.4810069633622, 2274.943126421836, 2319.5476882008015, 2846.9430611387656, 9950.0, 10302.536385862653, 10581.418022008786, 10683.314256581467, 15723.13522756248, 1680.3446655804246, 1787.8659100567509, 1792.8117547657569, 1840.411068458094, 1910.4173227165709, 96667.51666241624, 113063.0, 121322.78677213291, 121368.0, 121718.78281217163, 11306.477409036452, 11440.370779607036, 11477.0, 11498.665387037832, 11680.474378652982, 14580.0522966009, 14605.488807891672, 14620.122792632475, 14648.414063437343, 14718.926405367905, 8064.193580642006, 8386.664533418594, 8416.789580260542, 8535.658573656985, 8538.06081331053, 8009.799755006172, 8168.06067302256, 8236.04371906097, 8277.917220827836, 8488.702895398632, 4374.803133858984, 4491.685582009228, 4506.954930450654, 4597.862064138081, 4613.008203236321, 1849.5561065344489, 1900.429871038683, 1905.1902941250191, 1905.285517930776, 1914.0716752375365, 797.6330887791565, 855.7518319687221, 870.3559366069063, 871.877937088808, 923.5613083785282, 16087.517374478784, 20247.797522024885, 20543.28098516545, 20873.47816304574, 20932.79067209339, 816.4595077548934, 877.9385443018928, 887.3273878738624, 910.39003867409, 946.9157814302584, 10463.633772817915, 10971.780564388668, 11060.889391106148, 11086.889131108586, 11099.72250693739, 463461.0, 468994.0, 474752.0, 474770.0, 554442.0, 97901.03523601436, 97911.97340346407, 131181.75272988973, 131269.0, 144961.0, 950.4582388038751, 986.8963758805365, 990.0891180114312, 1039.599754094664, 1047.7275908263907, 17982.733626586072, 18532.166052527937, 18970.810291896905, 19225.0, 19545.70681439808, 36521.817390912875, 43052.78473607612, 49527.0, 54292.45707542874, 54535.09127180529, 73882.63058684672, 73896.63051684707, 74467.62766186135, 75392.62303688447, 75890.0, 7773.222677732181, 7972.0, 8090.433669643068, 8212.589370531568, 8237.176282371714, 9714.0, 12354.320512371547, 12377.62867113952, 12693.746125077632, 12812.679683008, 10651.57393704243, 11003.0, 11017.504212310625, 11079.833802492807, 11091.0, 10824.67525974222, 10835.458227088457, 11039.227254092137, 11152.498137583665, 11186.552537898719, 7617.238276172338, 7624.428167887319, 7912.723054693058, 8088.474249173785, 8307.626156822836, 11282.7743445129, 11494.712632184262, 12561.37193140321, 12613.0, 12626.810597840857, 11568.190226684052, 11759.941200293944, 11788.764224715285, 11792.469338879599, 11959.701007474883], "value": 9333.801640585798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.911246212765, 1488.3079368093838, 1599.8000249968754, 1759.4457745810078, 1812.5649844037434, 7988.92011079889, 8413.074561798197, 8425.157484251571, 8434.91565084349, 8446.535440550768, 7207.459440541954, 7386.74146404876, 7401.444891633136, 7934.761957141295, 8202.384821138408, 2271.931842044737, 2330.3940975346363, 2332.644029530178, 2332.9650055249185, 2337.532493501298, 2314.96527552086, 2345.812335013203, 2350.9647355289685, 2353.188150088217, 2369.0286982337243, 1971.4085774267735, 2308.2613563659634, 2330.9300720978313, 2336.8597884127007, 2341.531693661266, 2273.238465114189, 2283.577538155438, 2309.642005489152, 2311.884405779713, 2314.756950520188, 2302.7121609798774, 2314.849534780234, 2326.8487548309304, 2331.825113116523, 2339.6841426407386, 8042.316403105743, 8179.386546009073, 8217.219364160455, 8301.501909885366, 8328.7084952027, 4997.825076122354, 5156.896862062776, 5159.484051594848, 5163.7159956202395, 5165.354330708661, 3150.0, 3235.902922912316, 3412.283420481702, 3414.641462646411, 3429.159855835311, 999.4053538144865, 1043.3896170740127, 1075.6289080267295, 1079.3254216114929, 1080.9675709728722, 10727.731806704816, 10905.454727263685, 10911.127109831194, 10921.617743378943, 10940.56237750497, 4468.932966005513, 4493.0, 4667.743274119888, 4718.811247550128, 4768.237082066853, 8607.827843443096, 8656.177663121993, 8695.217430431292, 8709.346798990102, 8718.912810871938, 5085.872853178626, 5092.770825312869, 5092.796288148506, 5095.15929871567, 5099.158638824552, 4239.788010599457, 4435.223835828781, 4513.345564893138, 4696.600788932979, 4775.785089670973, 3426.109211605001, 3555.964440355615, 3604.3151801157696, 3667.8166091695307, 3671.871484498083, 1093.436880006797, 1129.5030186717818, 1134.8184290513477, 1136.2273653915418, 1145.3128123126223, 800.7597720683888, 860.9268212201907, 881.7090360181124, 929.7117893453051, 934.6495064350869, 5459.863503412367, 5605.887882242332, 5641.069223578063, 5717.542596592262, 5959.0, 820.8440396324798, 887.3699673231948, 888.3248730964384, 922.1786970732883, 926.9629214831331, 3618.1859081706407, 3632.473291372789, 3713.1088538751046, 3721.813909304578, 3805.3827123472415, 9414.15272625467, 9672.516374181263, 9887.752806179904, 10004.599816007423, 10022.498875056364, 9922.50387480623, 9931.10620044185, 9941.353812002197, 9942.502874856229, 9960.80078398428, 7425.368843648351, 7615.5430674159725, 7723.884141737878, 7819.882701759479, 7848.175941526058, 4668.323093151406, 5551.278333816578, 5764.020116580107, 5855.03391940325, 5875.471207591338, 9183.908160918572, 9211.309151813506, 9246.630134794803, 9258.305627077862, 9419.105185007413, 9183.448993060438, 9390.0, 9425.245980321695, 9447.0, 9520.428774273565, 6555.410013098844, 7019.403350715246, 7169.964150179216, 7187.928120718726, 7188.137423509213, 7019.543729657556, 7469.887951680837, 7667.769966901002, 7771.650275737718, 7908.960455197687, 6193.566450348432, 6720.924652055648, 6840.247572767091, 6958.269381714847, 7098.396636285974, 6754.662266886734, 6774.085498457842, 6787.457003439812, 6828.556143850634, 6837.521373504006, 6479.902801457888, 6511.283758786435, 6583.473322134122, 6620.337966203341, 6624.8012559623285, 4690.249560070372, 4745.383100196952, 4792.353032340589, 4823.517648235148, 4988.376452943382, 4760.309755085424, 4761.166795810788, 4778.116048531033, 4804.375431193923, 4892.192788189909], "value": 4338.736916620957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4076429305887, 350.6756250468316, 357.8264541697277, 367.2196582262692, 371.49662207708553, 4685.0, 4910.508949105088, 4984.750762461871, 5079.187330027196, 5253.79162792558, 3966.0084978755312, 4519.615832654228, 4715.339852420664, 5154.561862241714, 5196.324477817888, 3814.713896457763, 4032.2741906456827, 4087.0599762054744, 4117.023828562292, 4119.567445418233, 3828.272628200647, 4066.8169932353117, 4077.97961010196, 4100.528439229482, 4122.319817230168, 2808.4102338508937, 3399.5721796845382, 3942.664873485757, 3990.421388898608, 4052.305217030686, 3514.5782506099176, 3759.868404605853, 3945.9210815783813, 3961.2869683456966, 3979.582143874895, 3462.774919630216, 3463.4631632097066, 3467.959612116355, 3472.791632502033, 3487.459443786217, 4451.840857184263, 4628.120657075145, 4854.0, 5090.389153301628, 5106.876487172816, 3713.554373475173, 4013.678905687538, 4076.9592304077173, 4223.176480586256, 4312.611864932172, 4603.792829322689, 5038.39539255288, 5446.019716451037, 5464.453554644543, 5519.371785323339, 3254.528093426464, 3759.6052414496357, 3762.548494180716, 3764.2283331917165, 3775.4714339992424, 5464.6994415307145, 5519.475649813261, 5701.885962280731, 5728.28151554532, 5761.654300741969, 3373.5614370132216, 3792.805266341149, 3795.7342985991268, 3804.923901521954, 3809.466674665549, 3115.2679120406688, 3554.8400321985573, 3635.163912300133, 3847.0, 3888.0862997195636, 3999.440078389028, 4295.463067116611, 4426.8671939841215, 4502.707324023928, 4518.480374756879, 4470.374147619336, 5047.97476012625, 5503.780288531254, 5521.972390138024, 5550.47270509301, 1043.7286305560608, 1129.193953026728, 1152.6426807689643, 1180.7166280092715, 1246.507629486348, 690.3441730356182, 804.9195080491904, 814.3241109878904, 848.8132610825609, 864.7924498120532, 4391.363252328394, 4840.2255639098275, 4864.343313652612, 4879.951200488021, 4919.680220785637, 4740.549647783455, 4782.641301902371, 5239.563602924658, 5321.787128514893, 5376.7739356385855, 4573.3368661544555, 4596.954030459719, 4794.736289504111, 4851.719691744875, 4963.404391473046, 2336.9649455258186, 2795.95241187107, 2816.690164081949, 2823.0966090851143, 2825.8445785481995, 4929.87675308113, 5537.732737684705, 5538.086215774352, 5579.218909352694, 5585.1901474286005, 4801.759912004386, 5032.659813186886, 5322.33470816148, 5460.726963651801, 5487.64330318536, 4595.058013107305, 4691.601213896789, 4918.19662792205, 5001.149574657327, 5387.821185500574, 4587.72473651582, 5080.602834220471, 5115.462876397924, 5123.0, 5306.416294207557, 4534.820946553986, 5648.881669373985, 5662.008284159575, 5689.601727879009, 5757.61817163886, 5155.917257375843, 5471.370792358771, 5880.411958804086, 5961.374055724086, 5979.222701048836, 2973.3813899579945, 3313.7904664797657, 3390.4914262859784, 3456.481527770754, 3742.7835953315825, 5413.133898576209, 5582.9720851397105, 5667.234923285304, 5672.914906276326, 5744.770209191585, 4535.433070866142, 5059.392872855281, 5573.8507743125, 5596.642014791093, 5605.355384130877, 4893.266010098514, 5090.4655011223285, 5248.553872920845, 5527.866787308672, 5617.859553511195, 4721.7403042832975, 4846.806127754991, 5310.044192045469, 5443.755031023693, 5447.754851031634, 4908.0, 4943.7640589852535, 5038.823641172541, 5404.378876245097, 5531.9723401382735, 4924.433690125681, 5008.772850651613, 5416.783328666809, 5434.239206511171, 5441.993231252231], "value": 3906.1447987602137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.6944014073948, 730.404720153075, 739.974100906468, 785.0069661877726, 822.7284995951337, 16769.580760480978, 17506.912465437672, 17581.7362739559, 17585.472435826912, 17649.382271620496, 15662.216889155554, 16325.83674163258, 16460.423885164022, 16466.83533164668, 16529.504114876574, 688.7864761923795, 853.355716434093, 881.8104107616861, 887.8002449448887, 889.4129874282975, 702.5679207287533, 713.8679344321291, 822.3256929317962, 848.1815048478218, 863.6372723456132, 918.2837386838277, 918.7703074231442, 919.6413398774483, 920.4753290624346, 922.5525620074259, 916.715818096389, 917.4220241248038, 917.495377542349, 918.4948278446827, 919.2737737187614, 525.188583638276, 543.2774410034644, 656.3534918105662, 677.1163631460942, 679.3071067511111, 14799.334029968677, 14822.665960063647, 15129.319180636898, 15305.770413443808, 15369.923150384288, 13219.405126769318, 13263.602091937257, 13268.535601254007, 13311.201327920357, 13386.0, 12511.311877846714, 12682.36588170597, 12832.871671283354, 12980.675483112904, 13136.60590182296, 4409.5149533551285, 4418.160549495586, 4482.910341793146, 4582.473015603215, 4598.770061496912, 105382.47308763408, 106520.46739766252, 107836.0, 110733.0, 113907.86092139056, 10336.17310615149, 10503.107235884883, 10618.415987120628, 10714.46427678613, 10750.139988800876, 20474.18103275882, 20643.27748528794, 20729.792702072788, 20824.062917168765, 20847.1661133556, 7502.17476077631, 7510.549367037996, 7609.961950190213, 7628.427867909929, 7769.572673503011, 4231.9576804231565, 4296.312589985588, 4313.266744653416, 4417.580329868657, 4444.2444784386735, 3336.649651786576, 3360.22714775603, 3386.051905466424, 3436.244026314207, 3443.1564266754804, 617.3240301869446, 632.3265722006049, 644.2912795924445, 644.7775517446473, 652.100101859431, 509.1065180608009, 586.4956137721556, 589.8348462430527, 609.7195290166574, 622.8287221014257, 8168.714095006646, 8679.482949944571, 8732.8690069649, 8817.911820881838, 8894.510801905828, 497.8083437876371, 568.2243737298558, 568.5849329989048, 589.5990726306153, 601.1433706967641, 3473.4616134499192, 4020.19596080785, 4194.077302993336, 4224.746515209097, 4328.462073764813, 76711.61644191743, 90107.0, 96637.0, 98586.50706746565, 98741.0, 83921.58039209765, 84256.0, 87971.56014219888, 88048.0, 88978.55510722405, 77681.0, 77961.0, 77972.0, 78285.60857195678, 78413.60793195998, 8308.169183081643, 8337.416380853281, 8354.987207174083, 8406.0, 8604.225619694007, 45992.0, 50051.499485004686, 52390.738046309525, 53591.196132057274, 53607.46392536024, 55672.32983010516, 65198.67400662966, 66576.0, 68697.65651171713, 69113.30886691068, 12649.557265495663, 12848.229106253655, 13314.46742130304, 13344.332783360987, 13634.181949083088, 14634.560963171121, 14692.632684182981, 14926.253687315373, 15417.691646167239, 15513.146776927377, 13368.859019033733, 13610.895096807388, 13723.656908577366, 13893.861061389256, 14063.507777227747, 13649.317534123453, 13716.314184290546, 13947.790783138058, 13949.16305021702, 14061.578152655436, 12310.384480775747, 12562.555306139911, 13245.139065960682, 13276.26980516081, 13507.39216735269, 10956.726081848017, 11039.119015346805, 11396.886031139582, 11414.315141091562, 11859.466324015268, 10573.246497493587, 10591.5233814477, 11228.66314010581, 11294.058911632552, 11628.709282267673], "value": 7385.512651280465, "unit": "score"}], "name": "dromaeo_css", "value": 7055.99506915472, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 109.0, 149.0, 116.0, 116.0, 117.0, 98.0, 152.0, 143.0], "value": 126.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 184.0, 188.0, 184.0, 181.0, 183.0, 182.0, 184.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 61.0, 88.0, 62.0, 60.0, 60.0, 60.0, 92.0, 82.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 87.0, 70.0, 69.0, 68.0, 84.0, 70.0, 69.0, 83.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 114.0, 110.0, 96.0, 153.0, 114.0, 110.0, 129.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 94.0, 93.0, 94.0, 94.0, 118.0, 144.0, 93.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 89.0, 69.0, 128.0, 131.0, 85.0, 87.0, 86.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 55.0, 55.0, 56.0, 55.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 96.0, 99.0, 109.0, 86.0, 69.0, 70.0, 69.0, 71.0, 71.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 91.0, 92.0, 92.0, 93.0, 92.0, 127.0, 93.0], "value": 95.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 141.0, 148.0, 150.0, 146.0, 151.0, 155.0, 187.0, 141.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 234.0, 178.0, 178.0, 180.0, 182.0, 180.0, 178.0, 174.0, 177.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 72.0, 80.0, 86.0, 83.0, 79.0, 67.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1522.6999999999998, "alertThreshold": 2.0}]} 08:06:58 INFO - Return code: 0 08:06:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:06:58 INFO - # TBPL SUCCESS # 08:06:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:06:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:06:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:06:58 INFO - 2016-12-10 08:06:58.157 screenresolution[1941:15871] starting screenresolution argv=screenresolution get 08:06:58 INFO - 2016-12-10 08:06:58.160 screenresolution[1941:15871] Display 0: 1600x1200x32@60 08:06:58 INFO - 2016-12-10 08:06:58.167 screenresolution[1942:15874] starting screenresolution argv=screenresolution list 08:06:58 INFO - Available Modes on Display 0 08:06:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:06:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:06:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:06:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:06:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:06:58 INFO - Intel Iris: 08:06:58 INFO - Chipset Model: Intel Iris 08:06:58 INFO - Type: GPU 08:06:58 INFO - Bus: Built-In 08:06:58 INFO - VRAM (Dynamic, Max): 1536 MB 08:06:58 INFO - Vendor: Intel (0x8086) 08:06:58 INFO - Device ID: 0x0a2e 08:06:58 INFO - Revision ID: 0x0009 08:06:58 INFO - Displays: 08:06:58 INFO - Display: 08:06:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:06:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:06:58 INFO - Display Serial Number: 1600x1200 60 08:06:58 INFO - Main Display: Yes 08:06:58 INFO - Mirror: Off 08:06:58 INFO - Online: Yes 08:06:58 INFO - Rotation: Supported 08:06:58 INFO - Return code: 0 08:06:58 INFO - Running post-action listener: _resource_record_post_action 08:06:58 INFO - [mozharness: 2016-12-10 16:06:58.412193Z] Finished run-tests step (success) 08:06:58 INFO - Running post-run listener: _resource_record_post_run 08:06:58 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 700416; Write bytes: 551707136; Read time: 11; Write time: 1673 08:06:58 INFO - TinderboxPrint: CPU usage
53.8% 08:06:58 INFO - TinderboxPrint: I/O read bytes / time
700,416 / 11 08:06:58 INFO - TinderboxPrint: I/O write bytes / time
551,707,136 / 1,673 08:06:58 INFO - TinderboxPrint: CPU idle
2,224.9 (46.2%) 08:06:58 INFO - TinderboxPrint: CPU system
966.2 (20.1%) 08:06:58 INFO - TinderboxPrint: CPU user
1,626.6 (33.8%) 08:06:58 INFO - TinderboxPrint: Swap in / out
250,552,320 / 0 08:06:58 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250149376; Write bytes: 252577792; Read time: 18242; Write time: 530 08:06:58 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 626688; Write bytes: 297617920; Read time: 10; Write time: 1132 08:06:58 INFO - Running post-run listener: _upload_blobber_files 08:06:58 INFO - Blob upload gear active. 08:06:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:06:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:06:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:06:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:06:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:00 INFO - (blobuploader) - INFO - Done attempting. 08:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:01 INFO - (blobuploader) - INFO - Done attempting. 08:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:03 INFO - (blobuploader) - INFO - Done attempting. 08:07:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:03 INFO - Return code: 0 08:07:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab58a1e16cbcbdb80c8144148d6b51982e8185434994f908fddbb3e793b51e82b738cee6baa37719311d5f0a79d749fff5b852a98eb1ab154d8c22f868a19460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c670cda14e010a3736b5cf60063e097e004197623882b671475bba9ad0eee20b62522784272995adce96f26d33453668d6b88b5fcbee627acafbb1579079c1bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35758a81f4b3080e40878f084d9881f29411fd793ba0548b6a34a757703c9b6843f4fc573d25a5fbde82b19bd04fe81658f5735cfd661b19d48688f3dbe6139"} 08:07:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:03 INFO - Contents: 08:07:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab58a1e16cbcbdb80c8144148d6b51982e8185434994f908fddbb3e793b51e82b738cee6baa37719311d5f0a79d749fff5b852a98eb1ab154d8c22f868a19460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c670cda14e010a3736b5cf60063e097e004197623882b671475bba9ad0eee20b62522784272995adce96f26d33453668d6b88b5fcbee627acafbb1579079c1bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35758a81f4b3080e40878f084d9881f29411fd793ba0548b6a34a757703c9b6843f4fc573d25a5fbde82b19bd04fe81658f5735cfd661b19d48688f3dbe6139"} 08:07:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:03 INFO - Copying logs to upload dir... 08:07:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.404280 ========= master_lag: 0.84 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-10 08:07:04.506160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 08:07:04.510021) ========= 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.aHq1j3afIp/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.RmC8LijjHP/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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/Firefox/sha512/ab58a1e16cbcbdb80c8144148d6b51982e8185434994f908fddbb3e793b51e82b738cee6baa37719311d5f0a79d749fff5b852a98eb1ab154d8c22f868a19460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c670cda14e010a3736b5cf60063e097e004197623882b671475bba9ad0eee20b62522784272995adce96f26d33453668d6b88b5fcbee627acafbb1579079c1bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35758a81f4b3080e40878f084d9881f29411fd793ba0548b6a34a757703c9b6843f4fc573d25a5fbde82b19bd04fe81658f5735cfd661b19d48688f3dbe6139"} build_url:https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.010802 build_url: 'https://queue.taskcluster.net/v1/task/dT8tL99sSnWWumObtn3LJw/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab58a1e16cbcbdb80c8144148d6b51982e8185434994f908fddbb3e793b51e82b738cee6baa37719311d5f0a79d749fff5b852a98eb1ab154d8c22f868a19460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c670cda14e010a3736b5cf60063e097e004197623882b671475bba9ad0eee20b62522784272995adce96f26d33453668d6b88b5fcbee627acafbb1579079c1bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35758a81f4b3080e40878f084d9881f29411fd793ba0548b6a34a757703c9b6843f4fc573d25a5fbde82b19bd04fe81658f5735cfd661b19d48688f3dbe6139"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 08:07:04.544392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:07:04.544769) ========= 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.aHq1j3afIp/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.RmC8LijjHP/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.005173 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 08:07:04.593471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 08:07:04.593793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 08:07:04.594133) ========= ========= Total master_lag: 1.71 =========