builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0013 starttime: 1484605915.85 results: success (0) buildid: 20170116131921 builduid: f7b025b2748a45a7abf124da4142242e revision: 88030580b14bb253a55bc174c987a9fa43c3fb55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:55.848559) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:55.849049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:55.849325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:55.879398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:55.879835) ========= 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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-16 14:31: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% 14.1M=0.001s 2017-01-16 14:31:56 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.263467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:56.165563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:56.165908) ========= 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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.026581 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:31:56.214410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-01-16 14:31:56.214839) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 88030580b14bb253a55bc174c987a9fa43c3fb55 --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 88030580b14bb253a55bc174c987a9fa43c3fb55 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-16 14:31:56,309 truncating revision to first 12 chars 2017-01-16 14:31:56,309 Setting DEBUG logging. 2017-01-16 14:31:56,309 attempt 1/10 2017-01-16 14:31:56,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/88030580b14b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 14:31:58,135 unpacking tar archive at: mozilla-central-88030580b14b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.101161 ========= master_lag: 3.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-01-16 14:32:01.713017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:01.713396) ========= script_repo_revision: 88030580b14bb253a55bc174c987a9fa43c3fb55 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:01.713821) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:01.716979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:01.766074) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-16 14:32:01.766446) ========= /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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:01 INFO - MultiFileLogger online at 20170116 14:32:01 in /builds/slave/test 14:32:01 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 14:32:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:01 INFO - {'append_to_log': False, 14:32:01 INFO - 'base_work_dir': '/builds/slave/test', 14:32:01 INFO - 'blob_upload_branch': 'Firefox', 14:32:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:01 INFO - 'branch': 'Firefox', 14:32:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:01 INFO - 'config_files': ('talos/mac_config.py',), 14:32:01 INFO - 'default_actions': ('clobber', 14:32:01 INFO - 'read-buildbot-config', 14:32:01 INFO - 'download-and-extract', 14:32:01 INFO - 'populate-webroot', 14:32:01 INFO - 'create-virtualenv', 14:32:01 INFO - 'install', 14:32:01 INFO - 'run-tests'), 14:32:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:01 INFO - 'download_minidump_stackwalk': True, 14:32:01 INFO - 'download_symbols': 'ondemand', 14:32:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:01 INFO - 'installer_path': 'installer.exe', 14:32:01 INFO - 'log_level': 'info', 14:32:01 INFO - 'log_name': 'talos', 14:32:01 INFO - 'log_to_console': True, 14:32:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:01 INFO - 'opt_config_files': (), 14:32:01 INFO - 'pip_index': False, 14:32:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:01 INFO - 'cmd': ('bash', 14:32:01 INFO - '-c', 14:32:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:01 INFO - 'enabled': True, 14:32:01 INFO - 'halt_on_failure': False, 14:32:01 INFO - 'name': 'check_screen_resolution'},), 14:32:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:01 INFO - 'cmd': ('bash', 14:32:01 INFO - '-c', 14:32:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:01 INFO - 'enabled': True, 14:32:01 INFO - 'halt_on_failure': False, 14:32:01 INFO - 'name': 'check_screen_resolution'},), 14:32:01 INFO - 'run_cmd_checks_enabled': True, 14:32:01 INFO - 'sps_profile': False, 14:32:01 INFO - 'sps_profile_interval': 0, 14:32:01 INFO - 'suite': 'dromaeojs', 14:32:01 INFO - 'system_bits': '32', 14:32:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:01 INFO - 'title': 't-yosemite-r7-0013', 14:32:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:01 INFO - 'use_talos_json': True, 14:32:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:01 INFO - 'work_dir': 'build'} 14:32:01 INFO - [mozharness: 2017-01-16 22:32:01.972781Z] Running clobber step. 14:32:01 INFO - Running pre-action listener: _resource_record_pre_action 14:32:01 INFO - Running main action method: clobber 14:32:01 INFO - rmtree: /builds/slave/test/build 14:32:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:04 INFO - Running post-action listener: _resource_record_post_action 14:32:04 INFO - [mozharness: 2017-01-16 22:32:04.486051Z] Finished clobber step (success) 14:32:04 INFO - [mozharness: 2017-01-16 22:32:04.486219Z] Running read-buildbot-config step. 14:32:04 INFO - Running pre-action listener: _resource_record_pre_action 14:32:04 INFO - Running main action method: read_buildbot_config 14:32:04 INFO - Using buildbot properties: 14:32:04 INFO - { 14:32:04 INFO - "project": "", 14:32:04 INFO - "product": "firefox", 14:32:04 INFO - "script_repo_revision": "production", 14:32:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:32:04 INFO - "repository": "", 14:32:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:32:04 INFO - "buildid": "20170116131921", 14:32:04 INFO - "pgo_build": "False", 14:32:04 INFO - "basedir": "/builds/slave/test", 14:32:04 INFO - "buildnumber": 17, 14:32:04 INFO - "slavename": "t-yosemite-r7-0013", 14:32:04 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:32:04 INFO - "platform": "yosemite_r7", 14:32:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:32:04 INFO - "branch": "mozilla-central", 14:32:04 INFO - "repo_path": "mozilla-central", 14:32:04 INFO - "revision": "88030580b14bb253a55bc174c987a9fa43c3fb55", 14:32:04 INFO - "stage_platform": "macosx64", 14:32:04 INFO - "builduid": "f7b025b2748a45a7abf124da4142242e", 14:32:04 INFO - "slavebuilddir": "test" 14:32:04 INFO - } 14:32:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:32:04 INFO - Running post-action listener: _resource_record_post_action 14:32:04 INFO - [mozharness: 2017-01-16 22:32:04.489715Z] Finished read-buildbot-config step (success) 14:32:04 INFO - [mozharness: 2017-01-16 22:32:04.489853Z] Running download-and-extract step. 14:32:04 INFO - Running pre-action listener: _resource_record_pre_action 14:32:04 INFO - Running main action method: download_and_extract 14:32:04 INFO - mkdir: /builds/slave/test/build/tests 14:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:04 INFO - trying https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:32:04 INFO - Downloading https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:32:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:32:05 INFO - Downloaded 1199 bytes. 14:32:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:32:05 INFO - Using the following test package requirements: 14:32:05 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:32:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:32:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:32:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'jsshell-mac.zip'], 14:32:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:32:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:32:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:32:05 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:32:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:32:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:05 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:32:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:32:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:32:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:05 INFO - Fetch https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:32:06 INFO - Expected file size: 16326595 14:32:06 INFO - Obtained file size: 16326595 14:32:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:32:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:32:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:13 INFO - Fetch https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:32:13 INFO - Expected file size: 16326595 14:32:13 INFO - Obtained file size: 16326595 14:32:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:32:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:32:20 INFO - Fetch https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:32:21 INFO - Expected file size: 14403463 14:32:21 INFO - Obtained file size: 14403463 14:32:21 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')]} 14:32:21 INFO - trying https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:32:21 INFO - Downloading https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:32:23 INFO - Downloaded 70186189 bytes. 14:32:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:32:23 INFO - mkdir: /builds/slave/test/properties 14:32:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:23 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:23 INFO - Contents: 14:32:23 INFO - build_url:https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:32:24 INFO - Running post-action listener: _resource_record_post_action 14:32:24 INFO - Running post-action listener: set_extra_try_arguments 14:32:24 INFO - [mozharness: 2017-01-16 22:32:24.441738Z] Finished download-and-extract step (success) 14:32:24 INFO - [mozharness: 2017-01-16 22:32:24.441879Z] Running populate-webroot step. 14:32:24 INFO - Running pre-action listener: _resource_record_pre_action 14:32:24 INFO - Running main action method: populate_webroot 14:32:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:24 INFO - '--tppagecycles', 14:32:24 INFO - '7'], 14:32:24 INFO - 'tests': ['tsvgm']}}, 14:32:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:32:24 INFO - 'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:32:24 INFO - 'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['damp', 'tps']}, 14:32:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:32:24 INFO - 'tests': ['damp', 'tps']}, 14:32:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['dromaeo_dom']}, 14:32:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['basic_compositor_video']}, 14:32:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:32:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['a11yr', 14:32:24 INFO - 'ts_paint', 14:32:24 INFO - 'tpaint', 14:32:24 INFO - 'sessionrestore', 14:32:24 INFO - 'sessionrestore_no_auto_restore', 14:32:24 INFO - 'tabpaint']}, 14:32:24 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:24 INFO - 'ts_paint', 14:32:24 INFO - 'tpaint', 14:32:24 INFO - 'sessionrestore', 14:32:24 INFO - 'sessionrestore_no_auto_restore', 14:32:24 INFO - 'tabpaint']}, 14:32:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:24 INFO - 'ts_paint', 14:32:24 INFO - 'tpaint', 14:32:24 INFO - 'sessionrestore', 14:32:24 INFO - 'sessionrestore_no_auto_restore', 14:32:24 INFO - 'tabpaint']}, 14:32:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:24 INFO - 'ts_paint', 14:32:24 INFO - 'tpaint', 14:32:24 INFO - 'sessionrestore', 14:32:24 INFO - 'sessionrestore_no_auto_restore', 14:32:24 INFO - 'tabpaint']}, 14:32:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['a11yr', 14:32:24 INFO - 'ts_paint', 14:32:24 INFO - 'tpaint', 14:32:24 INFO - 'sessionrestore', 14:32:24 INFO - 'sessionrestore_no_auto_restore', 14:32:24 INFO - 'tabpaint']}, 14:32:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['a11yr', 14:32:24 INFO - 'ts_paint', 14:32:24 INFO - 'tpaint', 14:32:24 INFO - 'sessionrestore', 14:32:24 INFO - 'sessionrestore_no_auto_restore', 14:32:24 INFO - 'tabpaint']}, 14:32:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['tsvgx', 14:32:24 INFO - 'tsvgr_opacity', 14:32:24 INFO - 'tart', 14:32:24 INFO - 'tscrollx', 14:32:24 INFO - 'cart', 14:32:24 INFO - 'tsvg_static']}, 14:32:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:24 INFO - 'tsvgr_opacity', 14:32:24 INFO - 'tart', 14:32:24 INFO - 'tscrollx', 14:32:24 INFO - 'cart', 14:32:24 INFO - 'tsvg_static']}, 14:32:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:32:24 INFO - 'talos_options': ['--disable-e10s'], 14:32:24 INFO - 'tests': ['tp5o']}, 14:32:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:32:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:32:24 INFO - 'talos_options': ['--disable-e10s', 14:32:24 INFO - '--xperf_path', 14:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:24 INFO - 'tests': ['tp5n']}, 14:32:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:32:24 INFO - 'talos_options': ['--xperf_path', 14:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:24 INFO - 'tests': ['tp5n']}}, 14:32:24 INFO - 'talos.zip': {'path': '', 14:32:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:24 INFO - Running post-action listener: _resource_record_post_action 14:32:24 INFO - [mozharness: 2017-01-16 22:32:24.460313Z] Finished populate-webroot step (success) 14:32:24 INFO - [mozharness: 2017-01-16 22:32:24.460435Z] Running create-virtualenv step. 14:32:24 INFO - Running pre-action listener: _resource_record_pre_action 14:32:24 INFO - Running main action method: create_virtualenv 14:32:24 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:24 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 14:32:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:24 INFO - Using real prefix '/tools/python27' 14:32:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:25 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:28 INFO - Installing pip.................done. 14:32:28 INFO - Return code: 0 14:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:32:28 INFO - Reading from file tmpfile_stdout 14:32:28 INFO - Output received: 14:32:28 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) 14:32:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32:28 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')]} 14:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:28 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')]} 14:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:28 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:28 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 14:32:28 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 14:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:28 INFO - 'HOME': '/Users/cltbld', 14:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:28 INFO - 'LOGNAME': 'cltbld', 14:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:28 INFO - 'MOZ_NO_REMOTE': '1', 14:32:28 INFO - 'NO_EM_RESTART': '1', 14:32:28 INFO - 'PAGER': '/bin/cat', 14:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:28 INFO - 'PWD': '/builds/slave/test', 14:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:28 INFO - 'SHELL': '/bin/bash', 14:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:28 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:28 INFO - 'USER': 'cltbld', 14:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:28 INFO - 'XPC_FLAGS': '0x0', 14:32:28 INFO - 'XPC_SERVICE_NAME': '0', 14:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:28 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 14:32:28 INFO - Cleaning up... 14:32:28 INFO - Return code: 0 14:32:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32:28 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')]} 14:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:28 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')]} 14:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:28 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:28 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 14:32:28 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 14:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:28 INFO - 'HOME': '/Users/cltbld', 14:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:28 INFO - 'LOGNAME': 'cltbld', 14:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:28 INFO - 'MOZ_NO_REMOTE': '1', 14:32:28 INFO - 'NO_EM_RESTART': '1', 14:32:28 INFO - 'PAGER': '/bin/cat', 14:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:28 INFO - 'PWD': '/builds/slave/test', 14:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:28 INFO - 'SHELL': '/bin/bash', 14:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:28 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:28 INFO - 'USER': 'cltbld', 14:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:28 INFO - 'XPC_FLAGS': '0x0', 14:32:28 INFO - 'XPC_SERVICE_NAME': '0', 14:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:28 INFO - Downloading/unpacking psutil>=3.1.1 14:32:28 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 14:32:28 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 14:32:29 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 14:32:29 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 14:32:29 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 14:32:29 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 14:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:32 INFO - Installing collected packages: psutil 14:32:32 INFO - Running setup.py install for psutil 14:32:32 INFO - building 'psutil._psutil_osx' extension 14:32:32 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 14:32:33 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 14:32:33 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 14:32:33 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 14:32:33 INFO - building 'psutil._psutil_posix' extension 14:32:33 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 14:32:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:32:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:32:33 INFO - ^ 14:32:33 INFO - 1 warning generated. 14:32:33 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 14:32:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:33 INFO - Successfully installed psutil 14:32:33 INFO - Cleaning up... 14:32:33 INFO - Return code: 0 14:32:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:32: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 mozsystemmonitor==0.3 14:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:33 INFO - 'HOME': '/Users/cltbld', 14:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:33 INFO - 'LOGNAME': 'cltbld', 14:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:33 INFO - 'MOZ_NO_REMOTE': '1', 14:32:33 INFO - 'NO_EM_RESTART': '1', 14:32:33 INFO - 'PAGER': '/bin/cat', 14:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:33 INFO - 'PWD': '/builds/slave/test', 14:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:33 INFO - 'SHELL': '/bin/bash', 14:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:33 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:33 INFO - 'USER': 'cltbld', 14:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:33 INFO - 'XPC_FLAGS': '0x0', 14:32:33 INFO - 'XPC_SERVICE_NAME': '0', 14:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:32:36 INFO - Installing collected packages: mozsystemmonitor 14:32:36 INFO - Running setup.py install for mozsystemmonitor 14:32:36 INFO - Successfully installed mozsystemmonitor 14:32:36 INFO - Cleaning up... 14:32:37 INFO - Return code: 0 14:32:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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', '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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:32: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 jsonschema==2.5.1 14:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:37 INFO - 'HOME': '/Users/cltbld', 14:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:37 INFO - 'LOGNAME': 'cltbld', 14:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:37 INFO - 'MOZ_NO_REMOTE': '1', 14:32:37 INFO - 'NO_EM_RESTART': '1', 14:32:37 INFO - 'PAGER': '/bin/cat', 14:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:37 INFO - 'PWD': '/builds/slave/test', 14:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:37 INFO - 'SHELL': '/bin/bash', 14:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:37 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:37 INFO - 'USER': 'cltbld', 14:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:37 INFO - 'XPC_FLAGS': '0x0', 14:32:37 INFO - 'XPC_SERVICE_NAME': '0', 14:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:37 INFO - Downloading/unpacking jsonschema==2.5.1 14:32:37 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 14:32:37 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 14:32:37 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 14:32:37 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 14:32:37 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 14:32:37 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 14:32:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:40 INFO - warning: no files found matching '*.txt' 14:32:40 INFO - no previously-included directories found matching 'build' 14:32:40 INFO - no previously-included directories found matching 'dist' 14:32:40 INFO - no previously-included directories found matching '.git*' 14:32:40 INFO - Installing collected packages: jsonschema, functools32 14:32:40 INFO - Running setup.py install for functools32 14:32:40 INFO - warning: no files found matching '*.txt' 14:32:40 INFO - no previously-included directories found matching 'build' 14:32:40 INFO - no previously-included directories found matching 'dist' 14:32:40 INFO - no previously-included directories found matching '.git*' 14:32:40 INFO - Successfully installed jsonschema functools32 14:32:40 INFO - Cleaning up... 14:32:40 INFO - Return code: 0 14:32:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:40 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:40 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 14:32:40 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 14:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:40 INFO - 'HOME': '/Users/cltbld', 14:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:40 INFO - 'LOGNAME': 'cltbld', 14:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:40 INFO - 'MOZ_NO_REMOTE': '1', 14:32:40 INFO - 'NO_EM_RESTART': '1', 14:32:40 INFO - 'PAGER': '/bin/cat', 14:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:40 INFO - 'PWD': '/builds/slave/test', 14:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:40 INFO - 'SHELL': '/bin/bash', 14:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:40 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:40 INFO - 'USER': 'cltbld', 14:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:40 INFO - 'XPC_FLAGS': '0x0', 14:32:40 INFO - 'XPC_SERVICE_NAME': '0', 14:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:32:40 INFO - Cleaning up... 14:32:40 INFO - Return code: 0 14:32:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:40 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:40 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 14:32:40 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 14:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:40 INFO - 'HOME': '/Users/cltbld', 14:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:40 INFO - 'LOGNAME': 'cltbld', 14:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:40 INFO - 'MOZ_NO_REMOTE': '1', 14:32:40 INFO - 'NO_EM_RESTART': '1', 14:32:40 INFO - 'PAGER': '/bin/cat', 14:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:40 INFO - 'PWD': '/builds/slave/test', 14:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:40 INFO - 'SHELL': '/bin/bash', 14:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:40 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:40 INFO - 'USER': 'cltbld', 14:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:40 INFO - 'XPC_FLAGS': '0x0', 14:32:40 INFO - 'XPC_SERVICE_NAME': '0', 14:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:44 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 14:32:45 INFO - Downloading docopt-0.6.1.tar.gz 14:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:45 INFO - Running setup.py install for blobuploader 14:32:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:45 INFO - Running setup.py install for requests 14:32:45 INFO - Running setup.py install for docopt 14:32:45 INFO - Successfully installed blobuploader requests docopt 14:32:45 INFO - Cleaning up... 14:32:46 INFO - Return code: 0 14:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:46 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')]} 14:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:46 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')]} 14:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:46 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:46 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 14:32:46 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 14:32:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:46 INFO - 'HOME': '/Users/cltbld', 14:32:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:46 INFO - 'LOGNAME': 'cltbld', 14:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:46 INFO - 'MOZ_NO_REMOTE': '1', 14:32:46 INFO - 'NO_EM_RESTART': '1', 14:32:46 INFO - 'PAGER': '/bin/cat', 14:32:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:46 INFO - 'PWD': '/builds/slave/test', 14:32:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:46 INFO - 'SHELL': '/bin/bash', 14:32:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:46 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:46 INFO - 'USER': 'cltbld', 14:32:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:46 INFO - 'XPC_FLAGS': '0x0', 14:32:46 INFO - 'XPC_SERVICE_NAME': '0', 14:32:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-jRCP9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-I8lpTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-0GsLPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-o4tgGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hRVphx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-gdLP_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:46 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ZUtrdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-wNKhLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-IgI3Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-GInkGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ky7pBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-XRGW_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mEL5Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-GOBhEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-as5iox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:47 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-3LyMOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:48 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-M9R6E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:48 INFO - Running setup.py install for manifestparser 14:32:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:48 INFO - Running setup.py install for mozcrash 14:32:48 INFO - Running setup.py install for mozdebug 14:32:48 INFO - Running setup.py install for mozdevice 14:32:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:48 INFO - Running setup.py install for mozfile 14:32:48 INFO - Running setup.py install for mozhttpd 14:32:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Running setup.py install for mozinfo 14:32:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Running setup.py install for mozInstall 14:32:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Running setup.py install for mozleak 14:32:49 INFO - Running setup.py install for mozlog 14:32:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Running setup.py install for moznetwork 14:32:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:49 INFO - Running setup.py install for mozprocess 14:32:49 INFO - Running setup.py install for mozprofile 14:32:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:50 INFO - Running setup.py install for mozrunner 14:32:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:50 INFO - Running setup.py install for mozscreenshot 14:32:50 INFO - Running setup.py install for moztest 14:32:50 INFO - Running setup.py install for mozversion 14:32:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:50 INFO - Cleaning up... 14:32:50 INFO - Return code: 0 14:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:50 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:50 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 14:32:50 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 14:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:50 INFO - 'HOME': '/Users/cltbld', 14:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:50 INFO - 'LOGNAME': 'cltbld', 14:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:50 INFO - 'MOZ_NO_REMOTE': '1', 14:32:50 INFO - 'NO_EM_RESTART': '1', 14:32:50 INFO - 'PAGER': '/bin/cat', 14:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:50 INFO - 'PWD': '/builds/slave/test', 14:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:50 INFO - 'SHELL': '/bin/bash', 14:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:50 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:50 INFO - 'USER': 'cltbld', 14:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:50 INFO - 'XPC_FLAGS': '0x0', 14:32:50 INFO - 'XPC_SERVICE_NAME': '0', 14:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rO_G1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pifA43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-CDVVAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-KYOtk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rjuj9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mWBOp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pDYuVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-SisBwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-wPNTom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:51 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)) 14:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-7RpiHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:52 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)) 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:52 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-eUC4xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:52 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)) 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:52 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-MZXzJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:52 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Vih2pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:52 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)) 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:52 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vxgZw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:52 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)) 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:52 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YOM0sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:52 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)) 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:52 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-5EZwcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:52 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-47Q7xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:52 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)) 14:32:52 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)) 14:32:52 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)) 14:32:52 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)) 14:32:52 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)) 14:32:52 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)) 14:32:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:52 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 14:32:52 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 14:32:52 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 14:32:52 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 14:32:52 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 14:32:52 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 14:32:55 INFO - Downloading blessings-1.6.tar.gz 14:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:55 INFO - Installing collected packages: blessings 14:32:55 INFO - Running setup.py install for blessings 14:32:56 INFO - Successfully installed blessings 14:32:56 INFO - Cleaning up... 14:32:56 INFO - Return code: 0 14:32:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:56 INFO - Reading from file tmpfile_stdout 14:32:56 INFO - Current package versions: 14:32:56 INFO - blessings == 1.6 14:32:56 INFO - blobuploader == 1.2.4 14:32:56 INFO - docopt == 0.6.1 14:32:56 INFO - functools32 == 3.2.3-2 14:32:56 INFO - jsonschema == 2.5.1 14:32:56 INFO - manifestparser == 1.1 14:32:56 INFO - mozInstall == 1.12 14:32:56 INFO - mozcrash == 1.0 14:32:56 INFO - mozdebug == 0.1 14:32:56 INFO - mozdevice == 0.49 14:32:56 INFO - mozfile == 1.2 14:32:56 INFO - mozhttpd == 0.7 14:32:56 INFO - mozinfo == 0.9 14:32:56 INFO - mozleak == 0.1 14:32:56 INFO - mozlog == 3.4 14:32:56 INFO - moznetwork == 0.27 14:32:56 INFO - mozprocess == 0.24 14:32:56 INFO - mozprofile == 0.28 14:32:56 INFO - mozrunner == 6.13 14:32:56 INFO - mozscreenshot == 0.1 14:32:56 INFO - mozsystemmonitor == 0.3 14:32:56 INFO - moztest == 0.8 14:32:56 INFO - mozversion == 1.4 14:32:56 INFO - psutil == 3.1.1 14:32:56 INFO - requests == 1.2.3 14:32:56 INFO - wsgiref == 0.1.2 14:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:56 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')]} 14:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:56 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')]} 14:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:56 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:56 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 14:32:56 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 14:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:56 INFO - 'HOME': '/Users/cltbld', 14:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:56 INFO - 'LOGNAME': 'cltbld', 14:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:56 INFO - 'MOZ_NO_REMOTE': '1', 14:32:56 INFO - 'NO_EM_RESTART': '1', 14:32:56 INFO - 'PAGER': '/bin/cat', 14:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:56 INFO - 'PWD': '/builds/slave/test', 14:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:56 INFO - 'SHELL': '/bin/bash', 14:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:56 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:56 INFO - 'USER': 'cltbld', 14:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:56 INFO - 'XPC_FLAGS': '0x0', 14:32:56 INFO - 'XPC_SERVICE_NAME': '0', 14:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 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)) 14:32:57 INFO - Cleaning up... 14:32:57 INFO - Return code: 0 14:32:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:57 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 0x10e338b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94b1570780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, '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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 14:32:57 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 14:32:57 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 14:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:57 INFO - 'HOME': '/Users/cltbld', 14:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:57 INFO - 'LOGNAME': 'cltbld', 14:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:57 INFO - 'MOZ_NO_REMOTE': '1', 14:32:57 INFO - 'NO_EM_RESTART': '1', 14:32:57 INFO - 'PAGER': '/bin/cat', 14:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:57 INFO - 'PWD': '/builds/slave/test', 14:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:57 INFO - 'SHELL': '/bin/bash', 14:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:32:57 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:57 INFO - 'USER': 'cltbld', 14:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:57 INFO - 'XPC_FLAGS': '0x0', 14:32:57 INFO - 'XPC_SERVICE_NAME': '0', 14:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:32:57 INFO - Cleaning up... 14:32:57 INFO - Return code: 0 14:32:57 INFO - Running post-action listener: _resource_record_post_action 14:32:57 INFO - Running post-action listener: _start_resource_monitoring 14:32:57 INFO - Starting resource monitoring. 14:32:57 INFO - [mozharness: 2017-01-16 22:32:57.432220Z] Finished create-virtualenv step (success) 14:32:57 INFO - [mozharness: 2017-01-16 22:32:57.433253Z] Running install step. 14:32:57 INFO - Running pre-action listener: _resource_record_pre_action 14:32:57 INFO - Running main action method: install 14:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:57 INFO - Reading from file tmpfile_stdout 14:32:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:57 INFO - Reading from file tmpfile_stdout 14:32:57 INFO - Output received: 14:32:57 INFO - Usage: mozinstall [options] installer 14:32:57 INFO - Options: 14:32:57 INFO - -h, --help show this help message and exit 14:32:57 INFO - -d DEST, --destination=DEST 14:32:57 INFO - Directory to install application into. [default: 14:32:57 INFO - "/builds/slave/test"] 14:32:57 INFO - --app=APP Application being installed. [default: firefox] 14:32:57 INFO - mkdir: /builds/slave/test/build/application 14:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:33:19 INFO - Reading from file tmpfile_stdout 14:33:19 INFO - Output received: 14:33:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:33:19 INFO - Running post-action listener: _resource_record_post_action 14:33:19 INFO - [mozharness: 2017-01-16 22:33:19.907932Z] Finished install step (success) 14:33:19 INFO - [mozharness: 2017-01-16 22:33:19.908054Z] Running run-tests step. 14:33:19 INFO - Running pre-action listener: _resource_record_pre_action 14:33:19 INFO - Running main action method: run_tests 14:33:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:33:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:33:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:33:19 INFO - 2017-01-16 14:33:19.922 screenresolution[1629:7483] starting screenresolution argv=screenresolution get 14:33:19 INFO - 2017-01-16 14:33:19.925 screenresolution[1629:7483] Display 0: 1600x1200x32@60 14:33:19 INFO - 2017-01-16 14:33:19.930 screenresolution[1630:7485] starting screenresolution argv=screenresolution list 14:33:19 INFO - Available Modes on Display 0 14:33:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:33:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:33:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:33:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:33:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:33:20 INFO - Intel Iris: 14:33:20 INFO - Chipset Model: Intel Iris 14:33:20 INFO - Type: GPU 14:33:20 INFO - Bus: Built-In 14:33:20 INFO - VRAM (Dynamic, Max): 1536 MB 14:33:20 INFO - Vendor: Intel (0x8086) 14:33:20 INFO - Device ID: 0x0a2e 14:33:20 INFO - Revision ID: 0x0009 14:33:20 INFO - Displays: 14:33:20 INFO - Display: 14:33:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:33:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:33:20 INFO - Display Serial Number: 1600x1200 60 14:33:20 INFO - Main Display: Yes 14:33:20 INFO - Mirror: Off 14:33:20 INFO - Online: Yes 14:33:20 INFO - Rotation: Supported 14:33:20 INFO - Return code: 0 14:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:20 INFO - Python 2.7.3 14:33:20 INFO - Return code: 0 14:33:20 INFO - grabbing minidump binary from tooltool 14:33:20 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')]} 14:33:20 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 0x10e116d30>, '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 0x10e03ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:20 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 14:33:20 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 14:33:20 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 14:33:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:20 INFO - Return code: 0 14:33:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:33:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:33:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:20 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/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 14:33:20 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/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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 14:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qfwqsBjKCM/Render', 14:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:20 INFO - 'HOME': '/Users/cltbld', 14:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:20 INFO - 'LOGNAME': 'cltbld', 14:33:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:20 INFO - 'MOZ_NO_REMOTE': '1', 14:33:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:20 INFO - 'NO_EM_RESTART': '1', 14:33:20 INFO - 'PAGER': '/bin/cat', 14:33:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:20 INFO - 'PWD': '/builds/slave/test', 14:33:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:20 INFO - 'SHELL': '/bin/bash', 14:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AxnLpT7Jbh/Listeners', 14:33:20 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 14:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:20 INFO - 'USER': 'cltbld', 14:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:20 INFO - 'XPC_FLAGS': '0x0', 14:33:20 INFO - 'XPC_SERVICE_NAME': '0', 14:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:20 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/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 14:33:20 INFO - mozversion application_buildid: 20170116131921 14:33:20 INFO - mozversion application_changeset: 88030580b14bb253a55bc174c987a9fa43c3fb55 14:33:20 INFO - mozversion application_display_name: Nightly 14:33:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:20 INFO - mozversion application_name: Firefox 14:33:20 INFO - mozversion application_remotingname: firefox 14:33:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:33:20 INFO - mozversion application_vendor: Mozilla 14:33:20 INFO - mozversion application_version: 53.0a1 14:33:20 INFO - mozversion platform_buildid: 20170116131921 14:33:20 INFO - mozversion platform_changeset: 88030580b14bb253a55bc174c987a9fa43c3fb55 14:33:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:33:20 INFO - mozversion platform_version: 53.0a1 14:33:20 INFO - using testdate: 1484606000 14:33:20 INFO - actual date: 1484606000 14:33:20 INFO - starting webserver on 'localhost:49236' 14:33:20 INFO - SUITE-START | Running 2 tests 14:33:20 INFO - TEST-START | dromaeo_css 14:33:20 INFO - operating with platform_type : mac_ 14:33:20 INFO - Initialising browser for dromaeo_css test... 14:33:20 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpkSIUd7/profile http://localhost:49236/getInfo.html) 14:33:22 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 14:33:22 INFO - PROCESS | 1640 | colorDepth:24 14:33:22 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 14:33:22 INFO - PROCESS | 1640 | __metrics 14:33:22 INFO - PROCESS | 1640 | 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" 14:33:22 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:33:23 INFO - TEST-INFO | 1640: exit 0 14:33:23 INFO - Browser initialized. 14:33:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:23 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpkSIUd7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:35 INFO - PROCESS | 1642 | RSS: Main: 227049472 14:33:35 INFO - PROCESS | 1642 | 14:36:39 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 14:36:40 INFO - PROCESS | 1642 | RSS: Main: 364306432 14:36:40 INFO - PROCESS | 1642 | 14:38:25 INFO - PROCESS | 1642 | ************************* 14:38:25 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 14:38:25 INFO - PROCESS | 1642 | 14:38:25 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:38:25 INFO - PROCESS | 1642 | Full stack: 14:38:25 INFO - PROCESS | 1642 | ************************* 14:39:43 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 14:39:44 INFO - PROCESS | 1642 | RSS: Main: 378241024 14:39:44 INFO - PROCESS | 1642 | 14:42:46 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 14:42:47 INFO - PROCESS | 1642 | RSS: Main: 363139072 14:42:47 INFO - PROCESS | 1642 | 14:45:49 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 14:45:50 INFO - PROCESS | 1642 | RSS: Main: 339410944 14:45:50 INFO - PROCESS | 1642 | 14:48:53 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 14:48:54 INFO - PROCESS | 1642 | RSS: Main: 328282112 14:48:54 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 14:51:57 INFO - PROCESS | 1642 | RSS: Main: 455798784 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | __start_tp_report 14:51:57 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 14:51:57 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 14:51:57 INFO - PROCESS | 1642 | |i|pagename|runs| 14:51:57 INFO - PROCESS | 1642 | |0;dojo.html;3264.8530816113275;3307.6361600223986;3313.5858017747787;3332.0503656457913;3377.4933759936007;5567.9977604031255;5610.607257491977;5648.576356773238;5648.604597678164;5662.34882988456;5640.238567793347;5696.202531645573;5697.77208911643;5776.566757493194;5797.043487824504;5127.743612819344;5149.562287205574;5192.844214673566;5243.6853788772605;5275.762590683409;5290.232916227144;5321.574274058085;5322.361316641989;5343.519083282504;5384.5692344612335;5114.693118412907;5130.410002849682;5288.206768984644;5306.4958828911385;5307.442718514578;5125.077486052509;5188.92216616751;5193.350831146106;5258.894822103536;5319.3616765987945;5202.635815492917;5205.453427390107;5207.9479205207845;5223.11207094791;5226.398964119099;5760.913586296209;5778.942210577925;5783.334916484616;5797.420257974211;5803.651780893118;6151.83115208109;6192;6202.131701561785;6265.498760099181;6268.937310626881;6264.154339164245;6306.936930630681;6321.273053598849;6349.4602958748565;6353.6823158842335;5917.822465326047;5938.168656388109;5944.4352786485215;5955.047192449188;5991.400859913973;6158.7228574714245;6225.097360882737;6243.157173781481;6314.905276420857;6338.714757835908;6128.80869161996;6253.093301471261;6261.812145635638;6278.0269058296035;6279.686015699288;6182.072689096672;6330.841728956813;6334.3032266450655;6334.398232167937;6346.30190679025;6161.938380616226;6170.167027451236;6172.197614310111;6236.781712640127;6243.406876346739;6312.210973628296;6316.242050953915;6324.209473815773;6334.936650633527;6336.429721325011;5007.924881126786;5037.874053148627;5053.292539044537;5058.317127187783;5089.312942752681;4390.253656878274;4426.84506042287;4429.357743127229;4432.867013989586;4533.252013417815;5786.768529258782;5819.272590926134;5883.499902508249;5886.293644762656;5895.20414744004;6239.483876106349;6304.495640348761;6311.431971122621;6316.399942005502;6331.3352098029045;5636.4927156556105;5828.329742079715;5841.240638716939;5848.707564621752;5859.355470898197;5435.10320797064;5437.34751829783;5459.945400545944;5495.807646732345;5496.340439147328;6252.812415627538;6264.812055638338;6266.937330626818;6270.996640537492;6309.873802523924;5269.762860671202;6231.40801623845;6275.6548389839;6293;6328.651924144032;6305.432511074026;6350.650714210763;6366.331535188739;6381.968090159519;6455.419012288917;6264.373562643881;6280.591761535486;6285.340039295991;6290.716917738621;6296.590721603081;6151.169592105009;6159.414855588712;6186.041163619646;6210.037444196157;6216.875662486635;6078.666859355449;6156.045812899008;6160.7535698571555;6162.784302549389;6164.260288765377;6130.314163605044;6148.231471066117;6153.323134455117;6155.630662160284;6160.969195153995;5831.591788574759;5859.091840764689;5882.352941176553;5985.311689155628;6018.488428483628;6190.473809726043;6194.38056194377;6217.098520714561;6221.004639257697;6228.719707613078;6044.214252147192;6046.667433291212;6069.393060693896;6071.1067297973295;6128.479079278133 14:51:57 INFO - PROCESS | 1642 | |1;ext.html;473.8696858363949;490.64428289490104;490.75952783136273;504.60892808073737;513.5916946027909;31366.52950205749;39476.2104757905;41890.790546047305;42022.57977420225;44028.01873915674;43596;43969.7801510992;43999;44089.77955110228;44148;8190;9330.346875718702;9518.666846660368;9547.42715437076;9560.330776845623;8423.578821058953;8626.611802468904;11166.497507612177;11229.382383968878;11524.308541487495;10049;11492.195546311761;11498.25261358009;11501.367424791633;11530.711732206679;8435;11404.828927566094;11460.140489463323;11475.081993440546;11492.080633549296;7333.120025596909;9628.518574071339;10822.026017658449;11126.554937802559;11603.593874214363;34583.827080864685;41566.37650435246;41992.79003604963;42052.158956821;42117.57882421167;4023.537293211289;4061.2689715851134;4061.97969010156;4082.7754473503946;4115.053537686319;30689;31275.061748147593;31583.684163158305;31644.841775791203;31805.40972951343;3189.8245596492184;3237.7247933925646;3243.0919342584116;3310.470324748053;3375.3924293627138;504070;504272;504759;505037;505502;63929.68035159887;64257.35742642514;64264.35735642677;64293.35706642967;64417.35582644113;62197;62289;62296.754064918445;62355;62547;15861.52415427539;16355.509334719978;16372.181390930644;16381;16450.34198632065;11270.774584508265;11562.248453850472;12472.937635311766;12522.686932826753;12533.561325353568;18394.172262247965;18724.438266852016;18771.436856894314;18794.624107518048;18976.956267405425;6969.372756451944;7011.509194356346;7068.717251309993;7073.434125269966;7122.501424900207;869.9430192316366;878.5695009445453;879.3712495565701;886.1315910407836;908.9363744537819;24744;29834.55248171279;29961.70038299633;30253.243668908453;31207.84396078005;1020.6019652335596;1022.2588623248085;1055.482813421418;1058.7988282226352;1069.2675517270695;14426.855731442762;14806.629834254014;14831.40674373013;14880.181590012653;14990.625234369229;539813;540913;544652;545190;546352;52080.21879671808;52170.21744673833;52299;52428.21357679638;52472.73763631234;1376.9311534423239;1397.4061024064936;1407.1768015710516;1413.964650883736;1440.5606290081626;23685.28944131679;26936.191914242605;27576.724232757417;28246.43507129887;28255.43489130247;41172.588274116875;47021.76489117533;47141.764291178326;47165.7641711803;47192.7640361796;480111;480577;483388;483736;484748;22363.88818055899;22914;24696.13563525268;24841.50316993614;25229;41539.37690934699;41937;43028.78485607552;43231.78384108059;43497.34753978756;26496.8675156623;34074.829625851715;34306.79926202571;35822.46266305955;36404.81797590995;34254.657453426145;35451;36412.27175456423;37368.62631373652;38810.8356749298;35536;35759.82120089383;36108.27783444369;36117.458238125924;36208;26276;28834.855825720737;30391;32576.674233257363;32970.67029329772;22066.44833879166;23802.880985594962;23849.64225536653;24294.51410971806;24335.26994190177 14:51:57 INFO - PROCESS | 1642 | |2;jquery.html;374.251497005988;390.5898806253433;392.9332013557695;394.3906664203805;413.4728221517565;14905.403783848647;14910.5526834195;18932.958687272196;20719.274825381115;20721.896390518028;18831.905840470812;20734.548581599294;21808;22053.33839984799;22421.43946401341;1646.497818165459;1647.983520164801;1649.3979697410418;1651.743979683151;1858.2381223698287;5870.794522191724;6040.214772079624;6056.727447264861;6105.236845394325;6114.113453549255;5948.256467941507;6067.423594758513;6071.332153463116;6080.543959203077;6080.878382432371;5744.655320680752;5945.791897283596;6033.818985430444;6034.39656034393;6034.607750496204;5280;5282.947170528284;5300.602454815866;5306.973465132688;5327.786888524454;12931.48274069036;13172.275524846129;13370.791010157589;13374.665633359244;13613.455461781517;2543.758342957416;2554.2081954594137;2610.5040042392075;2615.437680898616;2659.906903258396;9815;9874.90125098747;9993.500324983721;10349.016843399864;10351.689449316533;1733.306677329066;1791.3640657566507;1795.0845069014765;1808.1863161577212;1828.3509354179207;118448.58306043052;124921.9999999991;125344.37327813393;127413;128980;11510.251833630788;11524.539018439336;11644.825327619923;11664.125190610737;11868.169228153947;15157.317920693595;15192.316345764468;15205.783537316987;15242.314095865713;15273.083614983136;8461.95769021151;8615.870761938577;8642.265407440313;8710.21608055278;8728.825423491495;8457.619407126695;8460.957695211608;8463.449875758179;8605.096464871098;8638.74083777475;3789.3368660484857;4559.680822342404;4572.839950601713;4607.769611519478;4661.743604101807;1955.1983686688675;1999.7100420438956;2003.869748466345;2004.2884775904636;2005.8796472211714;837.4305472278787;987.7283746969497;995.2237254941158;1000.3547711726042;1042.4475028235047;19707.40877773669;20723.27468538594;21529.78470215309;21569.352919412442;21764.782352176277;990.4750482244422;1035.1253191053547;1035.3632516002754;1078.358376765823;1084.734240111162;8363.58182090893;10885.401302928414;11096.699812653133;11141.053010494199;11157.995780379804;673340;685274;725514;736446;744485;151639;152997;153639.23180384026;155122;155768.2211588935;967.7000129959735;984.4929861121528;1006.6577363696379;1008.3143462445607;1010.9443980580992;14802.703945921237;17861;18794.624107518048;18869.811301887356;19223.423297301102;59450.405495944484;62740.68629656822;63949;63975.360246396944;64154.67922660357;84480.57759711162;85972;87068;87973.56013219892;88272.11234686409;8235.50586964784;8372.451096547158;8577.828443430972;8724.69463568772;8746.69386571467;10835.891641083488;13177.670558236121;13667.589972300846;13787;13799.586012419644;11178.20544863784;11328.830067549157;11377.601783937522;11468.770624587294;11792.646220613395;10382.636607718694;11452.312861228353;11606.129540284344;11792.866831564847;11806.468708907947;9020.684276050306;9381.812363752822;11136.276142050741;11634.883651163718;12080.456379463121;7019.4033507150425;7625.23747625233;8486.957565212135;8524.488530688179;8778.736637900873;8489.40574159803;11280.548778048786;11718.941405292919;11778;12005.279683219034 14:51:57 INFO - PROCESS | 1642 | |3;mootools.html;1349.925754083525;1451.8257809062914;1468.610818133195;1472.5729538433854;1482.7775833624958;6498.447631951284;7846.8038299042555;8130.186981301867;8343.998720153575;8447.986241651011;8260.91739082609;8340.624671889764;8347.791305217372;8369.037560680523;8376.204260595248;2277.840551161419;2321.651752237161;2323.76762323768;2326.8022218111482;2330.8951097200584;1932.4492519631838;2075.9065842037144;2151.0857885398723;2351.7413084560685;2364.775346342103;2321.419645088728;2321.5589038082794;2328.941776455585;2329.406001469623;2335.252719129879;2283.908643654252;2318.431984163874;2319.7216334039854;2323.8605683659034;2326.7091613548305;2299.2297580310615;2322.9651555226687;2329.871857047862;2338.5556744218543;2340.9816729722625;8402.327813774884;8463.534505602189;8467.068622451525;8481.067082620906;8490.448120872185;5036.722980236085;5201.1678131498775;5205.635605507616;5208.401033881114;5221.39953905302;3321.7342612590933;3468.5664291963503;3496.4755286707195;3535.1515636247373;3538.8761393351365;1160.669209275361;1215.890569848709;1218.5795900414344;1257.9621812005041;1260.023481801602;8969.506677132755;10712.946435267773;10717.46412679363;10770.246082774287;10775.353478791298;4413.073254616503;4615.930761038587;4663.860084197479;4677.316166180172;4681.461631912373;9472.242220622335;9477.810443791086;9479.857802132974;9490.430574165572;9491.240700743923;5216.139337009351;5223.059849227099;5228.346456692913;5230.529252367305;5231.189165679326;3771.8868433947027;3880.9029774255305;4680.251159814414;4752.215884379108;4810.855674329706;3761.774293542396;3781.640744129303;3818.4463252828186;3844.3272427325105;3848.7690738555775;1259.439549400508;1265.3862876504888;1267.3029833591672;1276.44474653526;1281.2824818101892;789.2541548236861;835.3400813357501;891.7636826241052;901.0989010989011;928.2202949522433;5277.577793776489;5362.758675859518;5579.776808927679;5708.914366284509;5724.942750572441;890.670451932789;976.7948730766618;977.7408986618552;1008.2337423558149;1008.641932114089;3562.2697347043795;3706.9258614827554;3790.8673196437994;3818.6372294631965;3848.615138486129;8316.916830831735;9438.90561094394;9729.221662267002;9765.609375625038;9891.60433582663;9735.513224338754;9803.460809655537;9900.059494348025;10018.499075046364;10072.546735396925;7684.654190561439;7990.121086680577;7994.200579941959;8002.559859207683;8007.119216886138;5635.224904155178;5665.631733937281;5781.248437703071;5840.678762667924;5892.7642894283745;9188.173064424234;9330.393524420891;9349.906500935176;9356.251499880129;9361.672341468016;8938.821223575362;9336.906630933603;9351.719448416286;9413.435193888388;9485.33602647808;6614.503912206507;6800.115984921928;6813.386795188457;6895.862082758417;6915.585064896122;6524.217093948757;7522.5862577558755;7596.354309883722;7630.389568834369;7809.609519523888;7086.362227399559;7187.353138217585;7195.352418282379;7257.637118143966;7351.485396022227;6945.895811562932;7010.789676309719;7025.297470252934;7208.56748595086;7218.061651985208;6244.438000579969;6386.137871387304;6392.456641185551;6399.488040956805;6403.199600049994;4876.29293752411;4928.926066109083;4994.825181118788;5020.924686129638;5036.748162591929;3984.2629113612916;4916.803327866845;4985.252212168204;5037.294778730908;5048.646594738333 14:51:57 INFO - PROCESS | 1642 | |4;prototype.html;315.27801334942984;355.35503061942575;362.1652091928106;365.25305749741784;376.5274580401594;5031.345925029746;5188.688678679282;5512.39363669996;5530.087535556639;5544.334679838415;4499.482559505658;4691.765411729409;5231.633785635007;5261.710605916673;5454.545454545455;3559.75081744278;4148.97925510372;4190.72760270583;4190.769507677084;4194.182134483777;3749.9250014999684;3985.2627263956115;4167.9583204167875;4171.706770901015;4184.937225941613;4047.8583249586272;4139.668826493888;4149.3775933609895;4151.688623353246;4156.210320039183;3196.536502207167;3629.3467175908327;3901.4928059352246;4056.5132184137797;4059.9594004060023;2912.956305655417;3087.8764849405998;3389.813560254185;3404.9740404459553;3659.8288547664756;4721.315409265637;4745.050989802019;4899.534544218293;5184.351956005499;5207.791688332462;3888.922221555553;4585.564371384747;4653.464851542082;4843.98974425613;4882.218844984821;5679.233303504016;5679.2455659005345;5701.372848986608;5708.286464191976;5715.342735585377;3730.8694195703292;4093.774842383668;4102.692298077656;4111.8972025699295;4116.650084742801;5024.64478123705;5774.335951365562;5849.327327357366;5938.524918006549;5945.286565612154;3523.559555055618;3753.230587729509;3955.5055618047745;4182.832686692498;4187.602177793105;3616.1863580694135;3962.841486340572;4222.577742225814;4271.636910862611;4320.395144679747;4294;4368.5194628590825;4663.370444989951;4670.719756814602;4906.215005599087;5702.7433765480655;5712.6286791358425;5720.914186287209;5721.742521586539;5724.685142317129;1259.8992080633527;1288.9677758055936;1289.2973329535425;1291.6964513339358;1302.667819705969;747.5701471653821;785.2971590426537;825;841.5413599588239;852.884860543831;4486.842960496432;4603.976980115078;5003.899922001539;5038.647294689336;5041;5021.84934451967;5111.284420181178;5176.9741151294;5205.932783779316;5622;4151.917548354278;4346.913061738747;4385.429894113809;4507.954920450819;5034.270030845507;2664.5603475426724;2884.79806413549;2901.158663987462;2902.3759891623404;2909.9524171298317;4933.925991110136;5730.85382923417;5739.7812607733285;5741.483266506035;5754.769809207585;4954;5590.217369568264;5875.529957603467;6010.819675409744;6030.889188783891;6048;6059.727891836244;6072.605280656743;6085.6348619083;6115.388461153938;5516.696581687886;5824.563157763269;5857.970710146422;5890.7054647266605;5902.468777810018;4915.361003069578;4925.679830810986;5784.797532086357;5795.5073818724195;5813.9534883721335;5428.402875683592;5612.579056570855;6037.49443980743;6078.7264573093435;6117.908231376444;3728.925421491609;4015.4980627421573;4017.7589344639414;4255.531891491995;4303.763293018914;4727.432708075053;5193.4027586828;5354.651947623392;5361.061814182424;5670.631408958405;5074.594032477319;5343.419908661129;5668.37647858727;5752.511036561939;5757.971210143923;5222.817201397933;5421.810236641699;5653.745581448927;5658.717064146858;5691.544676425959;4811.989482208635;5530.7511161997;5547.722613869371;5550.722463876871;5561.304836895388;4499.572540608637;4883.487233840396;4900.607951363953;4969.211084009826;5723.6851973141875;5550.27846379968;5551.307615806411;5569.860753481195;5580.246666700106;5589.496945274945 14:51:57 INFO - PROCESS | 1642 | |5;yui.html;720.5352547606793;727.0983979864969;774.4114473000521;816.612109248107;817.5340056167985;14810.92594537027;15751;15774.290156942936;15787.052776833383;15795.84204157958;14571.052881562691;14673.413063477448;14686.971911966166;14696.485623003196;14713.264336783144;689.8068540808582;705.8411857332111;709.5104377979204;725.1696807155804;861.0571424290407;706.7985624097133;714.1323292199976;849.235687880909;867.2628265973904;868.9789497340631;945.0360632155198;946.186279799372;956.1681337236614;957.2437774158407;961.0773657289011;948.1419315519466;949.9740280497047;951.4909523404945;952.1430712358863;958.0180315176895;550.411060165623;560.073079054166;710.1939298895738;714.3071220915704;715.1882613234017;13177.879880210194;13895.513657022057;14363.56909292723;15268;15306.617334566614;14378.568642940729;14405.927970360186;14515.419383224658;14532.636684082876;14539.563813085624;11805;11866.584669536525;11944.044476441864;11991;12149.817752733716;3631.564212294515;3692.7415080944343;3816.9809150954347;3876.8061596920325;3877.418387241936;103074.48462757713;105105;108187.45906270418;108780;109481.45259273653;10528.894466080952;10781.514831832586;11316.660500185008;11359;11419.942900285612;19256.903715481334;23135.305940821803;23187.536249275257;23188.884055579612;23231.186908458123;7766.728164514328;7768.611569421506;7812.375009999187;7817.8827317590285;7928.5639289838455;4168.353905144708;4243.108947121077;4289.785510724451;4413.536578659258;4445.622122119656;3539.663731945461;3639.526861507987;3640.4175331946763;3648.1426864686778;3648.325059863934;656.176498494396;663.6151032401195;667.2326824152167;682.3517658224706;690.0649619765246;659.7657831469855;680.5474359550843;695.7947405515386;701.6526819224516;717.5085066729307;9058.728238152866;9891.901080989099;10997.670069897917;11161.497732602053;11471.98291913894;553.1371061144547;577.125654633231;604.4439116013278;646.2923099206362;709.8757717399434;4500.347449619787;4900.8774780630765;4900.901981960341;4907.87730306738;4912.238603016538;87707.68438473428;89005.55497222472;92924.53537732403;93542;97193;78141.60929195432;82383.17616823874;84577;86301.56849215714;86569.5671521651;75494.24505755091;76289.61855190688;77430.28993985296;77700.83448748273;78938;9762.707118786448;9860.06329398706;9873.25950553697;9875.407475551203;9882.604695812088;32308.515372269903;48485.545433637046;49247.75376123097;49459;50091.248631271286;64071;64328;64447.67776161089;65279.673601631686;67611;11673.357965311989;11738.119641026786;11800.291982481078;11876.524939002344;12008.579699710468;12713.17364371313;12788.17049570791;12791.104622676323;12954.67613309637;13107.934460327637;10887.727806804893;11903.226290291102;11952.223105498115;12111.75776484483;12268.815967760313;10119.342242754197;11963.700907477383;12125.090618203847;12381.566645167375;12647.936760316139;12032.04718993244;12040.337781422106;12067.75864482723;12375.504979800708;12430.81353779676;9842.557084931052;9953.303268771117;10080.546375412978;10114.797704046025;10610.363378197333;9497.382670126419;9582.616695332108;9610.423374597547;9611.375260608038;9636.614535418785 14:51:57 INFO - PROCESS | 1642 | __end_tp_report 14:51:57 INFO - PROCESS | 1642 | __start_cc_report 14:51:57 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1241 14:51:57 INFO - PROCESS | 1642 | __end_cc_report 14:51:57 INFO - PROCESS | 1642 | __startTimestamp1484607117962__endTimestamp 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | ------- Summary: start ------- 14:51:57 INFO - PROCESS | 1642 | Number of tests: 6 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5789.42 Median:6046.67 stddev:649.61 (10.7%) stddev-sans-first:620.68 14:51:57 INFO - PROCESS | 1642 | Values: 3264.9 3307.6 3313.6 3332.1 3377.5 5568.0 5610.6 5648.6 5648.6 5662.3 5640.2 5696.2 5697.8 5776.6 5797.0 5127.7 5149.6 5192.8 5243.7 5275.8 5290.2 5321.6 5322.4 5343.5 5384.6 5114.7 5130.4 5288.2 5306.5 5307.4 5125.1 5188.9 5193.4 5258.9 5319.4 5202.6 5205.5 5207.9 5223.1 5226.4 5760.9 5778.9 5783.3 5797.4 5803.7 6151.8 6192.0 6202.1 6265.5 6268.9 6264.2 6306.9 6321.3 6349.5 6353.7 5917.8 5938.2 5944.4 5955.0 5991.4 6158.7 6225.1 6243.2 6314.9 6338.7 6128.8 6253.1 6261.8 6278.0 6279.7 6182.1 6330.8 6334.3 6334.4 6346.3 6161.9 6170.2 6172.2 6236.8 6243.4 6312.2 6316.2 6324.2 6334.9 6336.4 5007.9 5037.9 5053.3 5058.3 5089.3 4390.3 4426.8 4429.4 4432.9 4533.3 5786.8 5819.3 5883.5 5886.3 5895.2 6239.5 6304.5 6311.4 6316.4 6331.3 5636.5 5828.3 5841.2 5848.7 5859.4 5435.1 5437.3 5459.9 5495.8 5496.3 6252.8 6264.8 6266.9 6271.0 6309.9 5269.8 6231.4 6275.7 6293.0 6328.7 6305.4 6350.7 6366.3 6382.0 6455.4 6264.4 6280.6 6285.3 6290.7 6296.6 6151.2 6159.4 6186.0 6210.0 6216.9 6078.7 6156.0 6160.8 6162.8 6164.3 6130.3 6148.2 6153.3 6155.6 6161.0 5831.6 5859.1 5882.4 5985.3 6018.5 6190.5 6194.4 6217.1 6221.0 6228.7 6044.2 6046.7 6069.4 6071.1 6128.5 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:64588.75 Median:36112.87 stddev:136036.25 (376.7%) stddev-sans-first:136332.70 14:51:57 INFO - PROCESS | 1642 | Values: 473.9 490.6 490.8 504.6 513.6 31366.5 39476.2 41890.8 42022.6 44028.0 43596.0 43969.8 43999.0 44089.8 44148.0 8190.0 9330.3 9518.7 9547.4 9560.3 8423.6 8626.6 11166.5 11229.4 11524.3 10049.0 11492.2 11498.3 11501.4 11530.7 8435.0 11404.8 11460.1 11475.1 11492.1 7333.1 9628.5 10822.0 11126.6 11603.6 34583.8 41566.4 41992.8 42052.2 42117.6 4023.5 4061.3 4062.0 4082.8 4115.1 30689.0 31275.1 31583.7 31644.8 31805.4 3189.8 3237.7 3243.1 3310.5 3375.4 504070.0 504272.0 504759.0 505037.0 505502.0 63929.7 64257.4 64264.4 64293.4 64417.4 62197.0 62289.0 62296.8 62355.0 62547.0 15861.5 16355.5 16372.2 16381.0 16450.3 11270.8 11562.2 12472.9 12522.7 12533.6 18394.2 18724.4 18771.4 18794.6 18977.0 6969.4 7011.5 7068.7 7073.4 7122.5 869.9 878.6 879.4 886.1 908.9 24744.0 29834.6 29961.7 30253.2 31207.8 1020.6 1022.3 1055.5 1058.8 1069.3 14426.9 14806.6 14831.4 14880.2 14990.6 539813.0 540913.0 544652.0 545190.0 546352.0 52080.2 52170.2 52299.0 52428.2 52472.7 1376.9 1397.4 1407.2 1414.0 1440.6 23685.3 26936.2 27576.7 28246.4 28255.4 41172.6 47021.8 47141.8 47165.8 47192.8 480111.0 480577.0 483388.0 483736.0 484748.0 22363.9 22914.0 24696.1 24841.5 25229.0 41539.4 41937.0 43028.8 43231.8 43497.3 26496.9 34074.8 34306.8 35822.5 36404.8 34254.7 35451.0 36412.3 37368.6 38810.8 35536.0 35759.8 36108.3 36117.5 36208.0 26276.0 28834.9 30391.0 32576.7 32970.7 22066.4 23802.9 23849.6 24294.5 24335.3 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:39195.55 Median:21132.17 stddev:119135.64 (563.8%) stddev-sans-first:119434.18 14:51:57 INFO - PROCESS | 1642 | Values: 374.3 390.6 392.9 394.4 413.5 14905.4 14910.6 18933.0 20719.3 20721.9 18831.9 20734.5 21808.0 22053.3 22421.4 1646.5 1648.0 1649.4 1651.7 1858.2 5870.8 6040.2 6056.7 6105.2 6114.1 5948.3 6067.4 6071.3 6080.5 6080.9 5744.7 5945.8 6033.8 6034.4 6034.6 5280.0 5282.9 5300.6 5307.0 5327.8 12931.5 13172.3 13370.8 13374.7 13613.5 2543.8 2554.2 2610.5 2615.4 2659.9 9815.0 9874.9 9993.5 10349.0 10351.7 1733.3 1791.4 1795.1 1808.2 1828.4 118448.6 124922.0 125344.4 127413.0 128980.0 11510.3 11524.5 11644.8 11664.1 11868.2 15157.3 15192.3 15205.8 15242.3 15273.1 8462.0 8615.9 8642.3 8710.2 8728.8 8457.6 8461.0 8463.4 8605.1 8638.7 3789.3 4559.7 4572.8 4607.8 4661.7 1955.2 1999.7 2003.9 2004.3 2005.9 837.4 987.7 995.2 1000.4 1042.4 19707.4 20723.3 21529.8 21569.4 21764.8 990.5 1035.1 1035.4 1078.4 1084.7 8363.6 10885.4 11096.7 11141.1 11158.0 673340.0 685274.0 725514.0 736446.0 744485.0 151639.0 152997.0 153639.2 155122.0 155768.2 967.7 984.5 1006.7 1008.3 1010.9 14802.7 17861.0 18794.6 18869.8 19223.4 59450.4 62740.7 63949.0 63975.4 64154.7 84480.6 85972.0 87068.0 87973.6 88272.1 8235.5 8372.5 8577.8 8724.7 8746.7 10835.9 13177.7 13667.6 13787.0 13799.6 11178.2 11328.8 11377.6 11468.8 11792.6 10382.6 11452.3 11606.1 11792.9 11806.5 9020.7 9381.8 11136.3 11634.9 12080.5 7019.4 7625.2 8487.0 8524.5 8778.7 8489.4 11280.5 11718.9 11778.0 12005.3 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5389.50 Median:5229.44 stddev:2916.00 (55.8%) stddev-sans-first:2908.37 14:51:57 INFO - PROCESS | 1642 | Values: 1349.9 1451.8 1468.6 1472.6 1482.8 6498.4 7846.8 8130.2 8344.0 8448.0 8260.9 8340.6 8347.8 8369.0 8376.2 2277.8 2321.7 2323.8 2326.8 2330.9 1932.4 2075.9 2151.1 2351.7 2364.8 2321.4 2321.6 2328.9 2329.4 2335.3 2283.9 2318.4 2319.7 2323.9 2326.7 2299.2 2323.0 2329.9 2338.6 2341.0 8402.3 8463.5 8467.1 8481.1 8490.4 5036.7 5201.2 5205.6 5208.4 5221.4 3321.7 3468.6 3496.5 3535.2 3538.9 1160.7 1215.9 1218.6 1258.0 1260.0 8969.5 10712.9 10717.5 10770.2 10775.4 4413.1 4615.9 4663.9 4677.3 4681.5 9472.2 9477.8 9479.9 9490.4 9491.2 5216.1 5223.1 5228.3 5230.5 5231.2 3771.9 3880.9 4680.3 4752.2 4810.9 3761.8 3781.6 3818.4 3844.3 3848.8 1259.4 1265.4 1267.3 1276.4 1281.3 789.3 835.3 891.8 901.1 928.2 5277.6 5362.8 5579.8 5708.9 5724.9 890.7 976.8 977.7 1008.2 1008.6 3562.3 3706.9 3790.9 3818.6 3848.6 8316.9 9438.9 9729.2 9765.6 9891.6 9735.5 9803.5 9900.1 10018.5 10072.5 7684.7 7990.1 7994.2 8002.6 8007.1 5635.2 5665.6 5781.2 5840.7 5892.8 9188.2 9330.4 9349.9 9356.3 9361.7 8938.8 9336.9 9351.7 9413.4 9485.3 6614.5 6800.1 6813.4 6895.9 6915.6 6524.2 7522.6 7596.4 7630.4 7809.6 7086.4 7187.4 7195.4 7257.6 7351.5 6945.9 7010.8 7025.3 7208.6 7218.1 6244.4 6386.1 6392.5 6399.5 6403.2 4876.3 4928.9 4994.8 5020.9 5036.7 3984.3 4916.8 4985.3 5037.3 5048.6 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4543.90 Median:4986.56 stddev:1398.50 (28.0%) stddev-sans-first:1365.93 14:51:57 INFO - PROCESS | 1642 | Values: 315.3 355.4 362.2 365.3 376.5 5031.3 5188.7 5512.4 5530.1 5544.3 4499.5 4691.8 5231.6 5261.7 5454.5 3559.8 4149.0 4190.7 4190.8 4194.2 3749.9 3985.3 4168.0 4171.7 4184.9 4047.9 4139.7 4149.4 4151.7 4156.2 3196.5 3629.3 3901.5 4056.5 4060.0 2913.0 3087.9 3389.8 3405.0 3659.8 4721.3 4745.1 4899.5 5184.4 5207.8 3888.9 4585.6 4653.5 4844.0 4882.2 5679.2 5679.2 5701.4 5708.3 5715.3 3730.9 4093.8 4102.7 4111.9 4116.7 5024.6 5774.3 5849.3 5938.5 5945.3 3523.6 3753.2 3955.5 4182.8 4187.6 3616.2 3962.8 4222.6 4271.6 4320.4 4294.0 4368.5 4663.4 4670.7 4906.2 5702.7 5712.6 5720.9 5721.7 5724.7 1259.9 1289.0 1289.3 1291.7 1302.7 747.6 785.3 825.0 841.5 852.9 4486.8 4604.0 5003.9 5038.6 5041.0 5021.8 5111.3 5177.0 5205.9 5622.0 4151.9 4346.9 4385.4 4508.0 5034.3 2664.6 2884.8 2901.2 2902.4 2910.0 4933.9 5730.9 5739.8 5741.5 5754.8 4954.0 5590.2 5875.5 6010.8 6030.9 6048.0 6059.7 6072.6 6085.6 6115.4 5516.7 5824.6 5858.0 5890.7 5902.5 4915.4 4925.7 5784.8 5795.5 5814.0 5428.4 5612.6 6037.5 6078.7 6117.9 3728.9 4015.5 4017.8 4255.5 4303.8 4727.4 5193.4 5354.7 5361.1 5670.6 5074.6 5343.4 5668.4 5752.5 5758.0 5222.8 5421.8 5653.7 5658.7 5691.5 4812.0 5530.8 5547.7 5550.7 5561.3 4499.6 4883.5 4900.6 4969.2 5723.7 5550.3 5551.3 5569.9 5580.2 5589.5 14:51:57 INFO - PROCESS | 1642 | 14:51:57 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19645.12 Median:4904.39 stddev:28120.76 (573.4%) stddev-sans-first:28163.75 14:51:57 INFO - PROCESS | 1642 | Values: 720.5 727.1 774.4 816.6 817.5 14810.9 15751.0 15774.3 15787.1 15795.8 14571.1 14673.4 14687.0 14696.5 14713.3 689.8 705.8 709.5 725.2 861.1 706.8 714.1 849.2 867.3 869.0 945.0 946.2 956.2 957.2 961.1 948.1 950.0 951.5 952.1 958.0 550.4 560.1 710.2 714.3 715.2 13177.9 13895.5 14363.6 15268.0 15306.6 14378.6 14405.9 14515.4 14532.6 14539.6 11805.0 11866.6 11944.0 11991.0 12149.8 3631.6 3692.7 3817.0 3876.8 3877.4 103074.5 105105.0 108187.5 108780.0 109481.5 10528.9 10781.5 11316.7 11359.0 11419.9 19256.9 23135.3 23187.5 23188.9 23231.2 7766.7 7768.6 7812.4 7817.9 7928.6 4168.4 4243.1 4289.8 4413.5 4445.6 3539.7 3639.5 3640.4 3648.1 3648.3 656.2 663.6 667.2 682.4 690.1 659.8 680.5 695.8 701.7 717.5 9058.7 9891.9 10997.7 11161.5 11472.0 553.1 577.1 604.4 646.3 709.9 4500.3 4900.9 4900.9 4907.9 4912.2 87707.7 89005.6 92924.5 93542.0 97193.0 78141.6 82383.2 84577.0 86301.6 86569.6 75494.2 76289.6 77430.3 77700.8 78938.0 9762.7 9860.1 9873.3 9875.4 9882.6 32308.5 48485.5 49247.8 49459.0 50091.2 64071.0 64328.0 64447.7 65279.7 67611.0 11673.4 11738.1 11800.3 11876.5 12008.6 12713.2 12788.2 12791.1 12954.7 13107.9 10887.7 11903.2 11952.2 12111.8 12268.8 10119.3 11963.7 12125.1 12381.6 12647.9 12032.0 12040.3 12067.8 12375.5 12430.8 9842.6 9953.3 10080.5 10114.8 10610.4 9497.4 9582.6 9610.4 9611.4 9636.6 14:51:57 INFO - PROCESS | 1642 | -------- Summary: end -------- 14:51:57 INFO - PROCESS | 1642 | 14:51:58 INFO - TEST-INFO | 1642: exit 0 14:51:58 INFO - TEST-OK | dromaeo_css | took 1118077ms 14:51:58 INFO - TEST-START | kraken 14:51:58 INFO - operating with platform_type : mac_ 14:51:58 INFO - Initialising browser for kraken test... 14:51:58 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpd82ebZ/profile http://localhost:49236/getInfo.html) 14:52:00 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 14:52:00 INFO - PROCESS | 1648 | colorDepth:24 14:52:00 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 14:52:00 INFO - PROCESS | 1648 | __metrics 14:52:00 INFO - PROCESS | 1648 | 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" 14:52:00 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:52:01 INFO - TEST-INFO | 1648: exit 0 14:52:01 INFO - Browser initialized. 14:52:01 INFO - Running cycle 1/1 for kraken test... 14:52:01 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpd82ebZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:13 INFO - PROCESS | 1649 | RSS: Main: 235692032 14:52:13 INFO - PROCESS | 1649 | 14:52:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:17 INFO - PROCESS | 1649 | RSS: Main: 287666176 14:52:17 INFO - PROCESS | 1649 | 14:52:19 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 14:52:20 INFO - PROCESS | 1649 | RSS: Main: 286859264 14:52:20 INFO - PROCESS | 1649 | 14:52:23 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 14:52:24 INFO - PROCESS | 1649 | RSS: Main: 378687488 14:52:24 INFO - PROCESS | 1649 | 14:52:26 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 14:52:26 INFO - PROCESS | 1649 | RSS: Main: 282316800 14:52:26 INFO - PROCESS | 1649 | 14:52:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:52:29 INFO - PROCESS | 1649 | RSS: Main: 286838784 14:52:29 INFO - PROCESS | 1649 | 14:52:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 14:52:32 INFO - PROCESS | 1649 | RSS: Main: 329367552 14:52:32 INFO - PROCESS | 1649 | 14:52:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 14:52:36 INFO - PROCESS | 1649 | RSS: Main: 330891264 14:52:36 INFO - PROCESS | 1649 | 14:52:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 14:52:39 INFO - PROCESS | 1649 | RSS: Main: 326336512 14:52:39 INFO - PROCESS | 1649 | 14:52:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:42 INFO - PROCESS | 1649 | RSS: Main: 304029696 14:52:42 INFO - PROCESS | 1649 | 14:52:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:52:44 INFO - PROCESS | 1649 | RSS: Main: 307335168 14:52:44 INFO - PROCESS | 1649 | 14:52:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:52:47 INFO - PROCESS | 1649 | RSS: Main: 308977664 14:52:47 INFO - PROCESS | 1649 | 14:52:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:52:51 INFO - PROCESS | 1649 | RSS: Main: 325947392 14:52:51 INFO - PROCESS | 1649 | 14:52:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:54 INFO - PROCESS | 1649 | RSS: Main: 319512576 14:52:54 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 14:52:56 INFO - PROCESS | 1649 | RSS: Main: 363679744 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | __start_tp_report 14:52:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 14:52:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 14:52:56 INFO - PROCESS | 1649 | |i|pagename|runs| 14:52:56 INFO - PROCESS | 1649 | |0;ai-astar;113;114;114;113;113;124;123;114;113;114 14:52:56 INFO - PROCESS | 1649 | |1;audio-beat-detection;140;109;110;145;111;110;108;112;126;110 14:52:56 INFO - PROCESS | 1649 | |2;audio-dft;185;183;185;183;184;186;182;184;183;185 14:52:56 INFO - PROCESS | 1649 | |3;audio-fft;79;59;60;87;61;59;58;59;73;58 14:52:56 INFO - PROCESS | 1649 | |4;audio-oscillator;88;71;84;73;95;72;82;68;69;83 14:52:56 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;85;89;87;87;85;90;86;88;84 14:52:56 INFO - PROCESS | 1649 | |6;imaging-darkroom;97;98;96;97;95;97;96;96;96;95 14:52:56 INFO - PROCESS | 1649 | |7;imaging-desaturate;85;84;85;86;88;87;87;86;84;86 14:52:56 INFO - PROCESS | 1649 | |8;json-parse-financial;57;54;55;55;56;54;54;56;56;55 14:52:56 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;66;74;69;75;75;69;69;70;71;71 14:52:56 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;86;86;86;87;86;85;85;87;86;86 14:52:56 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;143;150;153;141;164;150;150;134;191;176 14:52:56 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;173;171;177;204;174;171;171;172;169;173 14:52:56 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;58;79;86;84;73;66;68;67;67;66 14:52:56 INFO - PROCESS | 1649 | __end_tp_report 14:52:56 INFO - PROCESS | 1649 | __start_cc_report 14:52:56 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1910 14:52:56 INFO - PROCESS | 1649 | __end_cc_report 14:52:56 INFO - PROCESS | 1649 | __startTimestamp1484607176744__endTimestamp 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | ------- Summary: start ------- 14:52:56 INFO - PROCESS | 1649 | Number of tests: 14 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:115.50 Median:114.00 stddev:4.25 (3.7%) stddev-sans-first:4.41 14:52:56 INFO - PROCESS | 1649 | Values: 113.0 114.0 114.0 113.0 113.0 124.0 123.0 114.0 113.0 114.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:111.50 stddev:13.88 (12.5%) stddev-sans-first:12.26 14:52:56 INFO - PROCESS | 1649 | Values: 140.0 109.0 110.0 145.0 111.0 110.0 108.0 112.0 126.0 110.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.25 (0.7%) stddev-sans-first:1.27 14:52:56 INFO - PROCESS | 1649 | Values: 185.0 183.0 185.0 183.0 184.0 186.0 182.0 184.0 183.0 185.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:65.30 Median:60.50 stddev:10.49 (17.3%) stddev-sans-first:9.88 14:52:56 INFO - PROCESS | 1649 | Values: 79.0 59.0 60.0 87.0 61.0 59.0 58.0 59.0 73.0 58.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:82.50 stddev:9.16 (11.1%) stddev-sans-first:9.04 14:52:56 INFO - PROCESS | 1649 | Values: 88.0 71.0 84.0 73.0 95.0 72.0 82.0 68.0 69.0 83.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.50 stddev:1.91 (2.2%) stddev-sans-first:1.99 14:52:56 INFO - PROCESS | 1649 | Values: 88.0 85.0 89.0 87.0 87.0 85.0 90.0 86.0 88.0 84.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 14:52:56 INFO - PROCESS | 1649 | Values: 97.0 98.0 96.0 97.0 95.0 97.0 96.0 96.0 96.0 95.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.32 (1.5%) stddev-sans-first:1.36 14:52:56 INFO - PROCESS | 1649 | Values: 85.0 84.0 85.0 86.0 88.0 87.0 87.0 86.0 84.0 86.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.03 (1.9%) stddev-sans-first:0.87 14:52:56 INFO - PROCESS | 1649 | Values: 57.0 54.0 55.0 55.0 56.0 54.0 54.0 56.0 56.0 55.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:2.96 (4.2%) stddev-sans-first:2.55 14:52:56 INFO - PROCESS | 1649 | Values: 66.0 74.0 69.0 75.0 75.0 69.0 69.0 70.0 71.0 71.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 14:52:56 INFO - PROCESS | 1649 | Values: 86.0 86.0 86.0 87.0 86.0 85.0 85.0 87.0 86.0 86.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:151.50 stddev:17.25 (11.4%) stddev-sans-first:17.72 14:52:56 INFO - PROCESS | 1649 | Values: 143.0 150.0 153.0 141.0 164.0 150.0 150.0 134.0 191.0 176.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:173.00 stddev:10.24 (5.9%) stddev-sans-first:10.83 14:52:56 INFO - PROCESS | 1649 | Values: 173.0 171.0 177.0 204.0 174.0 171.0 171.0 172.0 169.0 173.0 14:52:56 INFO - PROCESS | 1649 | 14:52:56 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.50 stddev:8.95 (12.7%) stddev-sans-first:8.07 14:52:56 INFO - PROCESS | 1649 | Values: 58.0 79.0 86.0 84.0 73.0 66.0 68.0 67.0 67.0 66.0 14:52:56 INFO - PROCESS | 1649 | -------- Summary: end -------- 14:52:56 INFO - PROCESS | 1649 | 14:52:57 INFO - TEST-INFO | 1649: exit 0 14:52:57 INFO - TEST-OK | kraken | took 59099ms 14:52:57 INFO - SUITE-END | took 1177s 14:52:57 INFO - Completed test suite (00:19:37) 14:52:57 INFO - javascript benchmark 14:52:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.8530816113275, 3307.6361600223986, 3313.5858017747787, 3332.0503656457913, 3377.4933759936007, 5567.9977604031255, 5610.607257491977, 5648.576356773238, 5648.604597678164, 5662.34882988456, 5640.238567793347, 5696.202531645573, 5697.77208911643, 5776.566757493194, 5797.043487824504, 5127.743612819344, 5149.562287205574, 5192.844214673566, 5243.6853788772605, 5275.762590683409, 5290.232916227144, 5321.574274058085, 5322.361316641989, 5343.519083282504, 5384.5692344612335, 5114.693118412907, 5130.410002849682, 5288.206768984644, 5306.4958828911385, 5307.442718514578, 5125.077486052509, 5188.92216616751, 5193.350831146106, 5258.894822103536, 5319.3616765987945, 5202.635815492917, 5205.453427390107, 5207.9479205207845, 5223.11207094791, 5226.398964119099, 5760.913586296209, 5778.942210577925, 5783.334916484616, 5797.420257974211, 5803.651780893118, 6151.83115208109, 6192.0, 6202.131701561785, 6265.498760099181, 6268.937310626881, 6264.154339164245, 6306.936930630681, 6321.273053598849, 6349.4602958748565, 6353.6823158842335, 5917.822465326047, 5938.168656388109, 5944.4352786485215, 5955.047192449188, 5991.400859913973, 6158.7228574714245, 6225.097360882737, 6243.157173781481, 6314.905276420857, 6338.714757835908, 6128.80869161996, 6253.093301471261, 6261.812145635638, 6278.0269058296035, 6279.686015699288, 6182.072689096672, 6330.841728956813, 6334.3032266450655, 6334.398232167937, 6346.30190679025, 6161.938380616226, 6170.167027451236, 6172.197614310111, 6236.781712640127, 6243.406876346739, 6312.210973628296, 6316.242050953915, 6324.209473815773, 6334.936650633527, 6336.429721325011, 5007.924881126786, 5037.874053148627, 5053.292539044537, 5058.317127187783, 5089.312942752681, 4390.253656878274, 4426.84506042287, 4429.357743127229, 4432.867013989586, 4533.252013417815, 5786.768529258782, 5819.272590926134, 5883.499902508249, 5886.293644762656, 5895.20414744004, 6239.483876106349, 6304.495640348761, 6311.431971122621, 6316.399942005502, 6331.3352098029045, 5636.4927156556105, 5828.329742079715, 5841.240638716939, 5848.707564621752, 5859.355470898197, 5435.10320797064, 5437.34751829783, 5459.945400545944, 5495.807646732345, 5496.340439147328, 6252.812415627538, 6264.812055638338, 6266.937330626818, 6270.996640537492, 6309.873802523924, 5269.762860671202, 6231.40801623845, 6275.6548389839, 6293.0, 6328.651924144032, 6305.432511074026, 6350.650714210763, 6366.331535188739, 6381.968090159519, 6455.419012288917, 6264.373562643881, 6280.591761535486, 6285.340039295991, 6290.716917738621, 6296.590721603081, 6151.169592105009, 6159.414855588712, 6186.041163619646, 6210.037444196157, 6216.875662486635, 6078.666859355449, 6156.045812899008, 6160.7535698571555, 6162.784302549389, 6164.260288765377, 6130.314163605044, 6148.231471066117, 6153.323134455117, 6155.630662160284, 6160.969195153995, 5831.591788574759, 5859.091840764689, 5882.352941176553, 5985.311689155628, 6018.488428483628, 6190.473809726043, 6194.38056194377, 6217.098520714561, 6221.004639257697, 6228.719707613078, 6044.214252147192, 6046.667433291212, 6069.393060693896, 6071.1067297973295, 6128.479079278133], "value": 5746.327601342954, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.8696858363949, 490.64428289490104, 490.75952783136273, 504.60892808073737, 513.5916946027909, 31366.52950205749, 39476.2104757905, 41890.790546047305, 42022.57977420225, 44028.01873915674, 43596.0, 43969.7801510992, 43999.0, 44089.77955110228, 44148.0, 8190.0, 9330.346875718702, 9518.666846660368, 9547.42715437076, 9560.330776845623, 8423.578821058953, 8626.611802468904, 11166.497507612177, 11229.382383968878, 11524.308541487495, 10049.0, 11492.195546311761, 11498.25261358009, 11501.367424791633, 11530.711732206679, 8435.0, 11404.828927566094, 11460.140489463323, 11475.081993440546, 11492.080633549296, 7333.120025596909, 9628.518574071339, 10822.026017658449, 11126.554937802559, 11603.593874214363, 34583.827080864685, 41566.37650435246, 41992.79003604963, 42052.158956821, 42117.57882421167, 4023.537293211289, 4061.2689715851134, 4061.97969010156, 4082.7754473503946, 4115.053537686319, 30689.0, 31275.061748147593, 31583.684163158305, 31644.841775791203, 31805.40972951343, 3189.8245596492184, 3237.7247933925646, 3243.0919342584116, 3310.470324748053, 3375.3924293627138, 504070.0, 504272.0, 504759.0, 505037.0, 505502.0, 63929.68035159887, 64257.35742642514, 64264.35735642677, 64293.35706642967, 64417.35582644113, 62197.0, 62289.0, 62296.754064918445, 62355.0, 62547.0, 15861.52415427539, 16355.509334719978, 16372.181390930644, 16381.0, 16450.34198632065, 11270.774584508265, 11562.248453850472, 12472.937635311766, 12522.686932826753, 12533.561325353568, 18394.172262247965, 18724.438266852016, 18771.436856894314, 18794.624107518048, 18976.956267405425, 6969.372756451944, 7011.509194356346, 7068.717251309993, 7073.434125269966, 7122.501424900207, 869.9430192316366, 878.5695009445453, 879.3712495565701, 886.1315910407836, 908.9363744537819, 24744.0, 29834.55248171279, 29961.70038299633, 30253.243668908453, 31207.84396078005, 1020.6019652335596, 1022.2588623248085, 1055.482813421418, 1058.7988282226352, 1069.2675517270695, 14426.855731442762, 14806.629834254014, 14831.40674373013, 14880.181590012653, 14990.625234369229, 539813.0, 540913.0, 544652.0, 545190.0, 546352.0, 52080.21879671808, 52170.21744673833, 52299.0, 52428.21357679638, 52472.73763631234, 1376.9311534423239, 1397.4061024064936, 1407.1768015710516, 1413.964650883736, 1440.5606290081626, 23685.28944131679, 26936.191914242605, 27576.724232757417, 28246.43507129887, 28255.43489130247, 41172.588274116875, 47021.76489117533, 47141.764291178326, 47165.7641711803, 47192.7640361796, 480111.0, 480577.0, 483388.0, 483736.0, 484748.0, 22363.88818055899, 22914.0, 24696.13563525268, 24841.50316993614, 25229.0, 41539.37690934699, 41937.0, 43028.78485607552, 43231.78384108059, 43497.34753978756, 26496.8675156623, 34074.829625851715, 34306.79926202571, 35822.46266305955, 36404.81797590995, 34254.657453426145, 35451.0, 36412.27175456423, 37368.62631373652, 38810.8356749298, 35536.0, 35759.82120089383, 36108.27783444369, 36117.458238125924, 36208.0, 26276.0, 28834.855825720737, 30391.0, 32576.674233257363, 32970.67029329772, 22066.44833879166, 23802.880985594962, 23849.64225536653, 24294.51410971806, 24335.26994190177], "value": 19492.90475241694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.251497005988, 390.5898806253433, 392.9332013557695, 394.3906664203805, 413.4728221517565, 14905.403783848647, 14910.5526834195, 18932.958687272196, 20719.274825381115, 20721.896390518028, 18831.905840470812, 20734.548581599294, 21808.0, 22053.33839984799, 22421.43946401341, 1646.497818165459, 1647.983520164801, 1649.3979697410418, 1651.743979683151, 1858.2381223698287, 5870.794522191724, 6040.214772079624, 6056.727447264861, 6105.236845394325, 6114.113453549255, 5948.256467941507, 6067.423594758513, 6071.332153463116, 6080.543959203077, 6080.878382432371, 5744.655320680752, 5945.791897283596, 6033.818985430444, 6034.39656034393, 6034.607750496204, 5280.0, 5282.947170528284, 5300.602454815866, 5306.973465132688, 5327.786888524454, 12931.48274069036, 13172.275524846129, 13370.791010157589, 13374.665633359244, 13613.455461781517, 2543.758342957416, 2554.2081954594137, 2610.5040042392075, 2615.437680898616, 2659.906903258396, 9815.0, 9874.90125098747, 9993.500324983721, 10349.016843399864, 10351.689449316533, 1733.306677329066, 1791.3640657566507, 1795.0845069014765, 1808.1863161577212, 1828.3509354179207, 118448.58306043052, 124921.9999999991, 125344.37327813393, 127413.0, 128980.0, 11510.251833630788, 11524.539018439336, 11644.825327619923, 11664.125190610737, 11868.169228153947, 15157.317920693595, 15192.316345764468, 15205.783537316987, 15242.314095865713, 15273.083614983136, 8461.95769021151, 8615.870761938577, 8642.265407440313, 8710.21608055278, 8728.825423491495, 8457.619407126695, 8460.957695211608, 8463.449875758179, 8605.096464871098, 8638.74083777475, 3789.3368660484857, 4559.680822342404, 4572.839950601713, 4607.769611519478, 4661.743604101807, 1955.1983686688675, 1999.7100420438956, 2003.869748466345, 2004.2884775904636, 2005.8796472211714, 837.4305472278787, 987.7283746969497, 995.2237254941158, 1000.3547711726042, 1042.4475028235047, 19707.40877773669, 20723.27468538594, 21529.78470215309, 21569.352919412442, 21764.782352176277, 990.4750482244422, 1035.1253191053547, 1035.3632516002754, 1078.358376765823, 1084.734240111162, 8363.58182090893, 10885.401302928414, 11096.699812653133, 11141.053010494199, 11157.995780379804, 673340.0, 685274.0, 725514.0, 736446.0, 744485.0, 151639.0, 152997.0, 153639.23180384026, 155122.0, 155768.2211588935, 967.7000129959735, 984.4929861121528, 1006.6577363696379, 1008.3143462445607, 1010.9443980580992, 14802.703945921237, 17861.0, 18794.624107518048, 18869.811301887356, 19223.423297301102, 59450.405495944484, 62740.68629656822, 63949.0, 63975.360246396944, 64154.67922660357, 84480.57759711162, 85972.0, 87068.0, 87973.56013219892, 88272.11234686409, 8235.50586964784, 8372.451096547158, 8577.828443430972, 8724.69463568772, 8746.69386571467, 10835.891641083488, 13177.670558236121, 13667.589972300846, 13787.0, 13799.586012419644, 11178.20544863784, 11328.830067549157, 11377.601783937522, 11468.770624587294, 11792.646220613395, 10382.636607718694, 11452.312861228353, 11606.129540284344, 11792.866831564847, 11806.468708907947, 9020.684276050306, 9381.812363752822, 11136.276142050741, 11634.883651163718, 12080.456379463121, 7019.4033507150425, 7625.23747625233, 8486.957565212135, 8524.488530688179, 8778.736637900873, 8489.40574159803, 11280.548778048786, 11718.941405292919, 11778.0, 12005.279683219034], "value": 9346.972380439414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.925754083525, 1451.8257809062914, 1468.610818133195, 1472.5729538433854, 1482.7775833624958, 6498.447631951284, 7846.8038299042555, 8130.186981301867, 8343.998720153575, 8447.986241651011, 8260.91739082609, 8340.624671889764, 8347.791305217372, 8369.037560680523, 8376.204260595248, 2277.840551161419, 2321.651752237161, 2323.76762323768, 2326.8022218111482, 2330.8951097200584, 1932.4492519631838, 2075.9065842037144, 2151.0857885398723, 2351.7413084560685, 2364.775346342103, 2321.419645088728, 2321.5589038082794, 2328.941776455585, 2329.406001469623, 2335.252719129879, 2283.908643654252, 2318.431984163874, 2319.7216334039854, 2323.8605683659034, 2326.7091613548305, 2299.2297580310615, 2322.9651555226687, 2329.871857047862, 2338.5556744218543, 2340.9816729722625, 8402.327813774884, 8463.534505602189, 8467.068622451525, 8481.067082620906, 8490.448120872185, 5036.722980236085, 5201.1678131498775, 5205.635605507616, 5208.401033881114, 5221.39953905302, 3321.7342612590933, 3468.5664291963503, 3496.4755286707195, 3535.1515636247373, 3538.8761393351365, 1160.669209275361, 1215.890569848709, 1218.5795900414344, 1257.9621812005041, 1260.023481801602, 8969.506677132755, 10712.946435267773, 10717.46412679363, 10770.246082774287, 10775.353478791298, 4413.073254616503, 4615.930761038587, 4663.860084197479, 4677.316166180172, 4681.461631912373, 9472.242220622335, 9477.810443791086, 9479.857802132974, 9490.430574165572, 9491.240700743923, 5216.139337009351, 5223.059849227099, 5228.346456692913, 5230.529252367305, 5231.189165679326, 3771.8868433947027, 3880.9029774255305, 4680.251159814414, 4752.215884379108, 4810.855674329706, 3761.774293542396, 3781.640744129303, 3818.4463252828186, 3844.3272427325105, 3848.7690738555775, 1259.439549400508, 1265.3862876504888, 1267.3029833591672, 1276.44474653526, 1281.2824818101892, 789.2541548236861, 835.3400813357501, 891.7636826241052, 901.0989010989011, 928.2202949522433, 5277.577793776489, 5362.758675859518, 5579.776808927679, 5708.914366284509, 5724.942750572441, 890.670451932789, 976.7948730766618, 977.7408986618552, 1008.2337423558149, 1008.641932114089, 3562.2697347043795, 3706.9258614827554, 3790.8673196437994, 3818.6372294631965, 3848.615138486129, 8316.916830831735, 9438.90561094394, 9729.221662267002, 9765.609375625038, 9891.60433582663, 9735.513224338754, 9803.460809655537, 9900.059494348025, 10018.499075046364, 10072.546735396925, 7684.654190561439, 7990.121086680577, 7994.200579941959, 8002.559859207683, 8007.119216886138, 5635.224904155178, 5665.631733937281, 5781.248437703071, 5840.678762667924, 5892.7642894283745, 9188.173064424234, 9330.393524420891, 9349.906500935176, 9356.251499880129, 9361.672341468016, 8938.821223575362, 9336.906630933603, 9351.719448416286, 9413.435193888388, 9485.33602647808, 6614.503912206507, 6800.115984921928, 6813.386795188457, 6895.862082758417, 6915.585064896122, 6524.217093948757, 7522.5862577558755, 7596.354309883722, 7630.389568834369, 7809.609519523888, 7086.362227399559, 7187.353138217585, 7195.352418282379, 7257.637118143966, 7351.485396022227, 6945.895811562932, 7010.789676309719, 7025.297470252934, 7208.56748595086, 7218.061651985208, 6244.438000579969, 6386.137871387304, 6392.456641185551, 6399.488040956805, 6403.199600049994, 4876.29293752411, 4928.926066109083, 4994.825181118788, 5020.924686129638, 5036.748162591929, 3984.2629113612916, 4916.803327866845, 4985.252212168204, 5037.294778730908, 5048.646594738333], "value": 4396.773253771146, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.27801334942984, 355.35503061942575, 362.1652091928106, 365.25305749741784, 376.5274580401594, 5031.345925029746, 5188.688678679282, 5512.39363669996, 5530.087535556639, 5544.334679838415, 4499.482559505658, 4691.765411729409, 5231.633785635007, 5261.710605916673, 5454.545454545455, 3559.75081744278, 4148.97925510372, 4190.72760270583, 4190.769507677084, 4194.182134483777, 3749.9250014999684, 3985.2627263956115, 4167.9583204167875, 4171.706770901015, 4184.937225941613, 4047.8583249586272, 4139.668826493888, 4149.3775933609895, 4151.688623353246, 4156.210320039183, 3196.536502207167, 3629.3467175908327, 3901.4928059352246, 4056.5132184137797, 4059.9594004060023, 2912.956305655417, 3087.8764849405998, 3389.813560254185, 3404.9740404459553, 3659.8288547664756, 4721.315409265637, 4745.050989802019, 4899.534544218293, 5184.351956005499, 5207.791688332462, 3888.922221555553, 4585.564371384747, 4653.464851542082, 4843.98974425613, 4882.218844984821, 5679.233303504016, 5679.2455659005345, 5701.372848986608, 5708.286464191976, 5715.342735585377, 3730.8694195703292, 4093.774842383668, 4102.692298077656, 4111.8972025699295, 4116.650084742801, 5024.64478123705, 5774.335951365562, 5849.327327357366, 5938.524918006549, 5945.286565612154, 3523.559555055618, 3753.230587729509, 3955.5055618047745, 4182.832686692498, 4187.602177793105, 3616.1863580694135, 3962.841486340572, 4222.577742225814, 4271.636910862611, 4320.395144679747, 4294.0, 4368.5194628590825, 4663.370444989951, 4670.719756814602, 4906.215005599087, 5702.7433765480655, 5712.6286791358425, 5720.914186287209, 5721.742521586539, 5724.685142317129, 1259.8992080633527, 1288.9677758055936, 1289.2973329535425, 1291.6964513339358, 1302.667819705969, 747.5701471653821, 785.2971590426537, 825.0, 841.5413599588239, 852.884860543831, 4486.842960496432, 4603.976980115078, 5003.899922001539, 5038.647294689336, 5041.0, 5021.84934451967, 5111.284420181178, 5176.9741151294, 5205.932783779316, 5622.0, 4151.917548354278, 4346.913061738747, 4385.429894113809, 4507.954920450819, 5034.270030845507, 2664.5603475426724, 2884.79806413549, 2901.158663987462, 2902.3759891623404, 2909.9524171298317, 4933.925991110136, 5730.85382923417, 5739.7812607733285, 5741.483266506035, 5754.769809207585, 4954.0, 5590.217369568264, 5875.529957603467, 6010.819675409744, 6030.889188783891, 6048.0, 6059.727891836244, 6072.605280656743, 6085.6348619083, 6115.388461153938, 5516.696581687886, 5824.563157763269, 5857.970710146422, 5890.7054647266605, 5902.468777810018, 4915.361003069578, 4925.679830810986, 5784.797532086357, 5795.5073818724195, 5813.9534883721335, 5428.402875683592, 5612.579056570855, 6037.49443980743, 6078.7264573093435, 6117.908231376444, 3728.925421491609, 4015.4980627421573, 4017.7589344639414, 4255.531891491995, 4303.763293018914, 4727.432708075053, 5193.4027586828, 5354.651947623392, 5361.061814182424, 5670.631408958405, 5074.594032477319, 5343.419908661129, 5668.37647858727, 5752.511036561939, 5757.971210143923, 5222.817201397933, 5421.810236641699, 5653.745581448927, 5658.717064146858, 5691.544676425959, 4811.989482208635, 5530.7511161997, 5547.722613869371, 5550.722463876871, 5561.304836895388, 4499.572540608637, 4883.487233840396, 4900.607951363953, 4969.211084009826, 5723.6851973141875, 5550.27846379968, 5551.307615806411, 5569.860753481195, 5580.246666700106, 5589.496945274945], "value": 4103.41944662253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5352547606793, 727.0983979864969, 774.4114473000521, 816.612109248107, 817.5340056167985, 14810.92594537027, 15751.0, 15774.290156942936, 15787.052776833383, 15795.84204157958, 14571.052881562691, 14673.413063477448, 14686.971911966166, 14696.485623003196, 14713.264336783144, 689.8068540808582, 705.8411857332111, 709.5104377979204, 725.1696807155804, 861.0571424290407, 706.7985624097133, 714.1323292199976, 849.235687880909, 867.2628265973904, 868.9789497340631, 945.0360632155198, 946.186279799372, 956.1681337236614, 957.2437774158407, 961.0773657289011, 948.1419315519466, 949.9740280497047, 951.4909523404945, 952.1430712358863, 958.0180315176895, 550.411060165623, 560.073079054166, 710.1939298895738, 714.3071220915704, 715.1882613234017, 13177.879880210194, 13895.513657022057, 14363.56909292723, 15268.0, 15306.617334566614, 14378.568642940729, 14405.927970360186, 14515.419383224658, 14532.636684082876, 14539.563813085624, 11805.0, 11866.584669536525, 11944.044476441864, 11991.0, 12149.817752733716, 3631.564212294515, 3692.7415080944343, 3816.9809150954347, 3876.8061596920325, 3877.418387241936, 103074.48462757713, 105105.0, 108187.45906270418, 108780.0, 109481.45259273653, 10528.894466080952, 10781.514831832586, 11316.660500185008, 11359.0, 11419.942900285612, 19256.903715481334, 23135.305940821803, 23187.536249275257, 23188.884055579612, 23231.186908458123, 7766.728164514328, 7768.611569421506, 7812.375009999187, 7817.8827317590285, 7928.5639289838455, 4168.353905144708, 4243.108947121077, 4289.785510724451, 4413.536578659258, 4445.622122119656, 3539.663731945461, 3639.526861507987, 3640.4175331946763, 3648.1426864686778, 3648.325059863934, 656.176498494396, 663.6151032401195, 667.2326824152167, 682.3517658224706, 690.0649619765246, 659.7657831469855, 680.5474359550843, 695.7947405515386, 701.6526819224516, 717.5085066729307, 9058.728238152866, 9891.901080989099, 10997.670069897917, 11161.497732602053, 11471.98291913894, 553.1371061144547, 577.125654633231, 604.4439116013278, 646.2923099206362, 709.8757717399434, 4500.347449619787, 4900.8774780630765, 4900.901981960341, 4907.87730306738, 4912.238603016538, 87707.68438473428, 89005.55497222472, 92924.53537732403, 93542.0, 97193.0, 78141.60929195432, 82383.17616823874, 84577.0, 86301.56849215714, 86569.5671521651, 75494.24505755091, 76289.61855190688, 77430.28993985296, 77700.83448748273, 78938.0, 9762.707118786448, 9860.06329398706, 9873.25950553697, 9875.407475551203, 9882.604695812088, 32308.515372269903, 48485.545433637046, 49247.75376123097, 49459.0, 50091.248631271286, 64071.0, 64328.0, 64447.67776161089, 65279.673601631686, 67611.0, 11673.357965311989, 11738.119641026786, 11800.291982481078, 11876.524939002344, 12008.579699710468, 12713.17364371313, 12788.17049570791, 12791.104622676323, 12954.67613309637, 13107.934460327637, 10887.727806804893, 11903.226290291102, 11952.223105498115, 12111.75776484483, 12268.815967760313, 10119.342242754197, 11963.700907477383, 12125.090618203847, 12381.566645167375, 12647.936760316139, 12032.04718993244, 12040.337781422106, 12067.75864482723, 12375.504979800708, 12430.81353779676, 9842.557084931052, 9953.303268771117, 10080.546375412978, 10114.797704046025, 10610.363378197333, 9497.382670126419, 9582.616695332108, 9610.423374597547, 9611.375260608038, 9636.614535418785], "value": 7302.8343774306395, "unit": "score"}], "name": "dromaeo_css", "value": 7188.294649987594, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 124.0, 123.0, 114.0, 113.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 110.0, 145.0, 111.0, 110.0, 108.0, 112.0, 126.0, 110.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 185.0, 183.0, 184.0, 186.0, 182.0, 184.0, 183.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 60.0, 87.0, 61.0, 59.0, 58.0, 59.0, 73.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 84.0, 73.0, 95.0, 72.0, 82.0, 68.0, 69.0, 83.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 87.0, 87.0, 85.0, 90.0, 86.0, 88.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 97.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 86.0, 88.0, 87.0, 87.0, 86.0, 84.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 55.0, 56.0, 54.0, 54.0, 56.0, 56.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 69.0, 75.0, 75.0, 69.0, 69.0, 70.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 87.0, 86.0, 85.0, 85.0, 87.0, 86.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 150.0, 153.0, 141.0, 164.0, 150.0, 150.0, 134.0, 191.0, 176.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 177.0, 204.0, 174.0, 171.0, 171.0, 172.0, 169.0, 173.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 79.0, 86.0, 84.0, 73.0, 66.0, 68.0, 67.0, 67.0, 66.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1444.6000000000001, "alertThreshold": 2.0}]} 14:52:57 INFO - Return code: 0 14:52:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:52:58 ERROR - # TBPL SUCCESS # 14:52:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:52:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:52:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:52:58 INFO - 2017-01-16 14:52:58.037 screenresolution[1653:9688] starting screenresolution argv=screenresolution get 14:52:58 INFO - 2017-01-16 14:52:58.040 screenresolution[1653:9688] Display 0: 1600x1200x32@60 14:52:58 INFO - 2017-01-16 14:52:58.047 screenresolution[1654:9691] starting screenresolution argv=screenresolution list 14:52:58 INFO - Available Modes on Display 0 14:52:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:52:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:52:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:52:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:52:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:52:58 INFO - Intel Iris: 14:52:58 INFO - Chipset Model: Intel Iris 14:52:58 INFO - Type: GPU 14:52:58 INFO - Bus: Built-In 14:52:58 INFO - VRAM (Dynamic, Max): 1536 MB 14:52:58 INFO - Vendor: Intel (0x8086) 14:52:58 INFO - Device ID: 0x0a2e 14:52:58 INFO - Revision ID: 0x0009 14:52:58 INFO - Displays: 14:52:58 INFO - Display: 14:52:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:52:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:52:58 INFO - Display Serial Number: 1600x1200 60 14:52:58 INFO - Main Display: Yes 14:52:58 INFO - Mirror: Off 14:52:58 INFO - Online: Yes 14:52:58 INFO - Rotation: Supported 14:52:58 INFO - Return code: 0 14:52:58 INFO - Running post-action listener: _resource_record_post_action 14:52:58 INFO - [mozharness: 2017-01-16 22:52:58.284081Z] Finished run-tests step (success) 14:52:58 INFO - Running post-run listener: _resource_record_post_run 14:52:58 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38863872; Write bytes: 553291776; Read time: 371; Write time: 1738 14:52:58 INFO - TinderboxPrint: CPU usage
53.7% 14:52:58 INFO - TinderboxPrint: I/O read bytes / time
38,863,872 / 371 14:52:58 INFO - TinderboxPrint: I/O write bytes / time
553,291,776 / 1,738 14:52:58 INFO - TinderboxPrint: CPU idle
2,223.0 (46.3%) 14:52:58 INFO - TinderboxPrint: CPU system
959.6 (20.0%) 14:52:58 INFO - TinderboxPrint: CPU user
1,619.1 (33.7%) 14:52:58 INFO - TinderboxPrint: Swap in / out
289,198,080 / 0 14:52:58 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248713728; Write bytes: 239368192; Read time: 17788; Write time: 613 14:52:58 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31661056; Write bytes: 296298496; Read time: 284; Write time: 1088 14:52:58 INFO - Running post-run listener: _upload_blobber_files 14:52:58 INFO - Blob upload gear active. 14:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52: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 14:52: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'] 14:52: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 14:52:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:59 INFO - (blobuploader) - INFO - Done attempting. 14:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:00 INFO - (blobuploader) - INFO - Done attempting. 14:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:02 INFO - (blobuploader) - INFO - Done attempting. 14:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:04 INFO - (blobuploader) - INFO - Done attempting. 14:53:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:04 INFO - Return code: 0 14:53:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0de76a2a1b9f870816836dcff3f0e67a720913dc63caac0332304ddd527dabc5e8da96f85c33a900493b9601ce8b6dbbb68d0fa6b71bc348d0460c1622cdc85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47c3f84942c347bd116f817ed5134b78dba9e6c8d632913ac7ec518e4818084bb968183d2ab3e70d9a5f8d2a1146765f7f1a973c679b936c215b9139ca145f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c193ac67456ba55692a9db93cdcc02d4cacb58a29363ddc1201e5b44e358871c82c675d7ca86995e8dd33f77cea0337a969c39a0ba8a119c7b31422f18b3a5e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e387e8a8b604621529c0b01e1fa4e44aec46432fd1f014e392a1e4f55e739cc3d84b086f84ec03756fe06758d824b644377c837ae74fcc55221a726c471086b2"} 14:53:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:04 INFO - Contents: 14:53:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0de76a2a1b9f870816836dcff3f0e67a720913dc63caac0332304ddd527dabc5e8da96f85c33a900493b9601ce8b6dbbb68d0fa6b71bc348d0460c1622cdc85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47c3f84942c347bd116f817ed5134b78dba9e6c8d632913ac7ec518e4818084bb968183d2ab3e70d9a5f8d2a1146765f7f1a973c679b936c215b9139ca145f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c193ac67456ba55692a9db93cdcc02d4cacb58a29363ddc1201e5b44e358871c82c675d7ca86995e8dd33f77cea0337a969c39a0ba8a119c7b31422f18b3a5e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e387e8a8b604621529c0b01e1fa4e44aec46432fd1f014e392a1e4f55e739cc3d84b086f84ec03756fe06758d824b644377c837ae74fcc55221a726c471086b2"} 14:53:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:04 INFO - Copying logs to upload dir... 14:53:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.094753 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-16 14:53:04.900577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:04.904324) ========= 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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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/0de76a2a1b9f870816836dcff3f0e67a720913dc63caac0332304ddd527dabc5e8da96f85c33a900493b9601ce8b6dbbb68d0fa6b71bc348d0460c1622cdc85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47c3f84942c347bd116f817ed5134b78dba9e6c8d632913ac7ec518e4818084bb968183d2ab3e70d9a5f8d2a1146765f7f1a973c679b936c215b9139ca145f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c193ac67456ba55692a9db93cdcc02d4cacb58a29363ddc1201e5b44e358871c82c675d7ca86995e8dd33f77cea0337a969c39a0ba8a119c7b31422f18b3a5e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e387e8a8b604621529c0b01e1fa4e44aec46432fd1f014e392a1e4f55e739cc3d84b086f84ec03756fe06758d824b644377c837ae74fcc55221a726c471086b2"} build_url:https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011037 build_url: 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0de76a2a1b9f870816836dcff3f0e67a720913dc63caac0332304ddd527dabc5e8da96f85c33a900493b9601ce8b6dbbb68d0fa6b71bc348d0460c1622cdc85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47c3f84942c347bd116f817ed5134b78dba9e6c8d632913ac7ec518e4818084bb968183d2ab3e70d9a5f8d2a1146765f7f1a973c679b936c215b9139ca145f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c193ac67456ba55692a9db93cdcc02d4cacb58a29363ddc1201e5b44e358871c82c675d7ca86995e8dd33f77cea0337a969c39a0ba8a119c7b31422f18b3a5e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e387e8a8b604621529c0b01e1fa4e44aec46432fd1f014e392a1e4f55e739cc3d84b086f84ec03756fe06758d824b644377c837ae74fcc55221a726c471086b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:04.938713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:04.939069) ========= 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.qfwqsBjKCM/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.AxnLpT7Jbh/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:04.987956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 14:53:04.988265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 14:53:04.988972) ========= ========= Total master_lag: 3.55 =========