builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0195 starttime: 1490092747.14 results: success (0) buildid: 20170321022528 builduid: 989aee1742ab41a689d348b9ab0ee3a7 revision: 1ef29f2ba069c67c95d5b0438c3fb78ec9567bba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.135393) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.135892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.136219) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.163702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.164153) ========= 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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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-03-21 03:39:07-- 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.3M=0.001s 2017-03-21 03:39:07 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.370517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.370868) ========= 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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.028453 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:07.421380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 03:39:07.421781) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ef29f2ba069c67c95d5b0438c3fb78ec9567bba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ef29f2ba069c67c95d5b0438c3fb78ec9567bba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f8qdxqnBQ1/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.C47y6yfsT0/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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-03-21 03:39:07,496 truncating revision to first 12 chars 2017-03-21 03:39:07,496 Setting DEBUG logging. 2017-03-21 03:39:07,496 attempt 1/10 2017-03-21 03:39:07,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1ef29f2ba069?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 03:39:09,532 unpacking tar archive at: mozilla-aurora-1ef29f2ba069/testing/mozharness/ program finished with exit code 0 elapsedTime=2.306633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 03:39:09.752445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:09.752792) ========= script_repo_revision: 1ef29f2ba069c67c95d5b0438c3fb78ec9567bba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:09.753250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:09.753550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 03:39:09.773036) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 03:39:09.773365) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f8qdxqnBQ1/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.C47y6yfsT0/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:39:09 INFO - MultiFileLogger online at 20170321 03:39:09 in /builds/slave/test 03:39:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:39:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:09 INFO - {'append_to_log': False, 03:39:09 INFO - 'base_work_dir': '/builds/slave/test', 03:39:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:09 INFO - 'branch': 'Mozilla-Aurora', 03:39:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:09 INFO - 'config_files': ('talos/mac_config.py',), 03:39:09 INFO - 'default_actions': ('clobber', 03:39:09 INFO - 'read-buildbot-config', 03:39:09 INFO - 'download-and-extract', 03:39:09 INFO - 'populate-webroot', 03:39:09 INFO - 'create-virtualenv', 03:39:09 INFO - 'install', 03:39:09 INFO - 'run-tests'), 03:39:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:09 INFO - 'download_minidump_stackwalk': True, 03:39:09 INFO - 'download_symbols': 'ondemand', 03:39:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:09 INFO - 'gecko_profile': False, 03:39:09 INFO - 'gecko_profile_interval': 0, 03:39:09 INFO - 'installer_path': 'installer.exe', 03:39:09 INFO - 'log_level': 'info', 03:39:09 INFO - 'log_name': 'talos', 03:39:09 INFO - 'log_to_console': True, 03:39:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:39:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:39:09 INFO - 'opt_config_files': (), 03:39:09 INFO - 'pip_index': False, 03:39:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:09 INFO - 'cmd': ('bash', 03:39:09 INFO - '-c', 03:39:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:09 INFO - 'enabled': True, 03:39:09 INFO - 'halt_on_failure': False, 03:39:09 INFO - 'name': 'check_screen_resolution'},), 03:39:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:09 INFO - 'cmd': ('bash', 03:39:09 INFO - '-c', 03:39:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:09 INFO - 'enabled': True, 03:39:09 INFO - 'halt_on_failure': False, 03:39:09 INFO - 'name': 'check_screen_resolution'},), 03:39:09 INFO - 'run_cmd_checks_enabled': True, 03:39:09 INFO - 'suite': 'dromaeojs', 03:39:09 INFO - 'system_bits': '32', 03:39:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:09 INFO - 'title': 't-yosemite-r7-0195', 03:39:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:09 INFO - 'use_talos_json': True, 03:39:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:09 INFO - 'work_dir': 'build'} 03:39:09 INFO - [mozharness: 2017-03-21 10:39:09.961565Z] Running clobber step. 03:39:09 INFO - Running pre-action listener: _resource_record_pre_action 03:39:09 INFO - Running main action method: clobber 03:39:09 INFO - rmtree: /builds/slave/test/build 03:39:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:12 INFO - Running post-action listener: _resource_record_post_action 03:39:12 INFO - [mozharness: 2017-03-21 10:39:12.463131Z] Finished clobber step (success) 03:39:12 INFO - [mozharness: 2017-03-21 10:39:12.463296Z] Running read-buildbot-config step. 03:39:12 INFO - Running pre-action listener: _resource_record_pre_action 03:39:12 INFO - Running main action method: read_buildbot_config 03:39:12 INFO - Using buildbot properties: 03:39:12 INFO - { 03:39:12 INFO - "project": "", 03:39:12 INFO - "product": "firefox", 03:39:12 INFO - "script_repo_revision": "production", 03:39:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:39:12 INFO - "repository": "", 03:39:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:39:12 INFO - "buildid": "20170321022528", 03:39:12 INFO - "pgo_build": "False", 03:39:12 INFO - "basedir": "/builds/slave/test", 03:39:12 INFO - "buildnumber": 61, 03:39:12 INFO - "slavename": "t-yosemite-r7-0195", 03:39:12 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:39:12 INFO - "platform": "yosemite_r7", 03:39:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:39:12 INFO - "branch": "mozilla-aurora", 03:39:12 INFO - "repo_path": "releases/mozilla-aurora", 03:39:12 INFO - "revision": "1ef29f2ba069c67c95d5b0438c3fb78ec9567bba", 03:39:12 INFO - "stage_platform": "macosx64", 03:39:12 INFO - "builduid": "989aee1742ab41a689d348b9ab0ee3a7", 03:39:12 INFO - "slavebuilddir": "test" 03:39:12 INFO - } 03:39:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:39:12 INFO - Running post-action listener: _resource_record_post_action 03:39:12 INFO - [mozharness: 2017-03-21 10:39:12.466595Z] Finished read-buildbot-config step (success) 03:39:12 INFO - [mozharness: 2017-03-21 10:39:12.466703Z] Running download-and-extract step. 03:39:12 INFO - Running pre-action listener: _resource_record_pre_action 03:39:12 INFO - Running main action method: download_and_extract 03:39:12 INFO - mkdir: /builds/slave/test/build/tests 03:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:12 INFO - trying https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 03:39:13 INFO - Downloaded 1199 bytes. 03:39:13 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:39:13 INFO - Using the following test package requirements: 03:39:13 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:39:13 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:39:13 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:39:13 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'jsshell-mac.zip'], 03:39:13 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:39:13 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:39:13 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:39:13 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:39:13 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:39:13 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:39:13 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:39:13 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:39:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:39:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:39:13 INFO - Fetch https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:39:15 INFO - Expected file size: 51782025 03:39:15 INFO - Obtained file size: 51782025 03:39:31 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:39:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:39:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:39:31 INFO - Fetch https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:39:33 INFO - Expected file size: 51782025 03:39:33 INFO - Obtained file size: 51782025 03:39:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:39:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:39:48 INFO - Fetch https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:39:49 INFO - Expected file size: 14404438 03:39:49 INFO - Obtained file size: 14404438 03:39: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')]} 03:39:50 INFO - trying https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:39:50 INFO - Downloading https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 03:39:52 INFO - Downloaded 74691279 bytes. 03:39:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:39:52 INFO - mkdir: /builds/slave/test/properties 03:39:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:52 INFO - Contents: 03:39:52 INFO - build_url:https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:39:52 INFO - Running post-action listener: _resource_record_post_action 03:39:52 INFO - Running post-action listener: set_extra_try_arguments 03:39:52 INFO - [mozharness: 2017-03-21 10:39:52.942150Z] Finished download-and-extract step (success) 03:39:52 INFO - [mozharness: 2017-03-21 10:39:52.942292Z] Running populate-webroot step. 03:39:52 INFO - Running pre-action listener: _resource_record_pre_action 03:39:52 INFO - Running main action method: populate_webroot 03:39:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:52 INFO - '--tppagecycles', 03:39:52 INFO - '7'], 03:39:52 INFO - 'tests': ['tsvgm']}}, 03:39:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:39:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:39:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:39:52 INFO - 'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:39:52 INFO - 'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['damp', 'tps']}, 03:39:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:39:52 INFO - 'tests': ['damp', 'tps']}, 03:39:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['dromaeo_dom']}, 03:39:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['basic_compositor_video']}, 03:39:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:39:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['a11yr', 03:39:52 INFO - 'ts_paint', 03:39:52 INFO - 'tpaint', 03:39:52 INFO - 'sessionrestore', 03:39:52 INFO - 'sessionrestore_no_auto_restore', 03:39:52 INFO - 'tabpaint']}, 03:39:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:39:52 INFO - 'ts_paint', 03:39:52 INFO - 'tpaint', 03:39:52 INFO - 'sessionrestore', 03:39:52 INFO - 'sessionrestore_no_auto_restore', 03:39:52 INFO - 'tabpaint']}, 03:39:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:39:52 INFO - 'ts_paint', 03:39:52 INFO - 'tpaint', 03:39:52 INFO - 'sessionrestore', 03:39:52 INFO - 'sessionrestore_no_auto_restore', 03:39:52 INFO - 'tabpaint']}, 03:39:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:39:52 INFO - 'ts_paint', 03:39:52 INFO - 'tpaint', 03:39:52 INFO - 'sessionrestore', 03:39:52 INFO - 'sessionrestore_no_auto_restore', 03:39:52 INFO - 'tabpaint']}, 03:39:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['a11yr', 03:39:52 INFO - 'ts_paint', 03:39:52 INFO - 'tpaint', 03:39:52 INFO - 'sessionrestore', 03:39:52 INFO - 'sessionrestore_no_auto_restore', 03:39:52 INFO - 'tabpaint']}, 03:39:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['a11yr', 03:39:52 INFO - 'ts_paint', 03:39:52 INFO - 'tpaint', 03:39:52 INFO - 'sessionrestore', 03:39:52 INFO - 'sessionrestore_no_auto_restore', 03:39:52 INFO - 'tabpaint']}, 03:39:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['tsvgx', 03:39:52 INFO - 'tsvgr_opacity', 03:39:52 INFO - 'tart', 03:39:52 INFO - 'tscrollx', 03:39:52 INFO - 'cart', 03:39:52 INFO - 'tsvg_static']}, 03:39:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:39:52 INFO - 'tsvgr_opacity', 03:39:52 INFO - 'tart', 03:39:52 INFO - 'tscrollx', 03:39:52 INFO - 'cart', 03:39:52 INFO - 'tsvg_static']}, 03:39:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:39:52 INFO - 'talos_options': ['--disable-e10s'], 03:39:52 INFO - 'tests': ['tp5o']}, 03:39:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:39:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:39:52 INFO - 'talos_options': ['--disable-e10s', 03:39:52 INFO - '--xperf_path', 03:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:52 INFO - 'tests': ['tp5n']}, 03:39:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:39:52 INFO - 'talos_options': ['--xperf_path', 03:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:52 INFO - 'tests': ['tp5n']}}, 03:39:52 INFO - 'talos.zip': {'path': '', 03:39:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:52 INFO - Running post-action listener: _resource_record_post_action 03:39:52 INFO - [mozharness: 2017-03-21 10:39:52.961027Z] Finished populate-webroot step (success) 03:39:52 INFO - [mozharness: 2017-03-21 10:39:52.961142Z] Running create-virtualenv step. 03:39:52 INFO - Running pre-action listener: _resource_record_pre_action 03:39:52 INFO - Running main action method: create_virtualenv 03:39:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:39:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:53 INFO - Using real prefix '/tools/python27' 03:39:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:56 INFO - Installing pip.................done. 03:39:56 INFO - Return code: 0 03:39:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:39:56 INFO - Reading from file tmpfile_stdout 03:39:56 INFO - Output received: 03:39:56 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) 03:39:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:56 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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:56 INFO - 'HOME': '/Users/cltbld', 03:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:56 INFO - 'LOGNAME': 'cltbld', 03:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:56 INFO - 'MOZ_NO_REMOTE': '1', 03:39:56 INFO - 'NO_EM_RESTART': '1', 03:39:56 INFO - 'PAGER': '/bin/cat', 03:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:56 INFO - 'PWD': '/builds/slave/test', 03:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:56 INFO - 'SHELL': '/bin/bash', 03:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:39:56 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:56 INFO - 'USER': 'cltbld', 03:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:56 INFO - 'XPC_FLAGS': '0x0', 03:39:56 INFO - 'XPC_SERVICE_NAME': '0', 03:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:39:57 INFO - Cleaning up... 03:39:57 INFO - Return code: 0 03:39:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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', '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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:39: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 psutil>=3.1.1 03:39:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:39:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:57 INFO - 'HOME': '/Users/cltbld', 03:39:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:57 INFO - 'LOGNAME': 'cltbld', 03:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:57 INFO - 'MOZ_NO_REMOTE': '1', 03:39:57 INFO - 'NO_EM_RESTART': '1', 03:39:57 INFO - 'PAGER': '/bin/cat', 03:39:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:57 INFO - 'PWD': '/builds/slave/test', 03:39:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:57 INFO - 'SHELL': '/bin/bash', 03:39:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:39:57 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:39:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:57 INFO - 'USER': 'cltbld', 03:39:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:57 INFO - 'XPC_FLAGS': '0x0', 03:39:57 INFO - 'XPC_SERVICE_NAME': '0', 03:39:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:57 INFO - Downloading/unpacking psutil>=3.1.1 03:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:00 INFO - Installing collected packages: psutil 03:40:00 INFO - Running setup.py install for psutil 03:40:01 INFO - building 'psutil._psutil_osx' extension 03:40:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:40:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:40:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:40:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:40:01 INFO - building 'psutil._psutil_posix' extension 03:40:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:40:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:40:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:40:01 INFO - ^ 03:40:01 INFO - 1 warning generated. 03:40:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:02 INFO - Successfully installed psutil 03:40:02 INFO - Cleaning up... 03:40:02 INFO - Return code: 0 03:40:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:02 INFO - 'HOME': '/Users/cltbld', 03:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:02 INFO - 'LOGNAME': 'cltbld', 03:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:02 INFO - 'MOZ_NO_REMOTE': '1', 03:40:02 INFO - 'NO_EM_RESTART': '1', 03:40:02 INFO - 'PAGER': '/bin/cat', 03:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:02 INFO - 'PWD': '/builds/slave/test', 03:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:02 INFO - 'SHELL': '/bin/bash', 03:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:02 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:02 INFO - 'USER': 'cltbld', 03:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:02 INFO - 'XPC_FLAGS': '0x0', 03:40:02 INFO - 'XPC_SERVICE_NAME': '0', 03:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:05 INFO - Installing collected packages: mozsystemmonitor 03:40:05 INFO - Running setup.py install for mozsystemmonitor 03:40:05 INFO - Successfully installed mozsystemmonitor 03:40:05 INFO - Cleaning up... 03:40:05 INFO - Return code: 0 03:40:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:06 INFO - 'HOME': '/Users/cltbld', 03:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:06 INFO - 'LOGNAME': 'cltbld', 03:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:06 INFO - 'MOZ_NO_REMOTE': '1', 03:40:06 INFO - 'NO_EM_RESTART': '1', 03:40:06 INFO - 'PAGER': '/bin/cat', 03:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:06 INFO - 'PWD': '/builds/slave/test', 03:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:06 INFO - 'SHELL': '/bin/bash', 03:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:06 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:06 INFO - 'USER': 'cltbld', 03:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:06 INFO - 'XPC_FLAGS': '0x0', 03:40:06 INFO - 'XPC_SERVICE_NAME': '0', 03:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:06 INFO - Downloading/unpacking jsonschema==2.5.1 03:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:09 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:09 INFO - warning: no files found matching '*.txt' 03:40:09 INFO - no previously-included directories found matching 'build' 03:40:09 INFO - no previously-included directories found matching 'dist' 03:40:09 INFO - no previously-included directories found matching '.git*' 03:40:09 INFO - Installing collected packages: jsonschema, functools32 03:40:10 INFO - Running setup.py install for functools32 03:40:10 INFO - warning: no files found matching '*.txt' 03:40:10 INFO - no previously-included directories found matching 'build' 03:40:10 INFO - no previously-included directories found matching 'dist' 03:40:10 INFO - no previously-included directories found matching '.git*' 03:40:10 INFO - Successfully installed jsonschema functools32 03:40:10 INFO - Cleaning up... 03:40:10 INFO - Return code: 0 03:40:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:10 INFO - 'HOME': '/Users/cltbld', 03:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PAGER': '/bin/cat', 03:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:10 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - 'XPC_FLAGS': '0x0', 03:40:10 INFO - 'XPC_SERVICE_NAME': '0', 03:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:10 INFO - Cleaning up... 03:40:10 INFO - Return code: 0 03:40:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:10 INFO - 'HOME': '/Users/cltbld', 03:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PAGER': '/bin/cat', 03:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:10 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - 'XPC_FLAGS': '0x0', 03:40:10 INFO - 'XPC_SERVICE_NAME': '0', 03:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:10 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:14 INFO - Downloading docopt-0.6.1.tar.gz 03:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:14 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:14 INFO - Running setup.py install for blobuploader 03:40:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:14 INFO - Running setup.py install for requests 03:40:15 INFO - Running setup.py install for docopt 03:40:15 INFO - Successfully installed blobuploader requests docopt 03:40:15 INFO - Cleaning up... 03:40:15 INFO - Return code: 0 03:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:15 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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:15 INFO - 'HOME': '/Users/cltbld', 03:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:15 INFO - 'LOGNAME': 'cltbld', 03:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:15 INFO - 'MOZ_NO_REMOTE': '1', 03:40:15 INFO - 'NO_EM_RESTART': '1', 03:40:15 INFO - 'PAGER': '/bin/cat', 03:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:15 INFO - 'PWD': '/builds/slave/test', 03:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:15 INFO - 'SHELL': '/bin/bash', 03:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:15 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:15 INFO - 'USER': 'cltbld', 03:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:15 INFO - 'XPC_FLAGS': '0x0', 03:40:15 INFO - 'XPC_SERVICE_NAME': '0', 03:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:15 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-RAhAe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-aUwI2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-_s583y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-GzERc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-uGAeZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-yLxBxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-21GxHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-5F0cfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-Tf0hcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-WvMYnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:16 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-eDbdQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:17 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-crY5OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:17 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-9Pvgzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:17 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-bj6c7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:17 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-KO4Rtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:17 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-KC_yV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:17 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-xYzUkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:17 INFO - Running setup.py install for manifestparser 03:40:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:17 INFO - Running setup.py install for mozcrash 03:40:17 INFO - Running setup.py install for mozdebug 03:40:18 INFO - Running setup.py install for mozdevice 03:40:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Running setup.py install for mozfile 03:40:18 INFO - Running setup.py install for mozhttpd 03:40:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Running setup.py install for mozinfo 03:40:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Running setup.py install for mozInstall 03:40:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:18 INFO - Running setup.py install for mozleak 03:40:18 INFO - Running setup.py install for mozlog 03:40:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:19 INFO - Running setup.py install for moznetwork 03:40:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:19 INFO - Running setup.py install for mozprocess 03:40:19 INFO - Running setup.py install for mozprofile 03:40:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:19 INFO - Running setup.py install for mozrunner 03:40:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:19 INFO - Running setup.py install for mozscreenshot 03:40:19 INFO - Running setup.py install for moztest 03:40:20 INFO - Running setup.py install for mozversion 03:40:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:20 INFO - Cleaning up... 03:40:20 INFO - Return code: 0 03:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:20 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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:20 INFO - 'HOME': '/Users/cltbld', 03:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:20 INFO - 'LOGNAME': 'cltbld', 03:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:20 INFO - 'MOZ_NO_REMOTE': '1', 03:40:20 INFO - 'NO_EM_RESTART': '1', 03:40:20 INFO - 'PAGER': '/bin/cat', 03:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:20 INFO - 'PWD': '/builds/slave/test', 03:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:20 INFO - 'SHELL': '/bin/bash', 03:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:20 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:20 INFO - 'USER': 'cltbld', 03:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:20 INFO - 'XPC_FLAGS': '0x0', 03:40:20 INFO - 'XPC_SERVICE_NAME': '0', 03:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-QrxOgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-oltCsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:20 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)) 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-acQprD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-fURbX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:20 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)) 03:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-sWOKUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-FTiOfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-rNFlYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-QxbATi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-BtTn7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-gdPNMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-mMlDor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-6JuedG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-IAPjwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-5SwIzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:22 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)) 03:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:22 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-9naX0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:22 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-aXwJNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:22 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)) 03:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:22 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-xfSsyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:40:22 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)) 03:40:22 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)) 03:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:40:22 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)) 03:40:22 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)) 03:40:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:24 INFO - Downloading blessings-1.6.tar.gz 03:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:24 INFO - Installing collected packages: blessings 03:40:24 INFO - Running setup.py install for blessings 03:40:25 INFO - Successfully installed blessings 03:40:25 INFO - Cleaning up... 03:40:25 INFO - Return code: 0 03:40:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:25 INFO - Reading from file tmpfile_stdout 03:40:25 INFO - Current package versions: 03:40:25 INFO - blessings == 1.6 03:40:25 INFO - blobuploader == 1.2.4 03:40:25 INFO - docopt == 0.6.1 03:40:25 INFO - functools32 == 3.2.3-2 03:40:25 INFO - jsonschema == 2.5.1 03:40:25 INFO - manifestparser == 1.1 03:40:25 INFO - mozInstall == 1.12 03:40:25 INFO - mozcrash == 1.0 03:40:25 INFO - mozdebug == 0.1 03:40:25 INFO - mozdevice == 0.49 03:40:25 INFO - mozfile == 1.2 03:40:25 INFO - mozhttpd == 0.7 03:40:25 INFO - mozinfo == 0.9 03:40:25 INFO - mozleak == 0.1 03:40:25 INFO - mozlog == 3.4 03:40:25 INFO - moznetwork == 0.27 03:40:25 INFO - mozprocess == 0.25 03:40:25 INFO - mozprofile == 0.28 03:40:25 INFO - mozrunner == 6.13 03:40:25 INFO - mozscreenshot == 0.1 03:40:25 INFO - mozsystemmonitor == 0.3 03:40:25 INFO - moztest == 0.8 03:40:25 INFO - mozversion == 1.4 03:40:25 INFO - psutil == 3.1.1 03:40:25 INFO - requests == 1.2.3 03:40:25 INFO - wsgiref == 0.1.2 03:40:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:25 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 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:25 INFO - 'HOME': '/Users/cltbld', 03:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:25 INFO - 'LOGNAME': 'cltbld', 03:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:25 INFO - 'MOZ_NO_REMOTE': '1', 03:40:25 INFO - 'NO_EM_RESTART': '1', 03:40:25 INFO - 'PAGER': '/bin/cat', 03:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:25 INFO - 'PWD': '/builds/slave/test', 03:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:25 INFO - 'SHELL': '/bin/bash', 03:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:25 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:25 INFO - 'USER': 'cltbld', 03:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:25 INFO - 'XPC_FLAGS': '0x0', 03:40:25 INFO - 'XPC_SERVICE_NAME': '0', 03:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:40:25 INFO - Cleaning up... 03:40:25 INFO - Return code: 0 03:40:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fede15a4be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, '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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:25 INFO - 'HOME': '/Users/cltbld', 03:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:25 INFO - 'LOGNAME': 'cltbld', 03:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:25 INFO - 'MOZ_NO_REMOTE': '1', 03:40:25 INFO - 'NO_EM_RESTART': '1', 03:40:25 INFO - 'PAGER': '/bin/cat', 03:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:25 INFO - 'PWD': '/builds/slave/test', 03:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:25 INFO - 'SHELL': '/bin/bash', 03:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:25 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:25 INFO - 'USER': 'cltbld', 03:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:25 INFO - 'XPC_FLAGS': '0x0', 03:40:25 INFO - 'XPC_SERVICE_NAME': '0', 03:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:26 INFO - Cleaning up... 03:40:26 INFO - Return code: 0 03:40:26 INFO - Running post-action listener: _resource_record_post_action 03:40:26 INFO - Running post-action listener: _start_resource_monitoring 03:40:26 INFO - Starting resource monitoring. 03:40:26 INFO - [mozharness: 2017-03-21 10:40:26.087243Z] Finished create-virtualenv step (success) 03:40:26 INFO - [mozharness: 2017-03-21 10:40:26.088004Z] Running install step. 03:40:26 INFO - Running pre-action listener: _resource_record_pre_action 03:40:26 INFO - Running main action method: install 03:40:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:26 INFO - Reading from file tmpfile_stdout 03:40:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:26 INFO - Reading from file tmpfile_stdout 03:40:26 INFO - Output received: 03:40:26 INFO - Usage: mozinstall [options] installer 03:40:26 INFO - Options: 03:40:26 INFO - -h, --help show this help message and exit 03:40:26 INFO - -d DEST, --destination=DEST 03:40:26 INFO - Directory to install application into. [default: 03:40:26 INFO - "/builds/slave/test"] 03:40:26 INFO - --app=APP Application being installed. [default: firefox] 03:40:26 INFO - mkdir: /builds/slave/test/build/application 03:40:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:40:46 INFO - Reading from file tmpfile_stdout 03:40:46 INFO - Output received: 03:40:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:40:46 INFO - Running post-action listener: _resource_record_post_action 03:40:46 INFO - [mozharness: 2017-03-21 10:40:46.972666Z] Finished install step (success) 03:40:46 INFO - [mozharness: 2017-03-21 10:40:46.972805Z] Running run-tests step. 03:40:46 INFO - Running pre-action listener: _resource_record_pre_action 03:40:46 INFO - Running main action method: run_tests 03:40:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:40:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:40:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:40:46 INFO - 2017-03-21 03:40:46.987 screenresolution[1624:7428] starting screenresolution argv=screenresolution get 03:40:46 INFO - 2017-03-21 03:40:46.990 screenresolution[1624:7428] Display 0: 1600x1200x32@60 03:40:46 INFO - 2017-03-21 03:40:46.996 screenresolution[1625:7431] starting screenresolution argv=screenresolution list 03:40:46 INFO - Available Modes on Display 0 03:40:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:40:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:40:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:40:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:40:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:40:47 INFO - Intel Iris: 03:40:47 INFO - Chipset Model: Intel Iris 03:40:47 INFO - Type: GPU 03:40:47 INFO - Bus: Built-In 03:40:47 INFO - VRAM (Dynamic, Max): 1536 MB 03:40:47 INFO - Vendor: Intel (0x8086) 03:40:47 INFO - Device ID: 0x0a2e 03:40:47 INFO - Revision ID: 0x0009 03:40:47 INFO - Displays: 03:40:47 INFO - Display: 03:40:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:40:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:40:47 INFO - Display Serial Number: 1600x1200 60 03:40:47 INFO - Main Display: Yes 03:40:47 INFO - Mirror: Off 03:40:47 INFO - Online: Yes 03:40:47 INFO - Rotation: Supported 03:40:47 INFO - Return code: 0 03:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:47 INFO - Python 2.7.3 03:40:47 INFO - Return code: 0 03:40:47 INFO - grabbing minidump binary from tooltool 03:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:47 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 0x10257ed30>, '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 0x1024a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102573be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:40:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:40:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:40:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:47 INFO - Return code: 0 03:40:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:40:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:47 INFO - ENV: RUST_BACKTRACE is now 1 03:40:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:40:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0195 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:40:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f8qdxqnBQ1/Render', 03:40:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:47 INFO - 'HOME': '/Users/cltbld', 03:40:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:47 INFO - 'LOGNAME': 'cltbld', 03:40:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:47 INFO - 'MOZ_NO_REMOTE': '1', 03:40:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:47 INFO - 'NO_EM_RESTART': '1', 03:40:47 INFO - 'PAGER': '/bin/cat', 03:40:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:47 INFO - 'PWD': '/builds/slave/test', 03:40:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:47 INFO - 'RUST_BACKTRACE': '1', 03:40:47 INFO - 'SHELL': '/bin/bash', 03:40:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C47y6yfsT0/Listeners', 03:40:47 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:40:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:47 INFO - 'USER': 'cltbld', 03:40:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:47 INFO - 'XPC_FLAGS': '0x0', 03:40:47 INFO - 'XPC_SERVICE_NAME': '0', 03:40:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:40:47 INFO - mozversion application_buildid: 20170321022528 03:40:47 INFO - mozversion application_changeset: 1ef29f2ba069c67c95d5b0438c3fb78ec9567bba 03:40:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:47 INFO - mozversion application_name: Firefox 03:40:47 INFO - mozversion application_remotingname: firefox-dev 03:40:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:47 INFO - mozversion application_vendor: Mozilla 03:40:47 INFO - mozversion application_version: 54.0a2 03:40:47 INFO - mozversion platform_buildid: 20170321022528 03:40:47 INFO - mozversion platform_changeset: 1ef29f2ba069c67c95d5b0438c3fb78ec9567bba 03:40:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:47 INFO - mozversion platform_version: 54.0a2 03:40:47 INFO - using testdate: 1490092847 03:40:47 INFO - actual date: 1490092847 03:40:47 INFO - starting webserver on 'localhost:49249' 03:40:47 INFO - SUITE-START | Running 2 tests 03:40:47 INFO - TEST-START | dromaeo_css 03:40:47 INFO - operating with platform_type : mac_ 03:40:47 INFO - Initialising browser for dromaeo_css test... 03:40:47 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmp1deFOa/profile http://localhost:49249/getInfo.html) 03:40:49 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 03:40:49 INFO - PROCESS | 1635 | colorDepth:24 03:40:49 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 03:40:49 INFO - PROCESS | 1635 | __metrics 03:40:50 INFO - PROCESS | 1635 | 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" 03:40:50 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:40:50 INFO - TEST-INFO | 1635: exit 0 03:40:50 INFO - Browser initialized. 03:40:50 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:50 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmp1deFOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:02 INFO - PROCESS | 1637 | RSS: Main: 214806528 03:41:02 INFO - PROCESS | 1637 | 03:44:07 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 03:44:08 INFO - PROCESS | 1637 | RSS: Main: 342978560 03:44:08 INFO - PROCESS | 1637 | 03:45:52 INFO - PROCESS | 1637 | ************************* 03:45:52 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 03:45:52 INFO - PROCESS | 1637 | 03:45:52 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:45:52 INFO - PROCESS | 1637 | Full stack: 03:45:52 INFO - PROCESS | 1637 | ************************* 03:47:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 03:47:12 INFO - PROCESS | 1637 | RSS: Main: 348319744 03:47:12 INFO - PROCESS | 1637 | 03:50:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 03:50:15 INFO - PROCESS | 1637 | RSS: Main: 331571200 03:50:15 INFO - PROCESS | 1637 | 03:53:17 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 03:53:18 INFO - PROCESS | 1637 | RSS: Main: 326995968 03:53:18 INFO - PROCESS | 1637 | 03:56:22 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 03:56:22 INFO - PROCESS | 1637 | RSS: Main: 329502720 03:56:22 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 03:59:26 INFO - PROCESS | 1637 | RSS: Main: 410443776 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | __start_tp_report 03:59:26 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 03:59:26 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 03:59:26 INFO - PROCESS | 1637 | |i|pagename|runs| 03:59:26 INFO - PROCESS | 1637 | |0;dojo.html;3360.479125735511;3376.746743994201;3382.915427114322;3401.8469168887395;3414.573178352706;5766.538676905848;5855.180274761537;5873.442023007813;5927.940720592793;5929.9407005929925;4818;5854.736536855841;5890.911636325448;5903.173555702205;5920.911186332209;5301.1783173607955;5316.202569614569;5360.383555891064;5374.596905232123;5418.078926582471;5214.556762675177;5223.242629818674;5286.154215325549;5442.2380866678695;5442.482964118402;4376.3216701411175;5291.31212942317;5295.549878260353;5306.575473962073;5321.361436627591;5359.892802143974;5367.543758780508;5377.300950876381;5395.406505284415;5403.486668766461;4627.953720462786;5264.842054738326;5328.413874473805;5332.653377530448;5378.381486129106;4973.254011898208;5645.887082258332;5718.42815718429;5725.198472213893;5899.911501327483;6319.58922670025;6384.553081284312;6385.329540398237;6396.712147953307;6446.838829029265;5303.60222983274;6419.711112999879;6427.710753016078;6429.067785171171;6450.612963222222;5759.712014399263;5923.851903702399;6055.122007308915;6058.757649694051;6064.4845188158615;6344.365563443711;6371.713272902731;6397.040443933354;6428.292887782341;6431.614103153825;6350.618962862243;6364.554481186273;6364.936350636434;6368.42684158428;6373.904391434132;6344.175257216532;6367.140436041075;6413.230412350548;6426.4216220540375;6435.74257029723;6127.142200091991;6144.846378840565;6229.56393052482;6243.37566243372;6419.325970773001;6253.1245625612455;6305.527085468608;6329.461995730415;6405.135306733531;6427.325130861286;5113.71874546896;5120.513551212629;5122.641415100981;5124.590032797368;5142.922856157161;4529.614982726439;4545.13642407948;4546.386237857913;4559.224931761609;4590.104929538707;5667.659940403589;5722.914156287659;5810.070388737866;5838.328592211865;5924.9703751480965;6397;6413.102165696806;6418.1656384669695;6426.453751431087;6428.357164283534;5930.970345148246;5940.316863560746;5947.732352044169;5948.940510594925;5949.137375080589;5372.462753724674;5412.7293635318865;5517.862053448615;5590.301212348457;5595.21666966625;6362.968185159137;6367.299597044229;6371.681415929278;6375.362463753773;6377.330380310001;6353.36466353361;6357.96821015892;6367.172267605181;6371;6405.583637063576;6499.155109835691;6571.5399922005;6581.045748366556;6582;6586.506012049212;6436.034594810816;6443.0335449682925;6446.226452825691;6452.516061295515;6470.579412338183;6171.290301615192;6378.138951241709;6422.421982021454;6428.8071357859335;6429.324920883427;6193.690315484298;6250.874982500233;6312.2740884796995;6315.589486683534;6322.2729386119345;6096.969515152573;6308.053791931247;6313.589616674902;6323.051542268697;6324.3991820776955;5868.471837534642;5937.139114828239;6132.509399248139;6165.352637972948;6179.876402472015;6242.906356404566;6310.5898116622275;6331.2085989251345;6331.620102793847;6332.778352757631;6146.6004709693725;6152.015677491759;6156.969215153896;6159.4456498915315;6172.814815555541 03:59:26 INFO - PROCESS | 1637 | |1;ext.html;789.7512283630656;872.7076429396152;885.6368888755611;891.1489527501237;963.6627180486835;38155.61844381559;38714;40253.99365015876;40269.19461610766;40386;38106.23787524255;38284.80857595715;38306.61693383065;38355;38358.61641383585;7415.777526674208;7563.508371955832;7797.4931629444045;7941.166177551332;7952.761417157494;10963.232573719803;11213.383263920521;11327.943360283187;11339.149563782708;11340.546378144863;9410.623575057023;11139.33164010162;11165.38590377529;11189.776204475906;11208.551657933673;7378.778636640909;11105.888941110567;11126.109911207164;11127.610533631285;11143.888561114367;7368.778936631909;10783.083437907788;11046;11138.721531961766;11169.72075698106;40063.7996810017;40105.79947100275;40204.59795402038;40215.396769048486;40280.395794063115;3820.9426858597144;3835.5972622874474;3839.308924393608;3856.402257650069;3857.517810273716;27258.863705681542;27291.317717057034;27544.862275688494;28944.986925457717;28990.855045724635;3016.788824782266;3036.620422447194;3046.162305366042;3204.1669166016773;3268.4933835255574;336049;337021;337103.77377357194;337740;339026.304868479;39216.803915980236;51997.96004079973;52094;52189;52198.21702674463;56038.15942760862;56055.159172612446;56095.43904560984;56131;56145.71927140338;14807.963442559132;14943.701125977419;14981.850181498046;14986;15005.324760385809;12794.808077878839;12805.935970320275;12807.61577152687;12811.871881281068;12818.423170957329;11207;12956.093073484766;12979.740405192033;13042.739145217232;13064.085514014118;4542.568455996675;4807.735574543433;5054.393472783289;5277.9472205278225;5290.550303224192;935.6397786852111;1018.923580731448;1028.0215565760404;1048.1876545677162;1055.1980494823988;26960.730392696216;27682.723172768416;27874.02440914599;28181.57727634087;28277.43445131086;713.2403989750899;1140.9087273018138;1230.6062060140669;1257.3650306595111;1272.1540175783;13974.231417272147;14040.385918749653;14138.50515231962;14152.36314365856;14219.933504987168;427553;427847;429491;429794.8510257429;431624;57915.710421448464;58030.129548056815;58110.7094464525;58291.4170858286;58340.708296458244;1404.592668126232;1445.8409574946959;1451.2018389885309;1453.1063396011589;1453.9491117810826;18528.0735963204;25598.744012560383;26044;26414;26709.465810684065;35532.467012995345;44300.892477688314;44377.55622443734;44406.77796610996;44415.55584444114;422052;423521;424082;424259;425019;34640.82679586586;35256.823715881255;35261;35262;35562.46656300209;42953.57046429496;43068.56931430646;44103;44358.778206108764;44582.55417445784;26246;31383.21541961469;33992.490112647836;34225.48661770125;35456.290874181854;27000.594991074755;35589.644103559665;36497.81751091334;36950.445743313336;37356.439653404675;28991.855040724662;35787.28425431529;36423.81788091043;36443.63556364403;36686.44970325394;27463.450730985667;30444.543331850484;31908.36183276368;31939.840300798347;31989.36021279608;23915.76084239135;23976.64035039441;24085.638715418932;24548.631770523814;24567.017319307743 03:59:26 INFO - PROCESS | 1637 | |2;jquery.html;349.9405101132807;389.2837179589555;414.61647975622543;425.68073944541595;459.88962648964235;12964.351782410877;14818.259087045644;21282.787172128275;21487;21901.890490547525;22088.88955555224;22343.441413964658;22437;22628.981695823688;23021.424464388358;6392.264889537693;6439.034144878271;6605.240397354318;6692.364225398604;6697.464202863759;4137.958620413788;4440.467143942731;6408.583442076273;6558.376954189344;6560.2455717592375;7505.249475052506;7524.849503009937;7627.389808815282;7639.770806875803;7654.11977622575;7328.780136595884;7453.739119130804;7549.924500754977;7550.622468876534;7551.924480755177;7007.509474336798;7244.203137654854;7337.88993165103;7345.155307139694;7353.595552244625;24405.755942440705;26841.389516629064;27274.31814204641;27510.862445687842;27872.442551149066;2844.7013063628433;2923.4737747205495;2923.6199294091844;2925.9268518287;2959.4081183763333;16334.918325408416;16378.426755063516;16426.83573164277;16567.834321656872;16865.07242101684;1702.4722336075856;1977.0707767349322;1981.316445826202;1995.4911497568173;2008.4677560446494;125284;126458;128361;128705;130668.69331306756;17064.829351706325;17823.287068517373;20407.081681324376;21644.78355216459;21711.782882170977;36242;36907.4463883042;36963;37002.88991330264;37010.44484332737;10534.315269507457;10739.624113156002;11030.124878770628;11043.006129448388;11171.44142792857;8965.148310910583;8970.744095826589;8989.595468203946;9173.541322933826;9178.403403778733;10135.64525241613;10185.236107291834;10233.334833235816;10392.740181495372;10401.635942741968;3678.9080272993388;4309.396684464177;4339.047428657117;4377.737335759864;4399.6920215584605;917.8256131335025;923.8244733500613;935.3686261773275;938.1978408460805;979.9804003919882;21783.782162178177;22489.32532024042;22643.547129057657;22776.31671049871;22929.082836686346;878.6397576993402;934.6915517879083;941.5951141009294;961.6057416459219;962.9951850240705;11423.086153107732;11719.472623731952;12098.576549820715;12151.210171338835;12216;723178;724427;731994;739174;773338;97091;123612.38193808973;126288.36855815662;126356.36821815833;129731.96988156284;1187.7683851648846;1212.6539541109362;1253.9623811285676;1299.82452368929;1303.094349427139;18268.81731182671;18686;19291.324803631807;19518.024098794718;19578;52983.470165297855;53281.20078198908;53903.730481347346;54088.18867717066;54399;78280.60859695665;78390.51266411296;83869.58065209635;85154;85262.57368713117;11500.424978750862;11829.645110646694;11879.22785018971;11995.1003674723;12257.754844903231;13383.464661413434;13386.665333366744;13685.178889266675;13739.24434156091;13775.311234438037;11724.41377931083;11848.526058957545;11856.70358241051;11980.64058078259;12008.63974080779;11494.482748276181;11522.366269855238;11741.16343711507;11880.584179553674;11927.165098443025;11590.246633968765;11770.470328835394;12037.518499259932;12192.963598093907;12198.14612977083;11448.255863369188;11771.764564708828;11792.70518237051;12088.032957363213;12186.695332616755;11622.302661840316;11845.348505832262;11945.581904633296;12127.514899403925;12159 03:59:26 INFO - PROCESS | 1637 | |3;mootools.html;1544.2664734251232;1549.4267121165171;1574.8346423625526;1576.7240732871744;1580.841915808419;10523.473826308693;11053.00522952934;11056;11056.281341712784;11068.059214966737;10663.413512256822;10782.514786834592;11028.613998510054;11087;11108.833367499474;2387.6537902004197;2419.1412048722627;2424.2848359733835;2425.1754403502805;2426.0780903256737;2361.7756313150308;2395.940101497459;2406.085687438771;2407.2898494944034;2409.4337830609793;1956.325067851589;2355.646653002055;2381.5951288281035;2382.0352757133387;2383.678203442539;2337.8480398774027;2350.7061617297836;2363.7399886012527;2364.0307473935777;2364.75170107138;2320.2691152286975;2362.267697013931;2385;2390.438247011951;2392.7726865947707;10744;10992.120630349553;11002.394868282241;11002.779944401067;11007.724806879813;5717.857053573653;5882.588218824684;5889.352171261158;5905.970470147665;5918.852028699274;3480.3039392121423;3560;3579.158897659048;3582.0686621478344;3631.019624701316;1159.1222220003565;1182.4442512019336;1207.1851500237392;1225.7671042501986;1235.2773627427966;13372.598822035354;13563.660908477268;13935.303234838217;15133.54599362021;15354.923225383802;4565.269556870885;4739.526047395302;4744.240921452551;4779.091972525209;4780.4741478437345;11523.07815374768;11527.827082593767;11531.88468115325;11543.76912461763;11562.364069976064;4802.327674125625;4867.196912509467;4985.1276026695905;5514.172874068841;5668.433156684298;5077.796888124508;5191.065608190562;5267.868303292372;5270.578353731692;5285.497877701612;3396.3037577296595;3867.6325749053794;3934.3508321127265;3956.0703234739813;3961.3859851723028;1021.1116328793996;1036.3988886445843;1049.1134990932649;1050.1965996013057;1050.7583255851198;889.4840992224495;914.2548822709471;923.690563661181;929.3866048408019;949.4588084791741;6404.615723056631;6420.775272865428;6457.321981192001;6558.704858281389;6585.86828263432;940.6002448959165;941.3504681769693;961.3174646001278;979.3976704326788;997.6258902911409;3794.2601192767697;3939.842406303716;4043.454133691973;4049.8286764632476;4108.63022327986;12707.491700332068;13170.143940644019;13652.453901844014;13681.794773078413;13709.45162193521;13438.193708377528;13447.193168409927;13451.865481345061;13454.798178027337;13462.259575723234;9886.604535818487;10164.745881352877;10164.949175254076;10167.339122956984;10192.643257485952;6211.440970312694;6373.5857169283845;6422.903656445251;6575.868482630416;6722.025306330653;11875.049996000473;12253.081018923438;12270.81593776112;12274.324912129918;12278.140530162802;12046.578369757017;12108.394580270775;12390.132690711564;12509.374531273583;12587.370631468208;9183.862242066241;9245.445273283625;9246.861297080415;9390.154886060287;9395.859062113937;10036.598536058476;10143.54354054084;10234.283600148216;10256.641017564349;10291.691249262534;8952.507612081137;8978;9024.819503610022;9042.728718138467;9074.228690561113;7670.501417407851;8697.130286971253;8733;8861;8916.643334266557;7541.5995705851565;7618.047744031996;7685.769426917202;7695.076590808915;7721.729739459317;5640.774369025357;5650.0959846424375;5701.515371193495;5770.163326317576;5847.561432892635;4193.643540298986;5688.5733569981585;5712.285964254468;5741.569382296428;5891.027980383189 03:59:26 INFO - PROCESS | 1637 | |4;prototype.html;374.2365574228574;375.3974870333115;378.5835580861055;387.128959840359;388.20999266492686;5071.873203169923;5077.466865979074;5146.562542183914;5171.663841850277;5180.989707007135;4551.476580193279;4690.061987602485;4726.125666751654;4743.7153770773775;5061.039292014167;3394.8132852693093;4224.97887510562;4254.957450425487;4267.295896177127;4305.397244385788;3963.9207215855668;4143.979280103596;4146.398772178048;4319.460067491564;4332.631726303268;4243.766592837393;4320.870373888788;4321.697481176319;4324.762138082404;4330.812939465582;3971.1010961997904;3996.080901392696;4122.0107174278255;4179.958200418017;4249.893752656178;3326.8170250636203;3423.3153369325987;3546.2552863898613;3747.1100214220432;3825.464434979105;4225.936610950838;4267.466566679165;5001.574866136383;5032.320636714034;5054.570361519275;4470.8435204768;4862.902741945177;4897.877553061202;4924.655274130812;4968.428630707479;5199.558037566811;5400.514858413968;5417.404085550586;5427.9185812212845;5498.487915823181;3616.8479754546;4230.682698797603;4351.717138385995;4384.561543845622;4398.613067937702;4303.913921721611;4802.094732686709;5420.620556561003;5810.094952523738;5833;3888.2199227552437;4272.6154646082;4408.831659610206;4426.340122454079;4483.618892394118;3916.941245881314;4549.294859296814;4573.771311434415;4579.656525760582;4648.97675511627;4549.340345649863;4780.685311539354;4928.162212423897;4934.8766280843265;4937.395346512398;4829.9034019319415;4912.926306105412;5469.753861076261;5477.917831232535;5509.889802203934;1437.8647708153385;1480.9185494797673;1541.421966762464;1570.4503423801577;1586.341668207704;987.3039507147444;1050.3750268590177;1092.819684752007;1131.0951239008925;1151.407025381929;4439;5069.011542749202;5089.312942752755;5105.412877519058;5125.69245845243;5137.794488220504;5269.495785302731;5391.676499410048;5666.291713535808;5668.518175955008;4709.175894218498;5073.416557095981;5087.694738315713;5133.920762091359;5172.353455818023;2674.277944954851;2720.7007229204773;2767.3911739417294;2850.8454076099215;2855.600215969766;4626.761267113035;4764.97553026101;5174.456682048331;5902.61632993854;5924.940750592526;4776.54315433796;4957.380327459067;5709.314882214161;5737.540996720252;5830.883382332329;5061.367329083864;5468.398476167618;5576.609637325349;5637.746301416446;5757.625754325955;4749.881252968566;5499.780008799763;5699.316082070178;5720.3421606515785;5761.625494342854;4620.815167393266;5338.439463856239;5531.806386776443;5604;5645.661260324394;4623.745693986863;4812.06164797861;5243.292155558951;5262.947370526245;5904.0553511437965;4371.0058609851085;4631.4905360411;4687.32045344403;4925.8818707955925;4973.651844370859;5083.974580127224;5473.31583552056;5489.505944465017;5508.834734957958;5678.602497825113;4628.583427491542;4705.55297246761;5037.375850756243;5258.053550360972;5503.670279481016;5335.279737235423;5501.779928802803;5529.723513824373;5538;5544.251526044094;4398.758068306146;4683.665155430685;5075.441701412916;5326.36083669962;5356.7146282974245;4913.533214344631;5436.737957225791;5512.7519261634125;5519.420460851553;5594.580406469449;5021.472745361831;5385.973070134624;5413.24214609947;5440.953066282894;5471.467988963097 03:59:26 INFO - PROCESS | 1637 | |5;yui.html;732.9560226386413;754.1365136918229;763.522798251093;830.0993422136982;848.3806821020653;14034.859651403483;17117;17979.910100449513;17995.460136195903;18017.729734054;16476.505704828873;16558.83441165588;16575.83424165758;16629.50111496657;16961.491155265332;952.1097773581706;972.4894430424014;975.5366201054513;975.8194733974202;980.2158273381302;915.1717695485563;942.6088173408027;967.9516024198762;974.1573538888846;977.1694060048973;1024.64137551857;1029.0429900192817;1029.1149611334247;1029.23836361093;1029.8970102989679;1023.1661196125209;1023.6826583759022;1024.4263212600893;1024.6823484719762;1025.1593693171603;761.4441457735884;761.600159916043;762.1083332500987;762.2567996203712;763.7174245529134;15340.616484587863;15754.369825206977;15779.605509862346;15812.841871581368;16072.196390180561;13757.862421375758;13904.089789978427;13922.651933701638;14002.229877356742;14147.151170929674;11744.647660570197;11816.852133694378;11846.348450835287;11862.881371186264;11902.642920712393;3592.6407359264126;3608.440691692792;3697.242065376591;3718.1448266898765;3758.530183727034;95724;100998;105300.99999999923;105918;106362.46818765857;10286;10732.570697172026;10772.838407423895;10787.352758834495;11340.319580825177;22436;22492.55014899693;22520.324390268317;22545;22562.435939101324;6660.600363978177;6660.70026848793;6716.697748601325;6785.287544807724;6966.268541803139;4290.99161697001;4359.978200108979;4390.780460977002;4426.070525189682;4492.348609451611;3461;3541.8583256669444;3556.270964452281;3563.55455568054;3573.76770509916;621.9036049412258;632.2160520953984;650.1288273713247;651.1892693596502;657.2080642825384;621.9129321894939;678.7556479667315;686.1731613405834;699.2168770976539;710.705057401183;8993.505357205286;9816.263780216512;9921.65274215399;10400.635977740894;10434.947825260977;626.5144513002459;646.7574659502686;664.8271449423088;687.6664817563478;702.1083224305104;4675.472489292237;4983;5013.824516141917;5028.296038554606;5034.295198672189;90656.54671726598;96074.51962740142;97626.51186744163;97810;98201.50899245458;81811;84138;87625.56187219151;88156;89106.55446722725;54740;67862;71493.92759108513;77647;77840.83238751424;9366.953165234403;9820.705378838646;10756.408397538211;11061.778764424827;11118.110551156049;37707.81146094252;47505;47538.76230618825;47922.04155916793;50855.23717144172;51250;53232.13687520918;72470.27529724846;72672.6366368186;75681;12064.517419303129;12469.625911222678;12551.49794008266;12555.560555380518;13335.66660833487;14181.976073904501;14409.78385324242;14438.927805360907;14545.636359090684;15166.772498412753;13240;13377.331133443095;13860.861391385957;13988.720225595634;14436.711265774416;13238.67216376193;13341.733165336833;14068.788968165281;14291.499797507038;14632.780508292171;13420.46318147263;13631.591052268448;13769.518066867611;13885;13993.790093148815;10232.846507302545;10736.685657666583;11053.723656908642;11716.133904351032;12124.939375303067;10785.40680262593;11220.270682405617;11591.88408115908;11598.88401115978;11604.30374177552 03:59:26 INFO - PROCESS | 1637 | __end_tp_report 03:59:26 INFO - PROCESS | 1637 | __start_cc_report 03:59:26 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1646 03:59:26 INFO - PROCESS | 1637 | __end_cc_report 03:59:26 INFO - PROCESS | 1637 | __startTimestamp1490093966403__endTimestamp 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | ------- Summary: start ------- 03:59:26 INFO - PROCESS | 1637 | Number of tests: 6 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5870.16 Median:6146.60 stddev:685.60 (11.2%) stddev-sans-first:658.83 03:59:26 INFO - PROCESS | 1637 | Values: 3360.5 3376.7 3382.9 3401.8 3414.6 5766.5 5855.2 5873.4 5927.9 5929.9 4818.0 5854.7 5890.9 5903.2 5920.9 5301.2 5316.2 5360.4 5374.6 5418.1 5214.6 5223.2 5286.2 5442.2 5442.5 4376.3 5291.3 5295.5 5306.6 5321.4 5359.9 5367.5 5377.3 5395.4 5403.5 4628.0 5264.8 5328.4 5332.7 5378.4 4973.3 5645.9 5718.4 5725.2 5899.9 6319.6 6384.6 6385.3 6396.7 6446.8 5303.6 6419.7 6427.7 6429.1 6450.6 5759.7 5923.9 6055.1 6058.8 6064.5 6344.4 6371.7 6397.0 6428.3 6431.6 6350.6 6364.6 6364.9 6368.4 6373.9 6344.2 6367.1 6413.2 6426.4 6435.7 6127.1 6144.8 6229.6 6243.4 6419.3 6253.1 6305.5 6329.5 6405.1 6427.3 5113.7 5120.5 5122.6 5124.6 5142.9 4529.6 4545.1 4546.4 4559.2 4590.1 5667.7 5722.9 5810.1 5838.3 5925.0 6397.0 6413.1 6418.2 6426.5 6428.4 5931.0 5940.3 5947.7 5948.9 5949.1 5372.5 5412.7 5517.9 5590.3 5595.2 6363.0 6367.3 6371.7 6375.4 6377.3 6353.4 6358.0 6367.2 6371.0 6405.6 6499.2 6571.5 6581.0 6582.0 6586.5 6436.0 6443.0 6446.2 6452.5 6470.6 6171.3 6378.1 6422.4 6428.8 6429.3 6193.7 6250.9 6312.3 6315.6 6322.3 6097.0 6308.1 6313.6 6323.1 6324.4 5868.5 5937.1 6132.5 6165.4 6179.9 6242.9 6310.6 6331.2 6331.6 6332.8 6146.6 6152.0 6157.0 6159.4 6172.8 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:54235.06 Median:34433.16 stddev:105567.19 (306.6%) stddev-sans-first:105787.07 03:59:26 INFO - PROCESS | 1637 | Values: 789.8 872.7 885.6 891.1 963.7 38155.6 38714.0 40254.0 40269.2 40386.0 38106.2 38284.8 38306.6 38355.0 38358.6 7415.8 7563.5 7797.5 7941.2 7952.8 10963.2 11213.4 11327.9 11339.1 11340.5 9410.6 11139.3 11165.4 11189.8 11208.6 7378.8 11105.9 11126.1 11127.6 11143.9 7368.8 10783.1 11046.0 11138.7 11169.7 40063.8 40105.8 40204.6 40215.4 40280.4 3820.9 3835.6 3839.3 3856.4 3857.5 27258.9 27291.3 27544.9 28945.0 28990.9 3016.8 3036.6 3046.2 3204.2 3268.5 336049.0 337021.0 337103.8 337740.0 339026.3 39216.8 51998.0 52094.0 52189.0 52198.2 56038.2 56055.2 56095.4 56131.0 56145.7 14808.0 14943.7 14981.9 14986.0 15005.3 12794.8 12805.9 12807.6 12811.9 12818.4 11207.0 12956.1 12979.7 13042.7 13064.1 4542.6 4807.7 5054.4 5277.9 5290.6 935.6 1018.9 1028.0 1048.2 1055.2 26960.7 27682.7 27874.0 28181.6 28277.4 713.2 1140.9 1230.6 1257.4 1272.2 13974.2 14040.4 14138.5 14152.4 14219.9 427553.0 427847.0 429491.0 429794.9 431624.0 57915.7 58030.1 58110.7 58291.4 58340.7 1404.6 1445.8 1451.2 1453.1 1453.9 18528.1 25598.7 26044.0 26414.0 26709.5 35532.5 44300.9 44377.6 44406.8 44415.6 422052.0 423521.0 424082.0 424259.0 425019.0 34640.8 35256.8 35261.0 35262.0 35562.5 42953.6 43068.6 44103.0 44358.8 44582.6 26246.0 31383.2 33992.5 34225.5 35456.3 27000.6 35589.6 36497.8 36950.4 37356.4 28991.9 35787.3 36423.8 36443.6 36686.4 27463.5 30444.5 31908.4 31939.8 31989.4 23915.8 23976.6 24085.6 24548.6 24567.0 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:41094.70 Median:22216.17 stddev:121873.64 (548.6%) stddev-sans-first:122177.13 03:59:26 INFO - PROCESS | 1637 | Values: 349.9 389.3 414.6 425.7 459.9 12964.4 14818.3 21282.8 21487.0 21901.9 22088.9 22343.4 22437.0 22629.0 23021.4 6392.3 6439.0 6605.2 6692.4 6697.5 4138.0 4440.5 6408.6 6558.4 6560.2 7505.2 7524.8 7627.4 7639.8 7654.1 7328.8 7453.7 7549.9 7550.6 7551.9 7007.5 7244.2 7337.9 7345.2 7353.6 24405.8 26841.4 27274.3 27510.9 27872.4 2844.7 2923.5 2923.6 2925.9 2959.4 16334.9 16378.4 16426.8 16567.8 16865.1 1702.5 1977.1 1981.3 1995.5 2008.5 125284.0 126458.0 128361.0 128705.0 130668.7 17064.8 17823.3 20407.1 21644.8 21711.8 36242.0 36907.4 36963.0 37002.9 37010.4 10534.3 10739.6 11030.1 11043.0 11171.4 8965.1 8970.7 8989.6 9173.5 9178.4 10135.6 10185.2 10233.3 10392.7 10401.6 3678.9 4309.4 4339.0 4377.7 4399.7 917.8 923.8 935.4 938.2 980.0 21783.8 22489.3 22643.5 22776.3 22929.1 878.6 934.7 941.6 961.6 963.0 11423.1 11719.5 12098.6 12151.2 12216.0 723178.0 724427.0 731994.0 739174.0 773338.0 97091.0 123612.4 126288.4 126356.4 129732.0 1187.8 1212.7 1254.0 1299.8 1303.1 18268.8 18686.0 19291.3 19518.0 19578.0 52983.5 53281.2 53903.7 54088.2 54399.0 78280.6 78390.5 83869.6 85154.0 85262.6 11500.4 11829.6 11879.2 11995.1 12257.8 13383.5 13386.7 13685.2 13739.2 13775.3 11724.4 11848.5 11856.7 11980.6 12008.6 11494.5 11522.4 11741.2 11880.6 11927.2 11590.2 11770.5 12037.5 12193.0 12198.1 11448.3 11771.8 11792.7 12088.0 12186.7 11622.3 11845.3 11945.6 12127.5 12159.0 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6634.11 Median:2421.71 stddev:4144.94 (171.2%) stddev-sans-first:4138.92 03:59:26 INFO - PROCESS | 1637 | Values: 1544.3 1549.4 1574.8 1576.7 1580.8 10523.5 11053.0 11056.0 11056.3 11068.1 10663.4 10782.5 11028.6 11087.0 11108.8 2387.7 2419.1 2424.3 2425.2 2426.1 2361.8 2395.9 2406.1 2407.3 2409.4 1956.3 2355.6 2381.6 2382.0 2383.7 2337.8 2350.7 2363.7 2364.0 2364.8 2320.3 2362.3 2385.0 2390.4 2392.8 10744.0 10992.1 11002.4 11002.8 11007.7 5717.9 5882.6 5889.4 5906.0 5918.9 3480.3 3560.0 3579.2 3582.1 3631.0 1159.1 1182.4 1207.2 1225.8 1235.3 13372.6 13563.7 13935.3 15133.5 15354.9 4565.3 4739.5 4744.2 4779.1 4780.5 11523.1 11527.8 11531.9 11543.8 11562.4 4802.3 4867.2 4985.1 5514.2 5668.4 5077.8 5191.1 5267.9 5270.6 5285.5 3396.3 3867.6 3934.4 3956.1 3961.4 1021.1 1036.4 1049.1 1050.2 1050.8 889.5 914.3 923.7 929.4 949.5 6404.6 6420.8 6457.3 6558.7 6585.9 940.6 941.4 961.3 979.4 997.6 3794.3 3939.8 4043.5 4049.8 4108.6 12707.5 13170.1 13652.5 13681.8 13709.5 13438.2 13447.2 13451.9 13454.8 13462.3 9886.6 10164.7 10164.9 10167.3 10192.6 6211.4 6373.6 6422.9 6575.9 6722.0 11875.0 12253.1 12270.8 12274.3 12278.1 12046.6 12108.4 12390.1 12509.4 12587.4 9183.9 9245.4 9246.9 9390.2 9395.9 10036.6 10143.5 10234.3 10256.6 10291.7 8952.5 8978.0 9024.8 9042.7 9074.2 7670.5 8697.1 8733.0 8861.0 8916.6 7541.6 7618.0 7685.8 7695.1 7721.7 5640.8 5650.1 5701.5 5770.2 5847.6 4193.6 5688.6 5712.3 5741.6 5891.0 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4530.05 Median:4919.09 stddev:1262.64 (25.7%) stddev-sans-first:1227.05 03:59:26 INFO - PROCESS | 1637 | Values: 374.2 375.4 378.6 387.1 388.2 5071.9 5077.5 5146.6 5171.7 5181.0 4551.5 4690.1 4726.1 4743.7 5061.0 3394.8 4225.0 4255.0 4267.3 4305.4 3963.9 4144.0 4146.4 4319.5 4332.6 4243.8 4320.9 4321.7 4324.8 4330.8 3971.1 3996.1 4122.0 4180.0 4249.9 3326.8 3423.3 3546.3 3747.1 3825.5 4225.9 4267.5 5001.6 5032.3 5054.6 4470.8 4862.9 4897.9 4924.7 4968.4 5199.6 5400.5 5417.4 5427.9 5498.5 3616.8 4230.7 4351.7 4384.6 4398.6 4303.9 4802.1 5420.6 5810.1 5833.0 3888.2 4272.6 4408.8 4426.3 4483.6 3916.9 4549.3 4573.8 4579.7 4649.0 4549.3 4780.7 4928.2 4934.9 4937.4 4829.9 4912.9 5469.8 5477.9 5509.9 1437.9 1480.9 1541.4 1570.5 1586.3 987.3 1050.4 1092.8 1131.1 1151.4 4439.0 5069.0 5089.3 5105.4 5125.7 5137.8 5269.5 5391.7 5666.3 5668.5 4709.2 5073.4 5087.7 5133.9 5172.4 2674.3 2720.7 2767.4 2850.8 2855.6 4626.8 4765.0 5174.5 5902.6 5924.9 4776.5 4957.4 5709.3 5737.5 5830.9 5061.4 5468.4 5576.6 5637.7 5757.6 4749.9 5499.8 5699.3 5720.3 5761.6 4620.8 5338.4 5531.8 5604.0 5645.7 4623.7 4812.1 5243.3 5262.9 5904.1 4371.0 4631.5 4687.3 4925.9 4973.7 5084.0 5473.3 5489.5 5508.8 5678.6 4628.6 4705.6 5037.4 5258.1 5503.7 5335.3 5501.8 5529.7 5538.0 5544.3 4398.8 4683.7 5075.4 5326.4 5356.7 4913.5 5436.7 5512.8 5519.4 5594.6 5021.5 5386.0 5413.2 5441.0 5471.5 03:59:26 INFO - PROCESS | 1637 | 03:59:26 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19921.12 Median:3549.06 stddev:27842.36 (784.5%) stddev-sans-first:27883.18 03:59:26 INFO - PROCESS | 1637 | Values: 733.0 754.1 763.5 830.1 848.4 14034.9 17117.0 17979.9 17995.5 18017.7 16476.5 16558.8 16575.8 16629.5 16961.5 952.1 972.5 975.5 975.8 980.2 915.2 942.6 968.0 974.2 977.2 1024.6 1029.0 1029.1 1029.2 1029.9 1023.2 1023.7 1024.4 1024.7 1025.2 761.4 761.6 762.1 762.3 763.7 15340.6 15754.4 15779.6 15812.8 16072.2 13757.9 13904.1 13922.7 14002.2 14147.2 11744.6 11816.9 11846.3 11862.9 11902.6 3592.6 3608.4 3697.2 3718.1 3758.5 95724.0 100998.0 105301.0 105918.0 106362.5 10286.0 10732.6 10772.8 10787.4 11340.3 22436.0 22492.6 22520.3 22545.0 22562.4 6660.6 6660.7 6716.7 6785.3 6966.3 4291.0 4360.0 4390.8 4426.1 4492.3 3461.0 3541.9 3556.3 3563.6 3573.8 621.9 632.2 650.1 651.2 657.2 621.9 678.8 686.2 699.2 710.7 8993.5 9816.3 9921.7 10400.6 10434.9 626.5 646.8 664.8 687.7 702.1 4675.5 4983.0 5013.8 5028.3 5034.3 90656.5 96074.5 97626.5 97810.0 98201.5 81811.0 84138.0 87625.6 88156.0 89106.6 54740.0 67862.0 71493.9 77647.0 77840.8 9367.0 9820.7 10756.4 11061.8 11118.1 37707.8 47505.0 47538.8 47922.0 50855.2 51250.0 53232.1 72470.3 72672.6 75681.0 12064.5 12469.6 12551.5 12555.6 13335.7 14182.0 14409.8 14438.9 14545.6 15166.8 13240.0 13377.3 13860.9 13988.7 14436.7 13238.7 13341.7 14068.8 14291.5 14632.8 13420.5 13631.6 13769.5 13885.0 13993.8 10232.8 10736.7 11053.7 11716.1 12124.9 10785.4 11220.3 11591.9 11598.9 11604.3 03:59:26 INFO - PROCESS | 1637 | -------- Summary: end -------- 03:59:26 INFO - PROCESS | 1637 | 03:59:27 INFO - TEST-INFO | 1637: exit 0 03:59:27 INFO - TEST-OK | dromaeo_css | took 1119515ms 03:59:27 INFO - TEST-START | kraken 03:59:27 INFO - operating with platform_type : mac_ 03:59:27 INFO - Initialising browser for kraken test... 03:59:27 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmp1n_EOx/profile http://localhost:49249/getInfo.html) 03:59:29 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 03:59:29 INFO - PROCESS | 1652 | colorDepth:24 03:59:29 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 03:59:29 INFO - PROCESS | 1652 | __metrics 03:59:29 INFO - PROCESS | 1652 | 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" 03:59:29 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:30 INFO - TEST-INFO | 1652: exit 0 03:59:30 INFO - Browser initialized. 03:59:30 INFO - Running cycle 1/1 for kraken test... 03:59:30 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmp1n_EOx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:42 INFO - PROCESS | 1653 | RSS: Main: 214491136 03:59:42 INFO - PROCESS | 1653 | 03:59:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:46 INFO - PROCESS | 1653 | RSS: Main: 267358208 03:59:46 INFO - PROCESS | 1653 | 03:59:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 03:59:49 INFO - PROCESS | 1653 | RSS: Main: 278880256 03:59:49 INFO - PROCESS | 1653 | 03:59:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 03:59:53 INFO - PROCESS | 1653 | RSS: Main: 375959552 03:59:53 INFO - PROCESS | 1653 | 03:59:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 03:59:55 INFO - PROCESS | 1653 | RSS: Main: 279003136 03:59:55 INFO - PROCESS | 1653 | 03:59:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:58 INFO - PROCESS | 1653 | RSS: Main: 280522752 03:59:58 INFO - PROCESS | 1653 | 04:00:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:02 INFO - PROCESS | 1653 | RSS: Main: 320942080 04:00:02 INFO - PROCESS | 1653 | 04:00:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:05 INFO - PROCESS | 1653 | RSS: Main: 322306048 04:00:05 INFO - PROCESS | 1653 | 04:00:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 04:00:09 INFO - PROCESS | 1653 | RSS: Main: 318955520 04:00:09 INFO - PROCESS | 1653 | 04:00:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:11 INFO - PROCESS | 1653 | RSS: Main: 294211584 04:00:11 INFO - PROCESS | 1653 | 04:00:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:14 INFO - PROCESS | 1653 | RSS: Main: 296976384 04:00:14 INFO - PROCESS | 1653 | 04:00:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:16 INFO - PROCESS | 1653 | RSS: Main: 305401856 04:00:16 INFO - PROCESS | 1653 | 04:00:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:20 INFO - PROCESS | 1653 | RSS: Main: 319217664 04:00:20 INFO - PROCESS | 1653 | 04:00:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:24 INFO - PROCESS | 1653 | RSS: Main: 313298944 04:00:24 INFO - PROCESS | 1653 | 04:00:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 04:00:26 INFO - PROCESS | 1653 | RSS: Main: 357834752 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | __start_tp_report 04:00:26 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 04:00:26 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 04:00:26 INFO - PROCESS | 1653 | |i|pagename|runs| 04:00:26 INFO - PROCESS | 1653 | |0;ai-astar;119;116;116;117;117;116;116;116;115;115 04:00:26 INFO - PROCESS | 1653 | |1;audio-beat-detection;163;136;136;142;110;106;110;110;129;107 04:00:26 INFO - PROCESS | 1653 | |2;audio-dft;185;186;184;184;185;185;186;184;184;184 04:00:26 INFO - PROCESS | 1653 | |3;audio-fft;85;76;50;105;86;87;84;85;74;58 04:00:26 INFO - PROCESS | 1653 | |4;audio-oscillator;85;69;87;70;69;68;81;69;69;84 04:00:26 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;94;89;90;94;88;88;94;92;89;87 04:00:26 INFO - PROCESS | 1653 | |6;imaging-darkroom;93;95;95;97;95;95;95;98;94;95 04:00:26 INFO - PROCESS | 1653 | |7;imaging-desaturate;85;83;81;85;81;86;83;94;83;83 04:00:26 INFO - PROCESS | 1653 | |8;json-parse-financial;63;61;60;61;65;65;65;66;63;66 04:00:26 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;54;62;64;65;64;64;76;84;84;84 04:00:26 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;79;80;87;86;84;81;87;89;89;89 04:00:26 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;137;137;146;122;142;137;139;130;180;138 04:00:26 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;165;165;165;165;166;167;214;223;165;165 04:00:26 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;59;79;81;80;66;66;68;77;83;75 04:00:26 INFO - PROCESS | 1653 | __end_tp_report 04:00:26 INFO - PROCESS | 1653 | __start_cc_report 04:00:26 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2141 04:00:26 INFO - PROCESS | 1653 | __end_cc_report 04:00:26 INFO - PROCESS | 1653 | __startTimestamp1490094026158__endTimestamp 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | ------- Summary: start ------- 04:00:26 INFO - PROCESS | 1653 | Number of tests: 14 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:116.30 Median:116.00 stddev:1.16 (1.0%) stddev-sans-first:0.71 04:00:26 INFO - PROCESS | 1653 | Values: 119.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 115.0 115.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:124.90 Median:132.50 stddev:19.30 (14.6%) stddev-sans-first:14.74 04:00:26 INFO - PROCESS | 1653 | Values: 163.0 136.0 136.0 142.0 110.0 106.0 110.0 110.0 129.0 107.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:0.82 (0.4%) stddev-sans-first:0.87 04:00:26 INFO - PROCESS | 1653 | Values: 185.0 186.0 184.0 184.0 185.0 185.0 186.0 184.0 184.0 184.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:79.00 Median:84.50 stddev:15.64 (18.5%) stddev-sans-first:16.44 04:00:26 INFO - PROCESS | 1653 | Values: 85.0 76.0 50.0 105.0 86.0 87.0 84.0 85.0 74.0 58.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:75.50 stddev:8.02 (10.6%) stddev-sans-first:7.66 04:00:26 INFO - PROCESS | 1653 | Values: 85.0 69.0 87.0 70.0 69.0 68.0 81.0 69.0 69.0 84.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:91.00 stddev:2.76 (3.0%) stddev-sans-first:2.62 04:00:26 INFO - PROCESS | 1653 | Values: 94.0 89.0 90.0 94.0 88.0 88.0 94.0 92.0 89.0 87.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:1.40 (1.5%) stddev-sans-first:1.24 04:00:26 INFO - PROCESS | 1653 | Values: 93.0 95.0 95.0 97.0 95.0 95.0 95.0 98.0 94.0 95.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:3.75 (4.5%) stddev-sans-first:3.97 04:00:26 INFO - PROCESS | 1653 | Values: 85.0 83.0 81.0 85.0 81.0 86.0 83.0 94.0 83.0 83.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:65.00 stddev:2.22 (3.4%) stddev-sans-first:2.35 04:00:26 INFO - PROCESS | 1653 | Values: 63.0 61.0 60.0 61.0 65.0 65.0 65.0 66.0 63.0 66.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:10.94 (15.5%) stddev-sans-first:9.93 04:00:26 INFO - PROCESS | 1653 | Values: 54.0 62.0 64.0 65.0 64.0 64.0 76.0 84.0 84.0 84.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:87.00 stddev:3.87 (4.5%) stddev-sans-first:3.42 04:00:26 INFO - PROCESS | 1653 | Values: 79.0 80.0 87.0 86.0 84.0 81.0 87.0 89.0 89.0 89.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:138.50 stddev:15.24 (11.0%) stddev-sans-first:16.10 04:00:26 INFO - PROCESS | 1653 | Values: 137.0 137.0 146.0 122.0 142.0 137.0 139.0 130.0 180.0 138.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:165.50 stddev:22.51 (13.6%) stddev-sans-first:23.52 04:00:26 INFO - PROCESS | 1653 | Values: 165.0 165.0 165.0 165.0 166.0 167.0 214.0 223.0 165.0 165.0 04:00:26 INFO - PROCESS | 1653 | 04:00:26 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:78.00 stddev:8.07 (10.3%) stddev-sans-first:6.67 04:00:26 INFO - PROCESS | 1653 | Values: 59.0 79.0 81.0 80.0 66.0 66.0 68.0 77.0 83.0 75.0 04:00:26 INFO - PROCESS | 1653 | -------- Summary: end -------- 04:00:26 INFO - PROCESS | 1653 | 04:00:27 INFO - TEST-INFO | 1653: exit 0 04:00:27 INFO - TEST-OK | kraken | took 60024ms 04:00:27 INFO - SUITE-END | took 1179s 04:00:27 INFO - Completed test suite (00:19:39) 04:00:27 INFO - javascript benchmark 04:00:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7675.4670697703295, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.479125735511, 3376.746743994201, 3382.915427114322, 3401.8469168887395, 3414.573178352706, 5766.538676905848, 5855.180274761537, 5873.442023007813, 5927.940720592793, 5929.9407005929925, 4818.0, 5854.736536855841, 5890.911636325448, 5903.173555702205, 5920.911186332209, 5301.1783173607955, 5316.202569614569, 5360.383555891064, 5374.596905232123, 5418.078926582471, 5214.556762675177, 5223.242629818674, 5286.154215325549, 5442.2380866678695, 5442.482964118402, 4376.3216701411175, 5291.31212942317, 5295.549878260353, 5306.575473962073, 5321.361436627591, 5359.892802143974, 5367.543758780508, 5377.300950876381, 5395.406505284415, 5403.486668766461, 4627.953720462786, 5264.842054738326, 5328.413874473805, 5332.653377530448, 5378.381486129106, 4973.254011898208, 5645.887082258332, 5718.42815718429, 5725.198472213893, 5899.911501327483, 6319.58922670025, 6384.553081284312, 6385.329540398237, 6396.712147953307, 6446.838829029265, 5303.60222983274, 6419.711112999879, 6427.710753016078, 6429.067785171171, 6450.612963222222, 5759.712014399263, 5923.851903702399, 6055.122007308915, 6058.757649694051, 6064.4845188158615, 6344.365563443711, 6371.713272902731, 6397.040443933354, 6428.292887782341, 6431.614103153825, 6350.618962862243, 6364.554481186273, 6364.936350636434, 6368.42684158428, 6373.904391434132, 6344.175257216532, 6367.140436041075, 6413.230412350548, 6426.4216220540375, 6435.74257029723, 6127.142200091991, 6144.846378840565, 6229.56393052482, 6243.37566243372, 6419.325970773001, 6253.1245625612455, 6305.527085468608, 6329.461995730415, 6405.135306733531, 6427.325130861286, 5113.71874546896, 5120.513551212629, 5122.641415100981, 5124.590032797368, 5142.922856157161, 4529.614982726439, 4545.13642407948, 4546.386237857913, 4559.224931761609, 4590.104929538707, 5667.659940403589, 5722.914156287659, 5810.070388737866, 5838.328592211865, 5924.9703751480965, 6397.0, 6413.102165696806, 6418.1656384669695, 6426.453751431087, 6428.357164283534, 5930.970345148246, 5940.316863560746, 5947.732352044169, 5948.940510594925, 5949.137375080589, 5372.462753724674, 5412.7293635318865, 5517.862053448615, 5590.301212348457, 5595.21666966625, 6362.968185159137, 6367.299597044229, 6371.681415929278, 6375.362463753773, 6377.330380310001, 6353.36466353361, 6357.96821015892, 6367.172267605181, 6371.0, 6405.583637063576, 6499.155109835691, 6571.5399922005, 6581.045748366556, 6582.0, 6586.506012049212, 6436.034594810816, 6443.0335449682925, 6446.226452825691, 6452.516061295515, 6470.579412338183, 6171.290301615192, 6378.138951241709, 6422.421982021454, 6428.8071357859335, 6429.324920883427, 6193.690315484298, 6250.874982500233, 6312.2740884796995, 6315.589486683534, 6322.2729386119345, 6096.969515152573, 6308.053791931247, 6313.589616674902, 6323.051542268697, 6324.3991820776955, 5868.471837534642, 5937.139114828239, 6132.509399248139, 6165.352637972948, 6179.876402472015, 6242.906356404566, 6310.5898116622275, 6331.2085989251345, 6331.620102793847, 6332.778352757631, 6146.6004709693725, 6152.015677491759, 6156.969215153896, 6159.4456498915315, 6172.814815555541], "value": 5825.215681361052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.7512283630656, 872.7076429396152, 885.6368888755611, 891.1489527501237, 963.6627180486835, 38155.61844381559, 38714.0, 40253.99365015876, 40269.19461610766, 40386.0, 38106.23787524255, 38284.80857595715, 38306.61693383065, 38355.0, 38358.61641383585, 7415.777526674208, 7563.508371955832, 7797.4931629444045, 7941.166177551332, 7952.761417157494, 10963.232573719803, 11213.383263920521, 11327.943360283187, 11339.149563782708, 11340.546378144863, 9410.623575057023, 11139.33164010162, 11165.38590377529, 11189.776204475906, 11208.551657933673, 7378.778636640909, 11105.888941110567, 11126.109911207164, 11127.610533631285, 11143.888561114367, 7368.778936631909, 10783.083437907788, 11046.0, 11138.721531961766, 11169.72075698106, 40063.7996810017, 40105.79947100275, 40204.59795402038, 40215.396769048486, 40280.395794063115, 3820.9426858597144, 3835.5972622874474, 3839.308924393608, 3856.402257650069, 3857.517810273716, 27258.863705681542, 27291.317717057034, 27544.862275688494, 28944.986925457717, 28990.855045724635, 3016.788824782266, 3036.620422447194, 3046.162305366042, 3204.1669166016773, 3268.4933835255574, 336049.0, 337021.0, 337103.77377357194, 337740.0, 339026.304868479, 39216.803915980236, 51997.96004079973, 52094.0, 52189.0, 52198.21702674463, 56038.15942760862, 56055.159172612446, 56095.43904560984, 56131.0, 56145.71927140338, 14807.963442559132, 14943.701125977419, 14981.850181498046, 14986.0, 15005.324760385809, 12794.808077878839, 12805.935970320275, 12807.61577152687, 12811.871881281068, 12818.423170957329, 11207.0, 12956.093073484766, 12979.740405192033, 13042.739145217232, 13064.085514014118, 4542.568455996675, 4807.735574543433, 5054.393472783289, 5277.9472205278225, 5290.550303224192, 935.6397786852111, 1018.923580731448, 1028.0215565760404, 1048.1876545677162, 1055.1980494823988, 26960.730392696216, 27682.723172768416, 27874.02440914599, 28181.57727634087, 28277.43445131086, 713.2403989750899, 1140.9087273018138, 1230.6062060140669, 1257.3650306595111, 1272.1540175783, 13974.231417272147, 14040.385918749653, 14138.50515231962, 14152.36314365856, 14219.933504987168, 427553.0, 427847.0, 429491.0, 429794.8510257429, 431624.0, 57915.710421448464, 58030.129548056815, 58110.7094464525, 58291.4170858286, 58340.708296458244, 1404.592668126232, 1445.8409574946959, 1451.2018389885309, 1453.1063396011589, 1453.9491117810826, 18528.0735963204, 25598.744012560383, 26044.0, 26414.0, 26709.465810684065, 35532.467012995345, 44300.892477688314, 44377.55622443734, 44406.77796610996, 44415.55584444114, 422052.0, 423521.0, 424082.0, 424259.0, 425019.0, 34640.82679586586, 35256.823715881255, 35261.0, 35262.0, 35562.46656300209, 42953.57046429496, 43068.56931430646, 44103.0, 44358.778206108764, 44582.55417445784, 26246.0, 31383.21541961469, 33992.490112647836, 34225.48661770125, 35456.290874181854, 27000.594991074755, 35589.644103559665, 36497.81751091334, 36950.445743313336, 37356.439653404675, 28991.855040724662, 35787.28425431529, 36423.81788091043, 36443.63556364403, 36686.44970325394, 27463.450730985667, 30444.543331850484, 31908.36183276368, 31939.840300798347, 31989.36021279608, 23915.76084239135, 23976.64035039441, 24085.638715418932, 24548.631770523814, 24567.017319307743], "value": 18739.922823833367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9405101132807, 389.2837179589555, 414.61647975622543, 425.68073944541595, 459.88962648964235, 12964.351782410877, 14818.259087045644, 21282.787172128275, 21487.0, 21901.890490547525, 22088.88955555224, 22343.441413964658, 22437.0, 22628.981695823688, 23021.424464388358, 6392.264889537693, 6439.034144878271, 6605.240397354318, 6692.364225398604, 6697.464202863759, 4137.958620413788, 4440.467143942731, 6408.583442076273, 6558.376954189344, 6560.2455717592375, 7505.249475052506, 7524.849503009937, 7627.389808815282, 7639.770806875803, 7654.11977622575, 7328.780136595884, 7453.739119130804, 7549.924500754977, 7550.622468876534, 7551.924480755177, 7007.509474336798, 7244.203137654854, 7337.88993165103, 7345.155307139694, 7353.595552244625, 24405.755942440705, 26841.389516629064, 27274.31814204641, 27510.862445687842, 27872.442551149066, 2844.7013063628433, 2923.4737747205495, 2923.6199294091844, 2925.9268518287, 2959.4081183763333, 16334.918325408416, 16378.426755063516, 16426.83573164277, 16567.834321656872, 16865.07242101684, 1702.4722336075856, 1977.0707767349322, 1981.316445826202, 1995.4911497568173, 2008.4677560446494, 125284.0, 126458.0, 128361.0, 128705.0, 130668.69331306756, 17064.829351706325, 17823.287068517373, 20407.081681324376, 21644.78355216459, 21711.782882170977, 36242.0, 36907.4463883042, 36963.0, 37002.88991330264, 37010.44484332737, 10534.315269507457, 10739.624113156002, 11030.124878770628, 11043.006129448388, 11171.44142792857, 8965.148310910583, 8970.744095826589, 8989.595468203946, 9173.541322933826, 9178.403403778733, 10135.64525241613, 10185.236107291834, 10233.334833235816, 10392.740181495372, 10401.635942741968, 3678.9080272993388, 4309.396684464177, 4339.047428657117, 4377.737335759864, 4399.6920215584605, 917.8256131335025, 923.8244733500613, 935.3686261773275, 938.1978408460805, 979.9804003919882, 21783.782162178177, 22489.32532024042, 22643.547129057657, 22776.31671049871, 22929.082836686346, 878.6397576993402, 934.6915517879083, 941.5951141009294, 961.6057416459219, 962.9951850240705, 11423.086153107732, 11719.472623731952, 12098.576549820715, 12151.210171338835, 12216.0, 723178.0, 724427.0, 731994.0, 739174.0, 773338.0, 97091.0, 123612.38193808973, 126288.36855815662, 126356.36821815833, 129731.96988156284, 1187.7683851648846, 1212.6539541109362, 1253.9623811285676, 1299.82452368929, 1303.094349427139, 18268.81731182671, 18686.0, 19291.324803631807, 19518.024098794718, 19578.0, 52983.470165297855, 53281.20078198908, 53903.730481347346, 54088.18867717066, 54399.0, 78280.60859695665, 78390.51266411296, 83869.58065209635, 85154.0, 85262.57368713117, 11500.424978750862, 11829.645110646694, 11879.22785018971, 11995.1003674723, 12257.754844903231, 13383.464661413434, 13386.665333366744, 13685.178889266675, 13739.24434156091, 13775.311234438037, 11724.41377931083, 11848.526058957545, 11856.70358241051, 11980.64058078259, 12008.63974080779, 11494.482748276181, 11522.366269855238, 11741.16343711507, 11880.584179553674, 11927.165098443025, 11590.246633968765, 11770.470328835394, 12037.518499259932, 12192.963598093907, 12198.14612977083, 11448.255863369188, 11771.764564708828, 11792.70518237051, 12088.032957363213, 12186.695332616755, 11622.302661840316, 11845.348505832262, 11945.581904633296, 12127.514899403925, 12159.0], "value": 11612.316629996236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.2664734251232, 1549.4267121165171, 1574.8346423625526, 1576.7240732871744, 1580.841915808419, 10523.473826308693, 11053.00522952934, 11056.0, 11056.281341712784, 11068.059214966737, 10663.413512256822, 10782.514786834592, 11028.613998510054, 11087.0, 11108.833367499474, 2387.6537902004197, 2419.1412048722627, 2424.2848359733835, 2425.1754403502805, 2426.0780903256737, 2361.7756313150308, 2395.940101497459, 2406.085687438771, 2407.2898494944034, 2409.4337830609793, 1956.325067851589, 2355.646653002055, 2381.5951288281035, 2382.0352757133387, 2383.678203442539, 2337.8480398774027, 2350.7061617297836, 2363.7399886012527, 2364.0307473935777, 2364.75170107138, 2320.2691152286975, 2362.267697013931, 2385.0, 2390.438247011951, 2392.7726865947707, 10744.0, 10992.120630349553, 11002.394868282241, 11002.779944401067, 11007.724806879813, 5717.857053573653, 5882.588218824684, 5889.352171261158, 5905.970470147665, 5918.852028699274, 3480.3039392121423, 3560.0, 3579.158897659048, 3582.0686621478344, 3631.019624701316, 1159.1222220003565, 1182.4442512019336, 1207.1851500237392, 1225.7671042501986, 1235.2773627427966, 13372.598822035354, 13563.660908477268, 13935.303234838217, 15133.54599362021, 15354.923225383802, 4565.269556870885, 4739.526047395302, 4744.240921452551, 4779.091972525209, 4780.4741478437345, 11523.07815374768, 11527.827082593767, 11531.88468115325, 11543.76912461763, 11562.364069976064, 4802.327674125625, 4867.196912509467, 4985.1276026695905, 5514.172874068841, 5668.433156684298, 5077.796888124508, 5191.065608190562, 5267.868303292372, 5270.578353731692, 5285.497877701612, 3396.3037577296595, 3867.6325749053794, 3934.3508321127265, 3956.0703234739813, 3961.3859851723028, 1021.1116328793996, 1036.3988886445843, 1049.1134990932649, 1050.1965996013057, 1050.7583255851198, 889.4840992224495, 914.2548822709471, 923.690563661181, 929.3866048408019, 949.4588084791741, 6404.615723056631, 6420.775272865428, 6457.321981192001, 6558.704858281389, 6585.86828263432, 940.6002448959165, 941.3504681769693, 961.3174646001278, 979.3976704326788, 997.6258902911409, 3794.2601192767697, 3939.842406303716, 4043.454133691973, 4049.8286764632476, 4108.63022327986, 12707.491700332068, 13170.143940644019, 13652.453901844014, 13681.794773078413, 13709.45162193521, 13438.193708377528, 13447.193168409927, 13451.865481345061, 13454.798178027337, 13462.259575723234, 9886.604535818487, 10164.745881352877, 10164.949175254076, 10167.339122956984, 10192.643257485952, 6211.440970312694, 6373.5857169283845, 6422.903656445251, 6575.868482630416, 6722.025306330653, 11875.049996000473, 12253.081018923438, 12270.81593776112, 12274.324912129918, 12278.140530162802, 12046.578369757017, 12108.394580270775, 12390.132690711564, 12509.374531273583, 12587.370631468208, 9183.862242066241, 9245.445273283625, 9246.861297080415, 9390.154886060287, 9395.859062113937, 10036.598536058476, 10143.54354054084, 10234.283600148216, 10256.641017564349, 10291.691249262534, 8952.507612081137, 8978.0, 9024.819503610022, 9042.728718138467, 9074.228690561113, 7670.501417407851, 8697.130286971253, 8733.0, 8861.0, 8916.643334266557, 7541.5995705851565, 7618.047744031996, 7685.769426917202, 7695.076590808915, 7721.729739459317, 5640.774369025357, 5650.0959846424375, 5701.515371193495, 5770.163326317576, 5847.561432892635, 4193.643540298986, 5688.5733569981585, 5712.285964254468, 5741.569382296428, 5891.027980383189], "value": 5062.128693613451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.2365574228574, 375.3974870333115, 378.5835580861055, 387.128959840359, 388.20999266492686, 5071.873203169923, 5077.466865979074, 5146.562542183914, 5171.663841850277, 5180.989707007135, 4551.476580193279, 4690.061987602485, 4726.125666751654, 4743.7153770773775, 5061.039292014167, 3394.8132852693093, 4224.97887510562, 4254.957450425487, 4267.295896177127, 4305.397244385788, 3963.9207215855668, 4143.979280103596, 4146.398772178048, 4319.460067491564, 4332.631726303268, 4243.766592837393, 4320.870373888788, 4321.697481176319, 4324.762138082404, 4330.812939465582, 3971.1010961997904, 3996.080901392696, 4122.0107174278255, 4179.958200418017, 4249.893752656178, 3326.8170250636203, 3423.3153369325987, 3546.2552863898613, 3747.1100214220432, 3825.464434979105, 4225.936610950838, 4267.466566679165, 5001.574866136383, 5032.320636714034, 5054.570361519275, 4470.8435204768, 4862.902741945177, 4897.877553061202, 4924.655274130812, 4968.428630707479, 5199.558037566811, 5400.514858413968, 5417.404085550586, 5427.9185812212845, 5498.487915823181, 3616.8479754546, 4230.682698797603, 4351.717138385995, 4384.561543845622, 4398.613067937702, 4303.913921721611, 4802.094732686709, 5420.620556561003, 5810.094952523738, 5833.0, 3888.2199227552437, 4272.6154646082, 4408.831659610206, 4426.340122454079, 4483.618892394118, 3916.941245881314, 4549.294859296814, 4573.771311434415, 4579.656525760582, 4648.97675511627, 4549.340345649863, 4780.685311539354, 4928.162212423897, 4934.8766280843265, 4937.395346512398, 4829.9034019319415, 4912.926306105412, 5469.753861076261, 5477.917831232535, 5509.889802203934, 1437.8647708153385, 1480.9185494797673, 1541.421966762464, 1570.4503423801577, 1586.341668207704, 987.3039507147444, 1050.3750268590177, 1092.819684752007, 1131.0951239008925, 1151.407025381929, 4439.0, 5069.011542749202, 5089.312942752755, 5105.412877519058, 5125.69245845243, 5137.794488220504, 5269.495785302731, 5391.676499410048, 5666.291713535808, 5668.518175955008, 4709.175894218498, 5073.416557095981, 5087.694738315713, 5133.920762091359, 5172.353455818023, 2674.277944954851, 2720.7007229204773, 2767.3911739417294, 2850.8454076099215, 2855.600215969766, 4626.761267113035, 4764.97553026101, 5174.456682048331, 5902.61632993854, 5924.940750592526, 4776.54315433796, 4957.380327459067, 5709.314882214161, 5737.540996720252, 5830.883382332329, 5061.367329083864, 5468.398476167618, 5576.609637325349, 5637.746301416446, 5757.625754325955, 4749.881252968566, 5499.780008799763, 5699.316082070178, 5720.3421606515785, 5761.625494342854, 4620.815167393266, 5338.439463856239, 5531.806386776443, 5604.0, 5645.661260324394, 4623.745693986863, 4812.06164797861, 5243.292155558951, 5262.947370526245, 5904.0553511437965, 4371.0058609851085, 4631.4905360411, 4687.32045344403, 4925.8818707955925, 4973.651844370859, 5083.974580127224, 5473.31583552056, 5489.505944465017, 5508.834734957958, 5678.602497825113, 4628.583427491542, 4705.55297246761, 5037.375850756243, 5258.053550360972, 5503.670279481016, 5335.279737235423, 5501.779928802803, 5529.723513824373, 5538.0, 5544.251526044094, 4398.758068306146, 4683.665155430685, 5075.441701412916, 5326.36083669962, 5356.7146282974245, 4913.533214344631, 5436.737957225791, 5512.7519261634125, 5519.420460851553, 5594.580406469449, 5021.472745361831, 5385.973070134624, 5413.24214609947, 5440.953066282894, 5471.467988963097], "value": 4161.7226647886955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.9560226386413, 754.1365136918229, 763.522798251093, 830.0993422136982, 848.3806821020653, 14034.859651403483, 17117.0, 17979.910100449513, 17995.460136195903, 18017.729734054, 16476.505704828873, 16558.83441165588, 16575.83424165758, 16629.50111496657, 16961.491155265332, 952.1097773581706, 972.4894430424014, 975.5366201054513, 975.8194733974202, 980.2158273381302, 915.1717695485563, 942.6088173408027, 967.9516024198762, 974.1573538888846, 977.1694060048973, 1024.64137551857, 1029.0429900192817, 1029.1149611334247, 1029.23836361093, 1029.8970102989679, 1023.1661196125209, 1023.6826583759022, 1024.4263212600893, 1024.6823484719762, 1025.1593693171603, 761.4441457735884, 761.600159916043, 762.1083332500987, 762.2567996203712, 763.7174245529134, 15340.616484587863, 15754.369825206977, 15779.605509862346, 15812.841871581368, 16072.196390180561, 13757.862421375758, 13904.089789978427, 13922.651933701638, 14002.229877356742, 14147.151170929674, 11744.647660570197, 11816.852133694378, 11846.348450835287, 11862.881371186264, 11902.642920712393, 3592.6407359264126, 3608.440691692792, 3697.242065376591, 3718.1448266898765, 3758.530183727034, 95724.0, 100998.0, 105300.99999999923, 105918.0, 106362.46818765857, 10286.0, 10732.570697172026, 10772.838407423895, 10787.352758834495, 11340.319580825177, 22436.0, 22492.55014899693, 22520.324390268317, 22545.0, 22562.435939101324, 6660.600363978177, 6660.70026848793, 6716.697748601325, 6785.287544807724, 6966.268541803139, 4290.99161697001, 4359.978200108979, 4390.780460977002, 4426.070525189682, 4492.348609451611, 3461.0, 3541.8583256669444, 3556.270964452281, 3563.55455568054, 3573.76770509916, 621.9036049412258, 632.2160520953984, 650.1288273713247, 651.1892693596502, 657.2080642825384, 621.9129321894939, 678.7556479667315, 686.1731613405834, 699.2168770976539, 710.705057401183, 8993.505357205286, 9816.263780216512, 9921.65274215399, 10400.635977740894, 10434.947825260977, 626.5144513002459, 646.7574659502686, 664.8271449423088, 687.6664817563478, 702.1083224305104, 4675.472489292237, 4983.0, 5013.824516141917, 5028.296038554606, 5034.295198672189, 90656.54671726598, 96074.51962740142, 97626.51186744163, 97810.0, 98201.50899245458, 81811.0, 84138.0, 87625.56187219151, 88156.0, 89106.55446722725, 54740.0, 67862.0, 71493.92759108513, 77647.0, 77840.83238751424, 9366.953165234403, 9820.705378838646, 10756.408397538211, 11061.778764424827, 11118.110551156049, 37707.81146094252, 47505.0, 47538.76230618825, 47922.04155916793, 50855.23717144172, 51250.0, 53232.13687520918, 72470.27529724846, 72672.6366368186, 75681.0, 12064.517419303129, 12469.625911222678, 12551.49794008266, 12555.560555380518, 13335.66660833487, 14181.976073904501, 14409.78385324242, 14438.927805360907, 14545.636359090684, 15166.772498412753, 13240.0, 13377.331133443095, 13860.861391385957, 13988.720225595634, 14436.711265774416, 13238.67216376193, 13341.733165336833, 14068.788968165281, 14291.499797507038, 14632.780508292171, 13420.46318147263, 13631.591052268448, 13769.518066867611, 13885.0, 13993.790093148815, 10232.846507302545, 10736.685657666583, 11053.723656908642, 11716.133904351032, 12124.939375303067, 10785.40680262593, 11220.270682405617, 11591.88408115908, 11598.88401115978, 11604.30374177552], "value": 7655.6378593594645, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 115.0, 115.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 136.0, 136.0, 142.0, 110.0, 106.0, 110.0, 110.0, 129.0, 107.0], "value": 124.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 184.0, 184.0, 185.0, 185.0, 186.0, 184.0, 184.0, 184.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 50.0, 105.0, 86.0, 87.0, 84.0, 85.0, 74.0, 58.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 87.0, 70.0, 69.0, 68.0, 81.0, 69.0, 69.0, 84.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 89.0, 90.0, 94.0, 88.0, 88.0, 94.0, 92.0, 89.0, 87.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 98.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 81.0, 85.0, 81.0, 86.0, 83.0, 94.0, 83.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 61.0, 65.0, 65.0, 65.0, 66.0, 63.0, 66.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 64.0, 65.0, 64.0, 64.0, 76.0, 84.0, 84.0, 84.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 87.0, 86.0, 84.0, 81.0, 87.0, 89.0, 89.0, 89.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 146.0, 122.0, 142.0, 137.0, 139.0, 130.0, 180.0, 138.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 165.0, 166.0, 167.0, 214.0, 223.0, 165.0, 165.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 79.0, 81.0, 80.0, 66.0, 66.0, 68.0, 77.0, 83.0, 75.0], "value": 73.4, "unit": "score"}]}]} 04:00:27 INFO - Return code: 0 04:00:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:27 ERROR - # TBPL SUCCESS # 04:00:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:00:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:00:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:00:27 INFO - 2017-03-21 04:00:27.480 screenresolution[1657:9892] starting screenresolution argv=screenresolution get 04:00:27 INFO - 2017-03-21 04:00:27.482 screenresolution[1657:9892] Display 0: 1600x1200x32@60 04:00:27 INFO - 2017-03-21 04:00:27.489 screenresolution[1658:9895] starting screenresolution argv=screenresolution list 04:00:27 INFO - Available Modes on Display 0 04:00:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:00:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:00:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:00:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:00:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:00:27 INFO - Intel Iris: 04:00:27 INFO - Chipset Model: Intel Iris 04:00:27 INFO - Type: GPU 04:00:27 INFO - Bus: Built-In 04:00:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:00:27 INFO - Vendor: Intel (0x8086) 04:00:27 INFO - Device ID: 0x0a2e 04:00:27 INFO - Revision ID: 0x0009 04:00:27 INFO - Displays: 04:00:27 INFO - Display: 04:00:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:00:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:00:27 INFO - Display Serial Number: 1600x1200 60 04:00:27 INFO - Main Display: Yes 04:00:27 INFO - Mirror: Off 04:00:27 INFO - Online: Yes 04:00:27 INFO - Rotation: Supported 04:00:27 INFO - Return code: 0 04:00:27 INFO - Running post-action listener: _resource_record_post_action 04:00:27 INFO - [mozharness: 2017-03-21 11:00:27.734365Z] Finished run-tests step (success) 04:00:27 INFO - Running post-run listener: _resource_record_post_run 04:00:27 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38851584; Write bytes: 511025664; Read time: 382; Write time: 1958 04:00:27 INFO - TinderboxPrint: CPU usage
53.8% 04:00:27 INFO - TinderboxPrint: I/O read bytes / time
38,851,584 / 382 04:00:27 INFO - TinderboxPrint: I/O write bytes / time
511,025,664 / 1,958 04:00:27 INFO - TinderboxPrint: CPU idle
2,220.9 (46.2%) 04:00:27 INFO - TinderboxPrint: CPU system
962.2 (20.0%) 04:00:27 INFO - TinderboxPrint: CPU user
1,622.7 (33.8%) 04:00:27 INFO - TinderboxPrint: Swap in / out
247,398,400 / 0 04:00:27 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200360448; Write bytes: 202950656; Read time: 16045; Write time: 450 04:00:27 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37864448; Write bytes: 298179072; Read time: 363; Write time: 1471 04:00:28 INFO - Running post-run listener: _upload_blobber_files 04:00:28 INFO - Blob upload gear active. 04:00:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:29 INFO - (blobuploader) - INFO - Done attempting. 04:00:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:30 INFO - (blobuploader) - INFO - Done attempting. 04:00:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:00:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:00:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:31 INFO - (blobuploader) - INFO - Done attempting. 04:00:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:34 INFO - (blobuploader) - INFO - Done attempting. 04:00:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:34 INFO - Return code: 0 04:00:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd3175a7fa68186572190e536cb43b1c73d600e2128005e620ba88afa2048faca4a28408b91bb6fe58a7681c0fa4c75eb51d8c8fcb055fba67d1991f4c22db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fb2d6e6c5acc8eb952c86423ab4ed54b9132166edeed54e941679de96f4445c7a4ffe91d612a9d9f524f0d9e50fe0bb98abe41894f4acb6b3e2392672093259", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecaf90c734d037dc440a9a42963d78ca26deea64f28a00d0c831975d934dafc438d1617d0966e1f083a2d8d5a3b227679b760e0990453412f8c360c9b6af13a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe599fe953f1b65cde94599ac61a976e4ed6613bdc4deca153bbbc66beb354685585e616c61588cd66a48a3933b38976cf1c213783a23579b304306d43c50d8d"} 04:00:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:34 INFO - Contents: 04:00:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd3175a7fa68186572190e536cb43b1c73d600e2128005e620ba88afa2048faca4a28408b91bb6fe58a7681c0fa4c75eb51d8c8fcb055fba67d1991f4c22db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fb2d6e6c5acc8eb952c86423ab4ed54b9132166edeed54e941679de96f4445c7a4ffe91d612a9d9f524f0d9e50fe0bb98abe41894f4acb6b3e2392672093259", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecaf90c734d037dc440a9a42963d78ca26deea64f28a00d0c831975d934dafc438d1617d0966e1f083a2d8d5a3b227679b760e0990453412f8c360c9b6af13a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe599fe953f1b65cde94599ac61a976e4ed6613bdc4deca153bbbc66beb354685585e616c61588cd66a48a3933b38976cf1c213783a23579b304306d43c50d8d"} 04:00:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:34 INFO - Copying logs to upload dir... 04:00:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.855515 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 04:00:34.662475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:00:34.666590) ========= 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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd3175a7fa68186572190e536cb43b1c73d600e2128005e620ba88afa2048faca4a28408b91bb6fe58a7681c0fa4c75eb51d8c8fcb055fba67d1991f4c22db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fb2d6e6c5acc8eb952c86423ab4ed54b9132166edeed54e941679de96f4445c7a4ffe91d612a9d9f524f0d9e50fe0bb98abe41894f4acb6b3e2392672093259", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecaf90c734d037dc440a9a42963d78ca26deea64f28a00d0c831975d934dafc438d1617d0966e1f083a2d8d5a3b227679b760e0990453412f8c360c9b6af13a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe599fe953f1b65cde94599ac61a976e4ed6613bdc4deca153bbbc66beb354685585e616c61588cd66a48a3933b38976cf1c213783a23579b304306d43c50d8d"} build_url:https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/QhkElVoESC2iaQQdabbz5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bd3175a7fa68186572190e536cb43b1c73d600e2128005e620ba88afa2048faca4a28408b91bb6fe58a7681c0fa4c75eb51d8c8fcb055fba67d1991f4c22db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fb2d6e6c5acc8eb952c86423ab4ed54b9132166edeed54e941679de96f4445c7a4ffe91d612a9d9f524f0d9e50fe0bb98abe41894f4acb6b3e2392672093259", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecaf90c734d037dc440a9a42963d78ca26deea64f28a00d0c831975d934dafc438d1617d0966e1f083a2d8d5a3b227679b760e0990453412f8c360c9b6af13a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe599fe953f1b65cde94599ac61a976e4ed6613bdc4deca153bbbc66beb354685585e616c61588cd66a48a3933b38976cf1c213783a23579b304306d43c50d8d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:00:34.701465) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:00:34.701791) ========= 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.f8qdxqnBQ1/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.C47y6yfsT0/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.005105 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:00:34.751242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:00:34.751647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:00:34.752005) ========= ========= Total master_lag: 0.17 =========