builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0278 starttime: 1489775007.17 results: success (0) buildid: 20170317104120 builduid: 145d275937164237a4942222e7b85104 revision: 81dc67758a0ff6cb85516ec417e242f5dea9290b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.168183) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.168699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.169027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.195696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.196074) ========= 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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-17 11:23:27-- 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% 11.2M=0.001s 2017-03-17 11:23:27 (11.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.362853) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.363177) ========= 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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.025438 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:27.411899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 11:23:27.412254) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 81dc67758a0ff6cb85516ec417e242f5dea9290b --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 81dc67758a0ff6cb85516ec417e242f5dea9290b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NNkgWkFTK2/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.BDHvOGLGHw/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-17 11:23:27,521 truncating revision to first 12 chars 2017-03-17 11:23:27,521 Setting DEBUG logging. 2017-03-17 11:23:27,521 attempt 1/10 2017-03-17 11:23:27,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/81dc67758a0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 11:23:28,610 unpacking tar archive at: mozilla-aurora-81dc67758a0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.364732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 11:23:28.799834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:28.800153) ========= script_repo_revision: 81dc67758a0ff6cb85516ec417e242f5dea9290b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:28.800621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:28.800927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 11:23:28.821040) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-17 11:23:28.821446) ========= /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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:23:29 INFO - MultiFileLogger online at 20170317 11:23:29 in /builds/slave/test 11:23:29 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 11:23:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:29 INFO - {'append_to_log': False, 11:23:29 INFO - 'base_work_dir': '/builds/slave/test', 11:23:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:23:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:29 INFO - 'branch': 'Mozilla-Aurora', 11:23:29 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:29 INFO - 'config_files': ('talos/mac_config.py',), 11:23:29 INFO - 'default_actions': ('clobber', 11:23:29 INFO - 'read-buildbot-config', 11:23:29 INFO - 'download-and-extract', 11:23:29 INFO - 'populate-webroot', 11:23:29 INFO - 'create-virtualenv', 11:23:29 INFO - 'install', 11:23:29 INFO - 'run-tests'), 11:23:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:29 INFO - 'download_minidump_stackwalk': True, 11:23:29 INFO - 'download_symbols': 'ondemand', 11:23:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:29 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:29 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:29 INFO - 'gecko_profile': False, 11:23:29 INFO - 'gecko_profile_interval': 0, 11:23:29 INFO - 'installer_path': 'installer.exe', 11:23:29 INFO - 'log_level': 'info', 11:23:29 INFO - 'log_name': 'talos', 11:23:29 INFO - 'log_to_console': True, 11:23:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:23:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:23:29 INFO - 'opt_config_files': (), 11:23:29 INFO - 'pip_index': False, 11:23:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:29 INFO - 'cmd': ('bash', 11:23:29 INFO - '-c', 11:23:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:29 INFO - 'enabled': True, 11:23:29 INFO - 'halt_on_failure': False, 11:23:29 INFO - 'name': 'check_screen_resolution'},), 11:23:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:29 INFO - 'cmd': ('bash', 11:23:29 INFO - '-c', 11:23:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:29 INFO - 'enabled': True, 11:23:29 INFO - 'halt_on_failure': False, 11:23:29 INFO - 'name': 'check_screen_resolution'},), 11:23:29 INFO - 'run_cmd_checks_enabled': True, 11:23:29 INFO - 'suite': 'dromaeojs', 11:23:29 INFO - 'system_bits': '32', 11:23:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:29 INFO - 'title': 't-yosemite-r7-0278', 11:23:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:29 INFO - 'use_talos_json': True, 11:23:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:29 INFO - 'work_dir': 'build'} 11:23:29 INFO - [mozharness: 2017-03-17 18:23:29.037852Z] Running clobber step. 11:23:29 INFO - Running pre-action listener: _resource_record_pre_action 11:23:29 INFO - Running main action method: clobber 11:23:29 INFO - rmtree: /builds/slave/test/build 11:23:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:31 INFO - Running post-action listener: _resource_record_post_action 11:23:31 INFO - [mozharness: 2017-03-17 18:23:31.513995Z] Finished clobber step (success) 11:23:31 INFO - [mozharness: 2017-03-17 18:23:31.514167Z] Running read-buildbot-config step. 11:23:31 INFO - Running pre-action listener: _resource_record_pre_action 11:23:31 INFO - Running main action method: read_buildbot_config 11:23:31 INFO - Using buildbot properties: 11:23:31 INFO - { 11:23:31 INFO - "project": "", 11:23:31 INFO - "product": "firefox", 11:23:31 INFO - "script_repo_revision": "production", 11:23:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:23:31 INFO - "repository": "", 11:23:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:23:31 INFO - "buildid": "20170317104120", 11:23:31 INFO - "pgo_build": "False", 11:23:31 INFO - "basedir": "/builds/slave/test", 11:23:31 INFO - "buildnumber": 67, 11:23:31 INFO - "slavename": "t-yosemite-r7-0278", 11:23:31 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:23:31 INFO - "platform": "yosemite_r7", 11:23:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:23:31 INFO - "branch": "mozilla-aurora", 11:23:31 INFO - "repo_path": "releases/mozilla-aurora", 11:23:31 INFO - "revision": "81dc67758a0ff6cb85516ec417e242f5dea9290b", 11:23:31 INFO - "stage_platform": "macosx64", 11:23:31 INFO - "builduid": "145d275937164237a4942222e7b85104", 11:23:31 INFO - "slavebuilddir": "test" 11:23:31 INFO - } 11:23:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 11:23:31 INFO - Running post-action listener: _resource_record_post_action 11:23:31 INFO - [mozharness: 2017-03-17 18:23:31.517572Z] Finished read-buildbot-config step (success) 11:23:31 INFO - [mozharness: 2017-03-17 18:23:31.517707Z] Running download-and-extract step. 11:23:31 INFO - Running pre-action listener: _resource_record_pre_action 11:23:31 INFO - Running main action method: download_and_extract 11:23:31 INFO - mkdir: /builds/slave/test/build/tests 11:23:31 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')]} 11:23:31 INFO - trying https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 11:23:31 INFO - Downloading https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/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 11:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/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 11:23:32 INFO - Downloaded 1199 bytes. 11:23:32 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 11:23:32 INFO - Using the following test package requirements: 11:23:32 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 11:23:32 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 11:23:32 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 11:23:32 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'jsshell-mac.zip'], 11:23:32 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 11:23:32 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 11:23:32 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 11:23:32 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 11:23:32 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 11:23:32 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 11:23:32 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 11:23:32 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:23:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 11:23:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:23:32 INFO - Fetch https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 11:23:34 INFO - Expected file size: 51784286 11:23:34 INFO - Obtained file size: 51784286 11:23:49 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 11:23:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 11:23:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:23:49 INFO - Fetch https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 11:23:51 INFO - Expected file size: 51784286 11:23:51 INFO - Obtained file size: 51784286 11:24:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 11:24:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:24:06 INFO - Fetch https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 11:24:07 INFO - Expected file size: 14404424 11:24:07 INFO - Obtained file size: 14404424 11:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:08 INFO - trying https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 11:24:08 INFO - Downloading https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 11:24:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/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 11:24:10 INFO - Downloaded 74618983 bytes. 11:24:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 11:24:10 INFO - mkdir: /builds/slave/test/properties 11:24:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:10 INFO - Contents: 11:24:10 INFO - build_url:https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 11:24:11 INFO - Running post-action listener: _resource_record_post_action 11:24:11 INFO - Running post-action listener: set_extra_try_arguments 11:24:11 INFO - [mozharness: 2017-03-17 18:24:11.133564Z] Finished download-and-extract step (success) 11:24:11 INFO - [mozharness: 2017-03-17 18:24:11.133693Z] Running populate-webroot step. 11:24:11 INFO - Running pre-action listener: _resource_record_pre_action 11:24:11 INFO - Running main action method: populate_webroot 11:24:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:11 INFO - '--tppagecycles', 11:24:11 INFO - '7'], 11:24:11 INFO - 'tests': ['tsvgm']}}, 11:24:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['damp', 'tps']}, 11:24:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:11 INFO - 'tests': ['damp', 'tps']}, 11:24:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['dromaeo_dom']}, 11:24:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['basic_compositor_video']}, 11:24:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:24:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tsvgx', 11:24:11 INFO - 'tsvgr_opacity', 11:24:11 INFO - 'tart', 11:24:11 INFO - 'tscrollx', 11:24:11 INFO - 'cart', 11:24:11 INFO - 'tsvg_static']}, 11:24:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:11 INFO - 'tsvgr_opacity', 11:24:11 INFO - 'tart', 11:24:11 INFO - 'tscrollx', 11:24:11 INFO - 'cart', 11:24:11 INFO - 'tsvg_static']}, 11:24:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tp5o']}, 11:24:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s', 11:24:11 INFO - '--xperf_path', 11:24:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:11 INFO - 'tests': ['tp5n']}, 11:24:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:11 INFO - 'talos_options': ['--xperf_path', 11:24:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:11 INFO - 'tests': ['tp5n']}}, 11:24:11 INFO - 'talos.zip': {'path': '', 11:24:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:11 INFO - Running post-action listener: _resource_record_post_action 11:24:11 INFO - [mozharness: 2017-03-17 18:24:11.152710Z] Finished populate-webroot step (success) 11:24:11 INFO - [mozharness: 2017-03-17 18:24:11.152837Z] Running create-virtualenv step. 11:24:11 INFO - Running pre-action listener: _resource_record_pre_action 11:24:11 INFO - Running main action method: create_virtualenv 11:24:11 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:11 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 11:24:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:11 INFO - Using real prefix '/tools/python27' 11:24:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:11 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:14 INFO - Installing pip.................done. 11:24:14 INFO - Return code: 0 11:24:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:15 INFO - Reading from file tmpfile_stdout 11:24:15 INFO - Output received: 11:24:15 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) 11:24:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:15 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:15 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 11:24:15 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 11:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:15 INFO - 'HOME': '/Users/cltbld', 11:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:15 INFO - 'LOGNAME': 'cltbld', 11:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:15 INFO - 'MOZ_NO_REMOTE': '1', 11:24:15 INFO - 'NO_EM_RESTART': '1', 11:24:15 INFO - 'PAGER': '/bin/cat', 11:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:15 INFO - 'PWD': '/builds/slave/test', 11:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:15 INFO - 'SHELL': '/bin/bash', 11:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:15 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:15 INFO - 'USER': 'cltbld', 11:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:15 INFO - 'XPC_FLAGS': '0x0', 11:24:15 INFO - 'XPC_SERVICE_NAME': '0', 11:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:15 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 11:24:15 INFO - Cleaning up... 11:24:15 INFO - Return code: 0 11:24:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:15 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:15 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 11:24:15 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 11:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:15 INFO - 'HOME': '/Users/cltbld', 11:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:15 INFO - 'LOGNAME': 'cltbld', 11:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:15 INFO - 'MOZ_NO_REMOTE': '1', 11:24:15 INFO - 'NO_EM_RESTART': '1', 11:24:15 INFO - 'PAGER': '/bin/cat', 11:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:15 INFO - 'PWD': '/builds/slave/test', 11:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:15 INFO - 'SHELL': '/bin/bash', 11:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:15 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:15 INFO - 'USER': 'cltbld', 11:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:15 INFO - 'XPC_FLAGS': '0x0', 11:24:15 INFO - 'XPC_SERVICE_NAME': '0', 11:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:15 INFO - Downloading/unpacking psutil>=3.1.1 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:19 INFO - Installing collected packages: psutil 11:24:19 INFO - Running setup.py install for psutil 11:24:19 INFO - building 'psutil._psutil_osx' extension 11:24:19 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 11:24:19 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 11:24:19 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 11:24:19 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 11:24:20 INFO - building 'psutil._psutil_posix' extension 11:24:20 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 11:24:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:24:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:24:20 INFO - ^ 11:24:20 INFO - 1 warning generated. 11:24:20 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 11:24:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:20 INFO - Successfully installed psutil 11:24:20 INFO - Cleaning up... 11:24:20 INFO - Return code: 0 11:24:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:20 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:20 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 11:24:20 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 11:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:20 INFO - 'HOME': '/Users/cltbld', 11:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:20 INFO - 'LOGNAME': 'cltbld', 11:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:20 INFO - 'MOZ_NO_REMOTE': '1', 11:24:20 INFO - 'NO_EM_RESTART': '1', 11:24:20 INFO - 'PAGER': '/bin/cat', 11:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:20 INFO - 'PWD': '/builds/slave/test', 11:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:20 INFO - 'SHELL': '/bin/bash', 11:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:20 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:20 INFO - 'USER': 'cltbld', 11:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:20 INFO - 'XPC_FLAGS': '0x0', 11:24:20 INFO - 'XPC_SERVICE_NAME': '0', 11:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:20 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 11:24:20 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 11:24:20 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 11:24:20 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 11:24:20 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 11:24:20 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 11:24:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:23 INFO - Installing collected packages: mozsystemmonitor 11:24:23 INFO - Running setup.py install for mozsystemmonitor 11:24:23 INFO - Successfully installed mozsystemmonitor 11:24:23 INFO - Cleaning up... 11:24:23 INFO - Return code: 0 11:24:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:24 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:24 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 11:24:24 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 11:24:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:24 INFO - 'HOME': '/Users/cltbld', 11:24:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:24 INFO - 'LOGNAME': 'cltbld', 11:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:24 INFO - 'MOZ_NO_REMOTE': '1', 11:24:24 INFO - 'NO_EM_RESTART': '1', 11:24:24 INFO - 'PAGER': '/bin/cat', 11:24:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:24 INFO - 'PWD': '/builds/slave/test', 11:24:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:24 INFO - 'SHELL': '/bin/bash', 11:24:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:24 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:24 INFO - 'USER': 'cltbld', 11:24:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:24 INFO - 'XPC_FLAGS': '0x0', 11:24:24 INFO - 'XPC_SERVICE_NAME': '0', 11:24:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:24 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:24 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 11:24:24 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 11:24:24 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 11:24:24 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 11:24:24 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 11:24:24 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 11:24:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:27 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 11:24:27 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 11:24:27 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 11:24:27 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 11:24:27 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 11:24:27 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 11:24:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:27 INFO - warning: no files found matching '*.txt' 11:24:27 INFO - no previously-included directories found matching 'build' 11:24:27 INFO - no previously-included directories found matching 'dist' 11:24:27 INFO - no previously-included directories found matching '.git*' 11:24:27 INFO - Installing collected packages: jsonschema, functools32 11:24:27 INFO - Running setup.py install for functools32 11:24:28 INFO - warning: no files found matching '*.txt' 11:24:28 INFO - no previously-included directories found matching 'build' 11:24:28 INFO - no previously-included directories found matching 'dist' 11:24:28 INFO - no previously-included directories found matching '.git*' 11:24:28 INFO - Successfully installed jsonschema functools32 11:24:28 INFO - Cleaning up... 11:24:28 INFO - Return code: 0 11:24:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:28 INFO - 'HOME': '/Users/cltbld', 11:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:28 INFO - 'LOGNAME': 'cltbld', 11:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:28 INFO - 'MOZ_NO_REMOTE': '1', 11:24:28 INFO - 'NO_EM_RESTART': '1', 11:24:28 INFO - 'PAGER': '/bin/cat', 11:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:28 INFO - 'PWD': '/builds/slave/test', 11:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:28 INFO - 'SHELL': '/bin/bash', 11:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:28 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:28 INFO - 'USER': 'cltbld', 11:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:28 INFO - 'XPC_FLAGS': '0x0', 11:24:28 INFO - 'XPC_SERVICE_NAME': '0', 11:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:28 INFO - Cleaning up... 11:24:28 INFO - Return code: 0 11:24:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:28 INFO - 'HOME': '/Users/cltbld', 11:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:28 INFO - 'LOGNAME': 'cltbld', 11:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:28 INFO - 'MOZ_NO_REMOTE': '1', 11:24:28 INFO - 'NO_EM_RESTART': '1', 11:24:28 INFO - 'PAGER': '/bin/cat', 11:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:28 INFO - 'PWD': '/builds/slave/test', 11:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:28 INFO - 'SHELL': '/bin/bash', 11:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:28 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:28 INFO - 'USER': 'cltbld', 11:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:28 INFO - 'XPC_FLAGS': '0x0', 11:24:28 INFO - 'XPC_SERVICE_NAME': '0', 11:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:28 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 11:24:28 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 11:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:31 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:32 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 11:24:32 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 11:24:32 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 11:24:32 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 11:24:32 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 11:24:32 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 11:24:32 INFO - Downloading docopt-0.6.1.tar.gz 11:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:32 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:32 INFO - Running setup.py install for blobuploader 11:24:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:32 INFO - Running setup.py install for requests 11:24:33 INFO - Running setup.py install for docopt 11:24:33 INFO - Successfully installed blobuploader requests docopt 11:24:33 INFO - Cleaning up... 11:24:33 INFO - Return code: 0 11:24:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:33 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:33 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 11:24:33 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 11:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:33 INFO - 'HOME': '/Users/cltbld', 11:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:33 INFO - 'LOGNAME': 'cltbld', 11:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:33 INFO - 'MOZ_NO_REMOTE': '1', 11:24:33 INFO - 'NO_EM_RESTART': '1', 11:24:33 INFO - 'PAGER': '/bin/cat', 11:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:33 INFO - 'PWD': '/builds/slave/test', 11:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:33 INFO - 'SHELL': '/bin/bash', 11:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:33 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:33 INFO - 'USER': 'cltbld', 11:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:33 INFO - 'XPC_FLAGS': '0x0', 11:24:33 INFO - 'XPC_SERVICE_NAME': '0', 11:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-UKxkAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-miukcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-kRrOpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LitGsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-xBfhj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-d04YdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-X2u8eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-QUqRnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Dh5Xy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vXSdoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-WTLavY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-K_uiwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:35 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-j8Vb9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:35 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-zzb8AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:35 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_mTmI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:35 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-BB2Lrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:35 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-oHf4Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:35 INFO - Running setup.py install for manifestparser 11:24:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:35 INFO - Running setup.py install for mozcrash 11:24:35 INFO - Running setup.py install for mozdebug 11:24:36 INFO - Running setup.py install for mozdevice 11:24:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Running setup.py install for mozfile 11:24:36 INFO - Running setup.py install for mozhttpd 11:24:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Running setup.py install for mozinfo 11:24:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Running setup.py install for mozInstall 11:24:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:36 INFO - Running setup.py install for mozleak 11:24:36 INFO - Running setup.py install for mozlog 11:24:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:37 INFO - Running setup.py install for moznetwork 11:24:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:37 INFO - Running setup.py install for mozprocess 11:24:37 INFO - Running setup.py install for mozprofile 11:24:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:37 INFO - Running setup.py install for mozrunner 11:24:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:37 INFO - Running setup.py install for mozscreenshot 11:24:37 INFO - Running setup.py install for moztest 11:24:38 INFO - Running setup.py install for mozversion 11:24:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:38 INFO - Cleaning up... 11:24:38 INFO - Return code: 0 11:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:38 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')]} 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:38 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')]} 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:38 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:38 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 11:24:38 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 11:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:38 INFO - 'HOME': '/Users/cltbld', 11:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:38 INFO - 'LOGNAME': 'cltbld', 11:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:38 INFO - 'MOZ_NO_REMOTE': '1', 11:24:38 INFO - 'NO_EM_RESTART': '1', 11:24:38 INFO - 'PAGER': '/bin/cat', 11:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:38 INFO - 'PWD': '/builds/slave/test', 11:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:38 INFO - 'SHELL': '/bin/bash', 11:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:38 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:38 INFO - 'USER': 'cltbld', 11:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:38 INFO - 'XPC_FLAGS': '0x0', 11:24:38 INFO - 'XPC_SERVICE_NAME': '0', 11:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-0on7kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:38 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)) 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-af1NzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:38 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)) 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-RvSgtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:38 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)) 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-7ChJsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:38 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)) 11:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:38 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_Nt9Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-I0HbSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-LZHABp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-k9SGx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-onPUMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ywdQXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-px15c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-5slGOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-k7zNBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-CQlcwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:39 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)) 11:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:39 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-HfLVjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:40 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)) 11:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:40 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-UYsSKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:40 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)) 11:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:40 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-SGtsPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:40 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)) 11:24:40 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)) 11:24:40 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)) 11:24:40 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)) 11:24:40 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)) 11:24:40 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)) 11:24:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:42 INFO - Downloading blessings-1.6.tar.gz 11:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:43 INFO - Installing collected packages: blessings 11:24:43 INFO - Running setup.py install for blessings 11:24:43 INFO - Successfully installed blessings 11:24:43 INFO - Cleaning up... 11:24:43 INFO - Return code: 0 11:24:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:43 INFO - Reading from file tmpfile_stdout 11:24:43 INFO - Current package versions: 11:24:43 INFO - blessings == 1.6 11:24:43 INFO - blobuploader == 1.2.4 11:24:43 INFO - docopt == 0.6.1 11:24:43 INFO - functools32 == 3.2.3-2 11:24:43 INFO - jsonschema == 2.5.1 11:24:43 INFO - manifestparser == 1.1 11:24:43 INFO - mozInstall == 1.12 11:24:43 INFO - mozcrash == 1.0 11:24:43 INFO - mozdebug == 0.1 11:24:43 INFO - mozdevice == 0.49 11:24:43 INFO - mozfile == 1.2 11:24:43 INFO - mozhttpd == 0.7 11:24:43 INFO - mozinfo == 0.9 11:24:43 INFO - mozleak == 0.1 11:24:43 INFO - mozlog == 3.4 11:24:43 INFO - moznetwork == 0.27 11:24:43 INFO - mozprocess == 0.25 11:24:43 INFO - mozprofile == 0.28 11:24:43 INFO - mozrunner == 6.13 11:24:43 INFO - mozscreenshot == 0.1 11:24:43 INFO - mozsystemmonitor == 0.3 11:24:43 INFO - moztest == 0.8 11:24:43 INFO - mozversion == 1.4 11:24:43 INFO - psutil == 3.1.1 11:24:43 INFO - requests == 1.2.3 11:24:43 INFO - wsgiref == 0.1.2 11:24:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:43 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')]} 11:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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')]} 11:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:43 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 11:24:43 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 11:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:43 INFO - 'HOME': '/Users/cltbld', 11:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:43 INFO - 'LOGNAME': 'cltbld', 11:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:43 INFO - 'MOZ_NO_REMOTE': '1', 11:24:43 INFO - 'NO_EM_RESTART': '1', 11:24:43 INFO - 'PAGER': '/bin/cat', 11:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:43 INFO - 'PWD': '/builds/slave/test', 11:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:43 INFO - 'SHELL': '/bin/bash', 11:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:43 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:43 INFO - 'USER': 'cltbld', 11:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:43 INFO - 'XPC_FLAGS': '0x0', 11:24:43 INFO - 'XPC_SERVICE_NAME': '0', 11:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 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)) 11:24:43 INFO - Cleaning up... 11:24:43 INFO - Return code: 0 11:24:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:43 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')]} 11:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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')]} 11:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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 0x1071d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba158e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, '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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 11:24:43 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 11:24:43 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 11:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:43 INFO - 'HOME': '/Users/cltbld', 11:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:43 INFO - 'LOGNAME': 'cltbld', 11:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:43 INFO - 'MOZ_NO_REMOTE': '1', 11:24:43 INFO - 'NO_EM_RESTART': '1', 11:24:43 INFO - 'PAGER': '/bin/cat', 11:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:43 INFO - 'PWD': '/builds/slave/test', 11:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:43 INFO - 'SHELL': '/bin/bash', 11:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:24:43 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:43 INFO - 'USER': 'cltbld', 11:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:43 INFO - 'XPC_FLAGS': '0x0', 11:24:43 INFO - 'XPC_SERVICE_NAME': '0', 11:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:44 INFO - Cleaning up... 11:24:44 INFO - Return code: 0 11:24:44 INFO - Running post-action listener: _resource_record_post_action 11:24:44 INFO - Running post-action listener: _start_resource_monitoring 11:24:44 INFO - Starting resource monitoring. 11:24:44 INFO - [mozharness: 2017-03-17 18:24:44.166342Z] Finished create-virtualenv step (success) 11:24:44 INFO - [mozharness: 2017-03-17 18:24:44.167301Z] Running install step. 11:24:44 INFO - Running pre-action listener: _resource_record_pre_action 11:24:44 INFO - Running main action method: install 11:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:44 INFO - Reading from file tmpfile_stdout 11:24:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:44 INFO - Reading from file tmpfile_stdout 11:24:44 INFO - Output received: 11:24:44 INFO - Usage: mozinstall [options] installer 11:24:44 INFO - Options: 11:24:44 INFO - -h, --help show this help message and exit 11:24:44 INFO - -d DEST, --destination=DEST 11:24:44 INFO - Directory to install application into. [default: 11:24:44 INFO - "/builds/slave/test"] 11:24:44 INFO - --app=APP Application being installed. [default: firefox] 11:24:44 INFO - mkdir: /builds/slave/test/build/application 11:24:44 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'] 11:24:44 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 11:25:05 INFO - Reading from file tmpfile_stdout 11:25:05 INFO - Output received: 11:25:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:25:05 INFO - Running post-action listener: _resource_record_post_action 11:25:05 INFO - [mozharness: 2017-03-17 18:25:05.138121Z] Finished install step (success) 11:25:05 INFO - [mozharness: 2017-03-17 18:25:05.138300Z] Running run-tests step. 11:25:05 INFO - Running pre-action listener: _resource_record_pre_action 11:25:05 INFO - Running main action method: run_tests 11:25:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:25:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:25:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:25:05 INFO - 2017-03-17 11:25:05.152 screenresolution[1646:7428] starting screenresolution argv=screenresolution get 11:25:05 INFO - 2017-03-17 11:25:05.155 screenresolution[1646:7428] Display 0: 1600x1200x32@60 11:25:05 INFO - 2017-03-17 11:25:05.160 screenresolution[1647:7430] starting screenresolution argv=screenresolution list 11:25:05 INFO - Available Modes on Display 0 11:25:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:25:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:25:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:25:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:25:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:25:05 INFO - Intel Iris: 11:25:05 INFO - Chipset Model: Intel Iris 11:25:05 INFO - Type: GPU 11:25:05 INFO - Bus: Built-In 11:25:05 INFO - VRAM (Dynamic, Max): 1536 MB 11:25:05 INFO - Vendor: Intel (0x8086) 11:25:05 INFO - Device ID: 0x0a2e 11:25:05 INFO - Revision ID: 0x0009 11:25:05 INFO - Displays: 11:25:05 INFO - Display: 11:25:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:25:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:25:05 INFO - Display Serial Number: 1600x1200 60 11:25:05 INFO - Main Display: Yes 11:25:05 INFO - Mirror: Off 11:25:05 INFO - Online: Yes 11:25:05 INFO - Rotation: Supported 11:25:05 INFO - Return code: 0 11:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:05 INFO - Python 2.7.3 11:25:05 INFO - Return code: 0 11:25:05 INFO - grabbing minidump binary from tooltool 11:25: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')]} 11:25:05 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 0x106fb2d30>, '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 0x106ed9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fa7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:05 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 11:25:05 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 11:25:05 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 11:25:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:05 INFO - Return code: 0 11:25:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:25:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:05 INFO - ENV: RUST_BACKTRACE is now 1 11:25:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:25:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:05 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/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 11:25:05 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/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --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 11:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNkgWkFTK2/Render', 11:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:05 INFO - 'HOME': '/Users/cltbld', 11:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:05 INFO - 'LOGNAME': 'cltbld', 11:25:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:05 INFO - 'MOZ_NO_REMOTE': '1', 11:25:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:05 INFO - 'NO_EM_RESTART': '1', 11:25:05 INFO - 'PAGER': '/bin/cat', 11:25:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:05 INFO - 'PWD': '/builds/slave/test', 11:25:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:05 INFO - 'RUST_BACKTRACE': '1', 11:25:05 INFO - 'SHELL': '/bin/bash', 11:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BDHvOGLGHw/Listeners', 11:25:05 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 11:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:05 INFO - 'USER': 'cltbld', 11:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:05 INFO - 'XPC_FLAGS': '0x0', 11:25:05 INFO - 'XPC_SERVICE_NAME': '0', 11:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:05 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/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 11:25:05 INFO - mozversion application_buildid: 20170317104120 11:25:05 INFO - mozversion application_changeset: 81dc67758a0ff6cb85516ec417e242f5dea9290b 11:25:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:25:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:05 INFO - mozversion application_name: Firefox 11:25:05 INFO - mozversion application_remotingname: firefox-dev 11:25:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:05 INFO - mozversion application_vendor: Mozilla 11:25:05 INFO - mozversion application_version: 54.0a2 11:25:05 INFO - mozversion platform_buildid: 20170317104120 11:25:05 INFO - mozversion platform_changeset: 81dc67758a0ff6cb85516ec417e242f5dea9290b 11:25:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:05 INFO - mozversion platform_version: 54.0a2 11:25:05 INFO - using testdate: 1489775105 11:25:05 INFO - actual date: 1489775105 11:25:05 INFO - starting webserver on 'localhost:49247' 11:25:05 INFO - SUITE-START | Running 2 tests 11:25:05 INFO - TEST-START | dromaeo_css 11:25:05 INFO - operating with platform_type : mac_ 11:25:05 INFO - Initialising browser for dromaeo_css test... 11:25:05 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpc9bD0q/profile http://localhost:49247/getInfo.html) 11:25:08 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 11:25:08 INFO - PROCESS | 1657 | colorDepth:24 11:25:08 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 11:25:08 INFO - PROCESS | 1657 | __metrics 11:25:08 INFO - PROCESS | 1657 | 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" 11:25:08 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:08 INFO - TEST-INFO | 1657: exit 0 11:25:08 INFO - Browser initialized. 11:25:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:08 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpc9bD0q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:20 INFO - PROCESS | 1659 | RSS: Main: 214413312 11:25:20 INFO - PROCESS | 1659 | 11:28:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 11:28:28 INFO - PROCESS | 1659 | RSS: Main: 501391360 11:28:28 INFO - PROCESS | 1659 | 11:30:10 INFO - PROCESS | 1659 | ************************* 11:30:10 INFO - PROCESS | 1659 | A coding exception was thrown and uncaught in a Task. 11:30:10 INFO - PROCESS | 1659 | 11:30:10 ERROR - PROCESS | 1659 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:30:10 INFO - PROCESS | 1659 | Full stack: 11:30:10 INFO - PROCESS | 1659 | ************************* 11:31:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 11:31:31 INFO - PROCESS | 1659 | RSS: Main: 357310464 11:31:31 INFO - PROCESS | 1659 | 11:34:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 11:34:35 INFO - PROCESS | 1659 | RSS: Main: 339443712 11:34:35 INFO - PROCESS | 1659 | 11:37:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 11:37:38 INFO - PROCESS | 1659 | RSS: Main: 319565824 11:37:38 INFO - PROCESS | 1659 | 11:40:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 11:40:42 INFO - PROCESS | 1659 | RSS: Main: 324538368 11:40:42 INFO - PROCESS | 1659 | 11:43:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 11:43:46 INFO - PROCESS | 1659 | RSS: Main: 536883200 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | __start_tp_report 11:43:46 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 11:43:46 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 11:43:46 INFO - PROCESS | 1659 | |i|pagename|runs| 11:43:46 INFO - PROCESS | 1659 | |0;dojo.html;2697.8111532192743;3184.2039490127468;3452.0679416557546;3460.8961731148074;3504.5093686883843;5902.911456328153;5910.0248459004215;5923.229980102591;6033.547483938712;6061.605995610288;5914.526837852972;5928.258967629046;5982.790602328909;6009.549283803722;6037.0340745480735;5323.467653234675;5327.600429967768;5346.973265133688;5408.161734931092;5448.318960129984;5276.498732620415;5280.841574752763;5293.9735301323635;5470.7264636768205;5500.972495137538;5334.5732341412595;5338;5340.385855626614;5341.439148889369;5341.572674186055;5322.308099947001;5331.067063263913;5347.465253474641;5353.03645343838;5355.6251062425645;5185.870353241162;5299.4435584263865;5299.655522391071;5312.521873031407;5348.010618035637;5932.7330270137945;5939.3763654816485;5943.732532036069;5947.167396564484;5952.494038006775;6264.7807326743805;6274.498040156776;6274.498040156776;6278;6288.62268263901;5305.65513241638;6265.624062556261;6275.529335299871;6283.057541368831;6344.873102537924;6027.065804800219;6074.817755467343;6077.026711276575;6079.939200607982;6094.268687757498;6240.594361366497;6578.8355291118105;6582.17722784652;6603.372679595431;6603.867922641616;6107.378548143503;6230.844228894314;6236.345183755731;6242.781502647385;6244.094606282155;4897.440360770301;6203.2245969253845;6284.4344009039405;6287.371262873676;6401.071844582602;6281.497480201573;6297.4647154992335;6313.337099604567;6315.905261421082;6323.620582765049;6325.683715814191;6327.082573026885;6348.396902294275;6350.4919606432295;6351.079093531412;5016.5485106339875;5034.395872495251;5056.494350564914;5160.045391602565;5188.377394712658;4511.075229577928;4556.72659640416;4563.361129441881;4564.977175114103;4572.108438854458;5928.822135335947;5941;5941.792037278675;5944.554158438134;5947.1376650385455;6145.8156255312415;6313.2424109107205;6346.397092276226;6346.9682651586445;6355.3326900674765;5045.9747701261995;6130.153553065287;6139.19845745766;6141.170941922873;6154.569180157346;5635.915461268084;5658.7170641467765;5659.207710920475;5662.348829884616;5701.344345400332;6309.432151106423;6361.268454127835;6417.069524918954;6634.86730265392;6684.866302674017;6330.430261276507;6350.364963503613;6355.5551111421755;6357.618542887441;6364.045393191059;6427.389398007182;6508.251551071688;6553.475721942328;6630.30381809903;6653.634050127096;6358.777442789666;6373;6375.107484952017;6387.680615969276;6395.93604063972;6363.649999250086;6364.140840986408;6367.745290188526;6381.904271436025;6393.073004414427;5135.87160320995;6111.95640283616;6142.3759981611065;6193.566450348432;6210.099535567408;6085.178500902499;6180.351063138485;6193.009118541012;6197.721102550306;6212.192414986023;6175.320714721287;6199.287081985449;6228.657423841732;6232.376762323732;6237.251529816451;6240.188775459343;6246.437820596168;6246.750129994749;6248.781292654735;6252.656103914146;5268;5820.417958204146;6051.183090282755;6140.232470941132;6152.64641778808 11:43:46 INFO - PROCESS | 1659 | |1;ext.html;696.8153439338577;810.5825499867569;871.2072014466836;884.0540621534956;964.5611246882669;32288.515672264904;37133.81433092834;37535;39009.41485877714;39498.8025059875;37500.624993750054;37706.81146594263;37739.81130094346;37755;37766.811165944135;7691.42314326425;7800.79087741401;7813.296803287703;7816.022997125359;7821.296083352498;7627.618619069052;7732.304092631662;7748.690052397926;7749.147593764681;7763.301302882739;7681.692732290701;7690.5770182639935;7699.653515591784;7704.26809453101;7753.883691744629;7554.848903021963;7616.923830761677;7684.4236682248775;7691.423143264277;7697.422693297969;6710.194776626788;6750.729970801162;6754.797356079325;6764.9323506764795;6765.9661701691175;30703.925362612426;34227.97316080522;35539.28921421583;35577.64422355769;35589;3522.1018640246575;3535.611082780892;3555.982220088883;3563.2160924596546;3656.945145822788;24238;24394.512109757707;26020.73979260221;26202;26209.60685589718;2716.5653495440833;2717.1033558925506;2719.456108778252;2725.318670332417;2811.9718802812117;365274;365743;366264;366723;368655;42222.78888605537;42756.358654620206;50459.74770126126;51089;53633;52471.73764131155;53348.933021339355;53491.73254133704;53549.1967620486;53687;14183.21992290434;14248.93133015028;14254.216018118896;14288.928555357365;14294.642633934234;12349.93825030869;12383.504659813687;12392.876071239172;12549.811752823714;12550.623481295575;11999.760004799855;12003.879961200451;12037;12055.517779288906;12084.818727719092;5670.121131224667;5694.430556944355;5703.515201207943;5712.257406537124;5719.19931209631;1054.3341520397753;1061.8266815169127;1073.6027669762238;1108.5510368300852;1113.3876367997732;22084.88957555234;25644.71776411172;26966.5955010675;27211.319717007234;27289.590656140175;983.2969426859829;1135.1883403366633;1143.6454699043322;1164.8019836627793;1170.9063274937985;12766.234025958473;13807.378667959765;13868.098573592684;13921.860781392057;14255.287235638176;431342;448537;448755;449629;449675;55042;55121.724391377786;55123.17315240275;55160;55163;1395.937182826755;1445.551878917539;1449.6955639315652;1452.5061479097158;1456.8178977627797;22435.663465048365;26048.34879128037;26176.34559136037;26421.73578264193;26590.86704566542;40245;40886.1822763549;44344.891377715816;44491;44552.33171502495;423744;423829;423858;423892;424923;32768;33579.66420335766;33598.3280334387;33660;33682.66317336795;41966.58033419749;42500;42506.36240456334;42573.722788315165;43136.7647426438;28859.85570072136;33087.338253235284;34445.31109377849;35800.28399431945;36039.63960360363;34351.65648343485;34431.827840860635;34445;35692;35703.642963571074;29007.564886526296;31783.205419864687;32367.676323237407;35804.10489737777;35873.64126358808;27664.308392290353;27759.583606246328;29176.27059323534;29647.407051859274;29763.12976412876;22651.660225096308;23176.188833390752;23210.955507001887;23394.532109358057;23436.648450272918 11:43:46 INFO - PROCESS | 1659 | |2;jquery.html;379.5900427538259;394.8795617336712;399.93831797085994;414.51501742960744;441.52756550490966;12356;17448.302067917284;20561.38315850525;21921.01355439005;22080.447988800246;20352.287669931517;20912.790872091275;21723.6741448878;22250.221242256524;22552.54894902101;5430.402655707889;6528.608283502981;6701.363370479797;6738.764143254987;6739.2249891262645;6376.234851817789;7205.711771529132;7664.118626357985;7692.230776922319;7740.109887362941;7403;7557.130929943072;7681.23187681233;7681.385489160882;7733;7103.254158313354;7407.259274072603;7568.470207085506;7609.391248700091;7657.540547567164;6103;7279.781606551759;7318.9634051829935;7331.560106393634;7339.412846972229;26165.476690466083;26259.343516412053;26597;26748.866255668792;26931.461370772475;2839.5030869597945;2851.9429611407863;2857.8428186449737;2870.8277503349864;2903.1000389878996;12861.807072893915;14844.925775371163;15964.840351596451;16000.959937604019;16840.326386944507;1945.1441365799003;1952.3069310394746;1962.941111766635;1989.4727897107277;1998.9000549972588;130729;134692;135207;135947;137403.999999999;13511.594652160451;19501.902490487457;19595.706064409045;19830.008499574964;19934.102965366594;27024.59463108055;27032.91868325245;27035;27046;28844.990425335014;9291.349605527548;9317.627294908129;9728.416295022322;9833.557489912828;9962.900370996342;6820.795376138723;7089.22018577956;7123.715051397886;7258.419326453871;8258.504489730636;7034.788956331318;8873.511956842307;9297.814043719223;9407.519217889425;9441.76395590102;3851.826667799956;3933.527976642821;3947.624975627311;3951.7233793634746;3963.3460479020637;1011.6560369474414;1025.7128004158847;1036.5853658536646;1075.6181555547669;1090.432974853088;20867.791322086585;21500.569988600142;22239.888800555895;22242.777572224393;22268.777312226994;1038.9324693895023;1061.9044286014296;1072.484291521638;1075.3762817565948;1096.4024606589269;9778.75553111178;10733.658292713411;11504.252223605607;11705.180637355474;12771.361431928552;503038;508136;512724.4363778157;646159;778616;153984;161514;164280.32177908398;166533.16733416254;167283;992.9205663546899;1229.1027549888452;1260.3383223807575;1260.3950103950156;1262.444524409257;19576;19636.312729054414;20140.798592013893;20206.89896550508;20297.69553456729;55934.44065559455;59594.40405595888;61051.69474152601;62900.05649915346;63879.04181437375;84795.72806408032;87348;88870;91110.54444727734;91649;10673;10944.945275273572;11207.271527350696;11348.829767553329;11430.428478576205;10168.644097456554;12297.815532767194;12475.126741128033;12489.875101248872;12590.24458532491;9692.079252471003;10834.133269338592;10969.067629251284;11109.166812489257;11121.388323641953;10670.8399374011;10940.39827809478;11063.834042489209;11212.607558735404;11297.322160670386;10811.081058109834;11363.488643010918;11387.54449822031;11687.539057617798;11842.052635789289;11467.139964502529;11675.3578553177;11717.60589778833;11725.706857328634;11895.643130706092;10693.251472396858;10726.517306721373;10736.30214036085;10863.239573230114;11076.833847492455 11:43:46 INFO - PROCESS | 1659 | |3;mootools.html;1540.1606124662057;1552.6351307442749;1576.5506830553295;1579.3761464221632;1587.246058122392;10212.540435680394;10730.302530335523;10731.195160362984;10748.838767418485;10756.247062705614;10402;10831.241813073068;10896.346219226853;10907.018368346848;10907.34555926645;2370.466645004873;2404.651325557793;2410.5660981023498;2411.590029694947;2416.0577374823833;2338.649202619604;2374.2165085521824;2374.9287521374386;2383.4398916254668;2394.7006624171977;2329.7087864017;2349.048635302705;2357.4106473381653;2359.256834097254;2364.4916342986253;2295.621222498286;2319.1651005637955;2319.7564255753073;2323.082382458928;2328.464453175779;2268.65970104484;2315.305408377497;2318.9188378406675;2321.419645088728;2323.9767602323927;9808.21534277256;9886.604535818558;9896.208303335716;9906.05892440217;9937.850932236022;3848.692104631623;5699.202111704365;5702.572307076985;5709.628874123168;5721.799737009226;3417.1627951151877;3466.0814884055744;3544.0962554548682;3550.2721942002086;3567.250877315767;991.2070343725063;1125.9605913792977;1137.3858116617016;1150.5397840863639;1183.4851839449866;13504.527341543097;13863.722725545533;14267.785983210364;15077.849221507755;15136.848631513763;4149.066460046526;4273.166732487197;4276.72201306914;4289.442372491556;4529.501754806968;11326.716832079264;11331.603393881174;11338;11351.772964540663;11362.375069371265;5612.017896868032;5615.6630602164005;5620.718964051781;5621.690807005654;5630.831075067755;4836.419629644465;5145.794168233228;5181.715005674724;5188.11801993662;5207.036698210767;3397.303552771725;3545.6631619996574;3781.7920014399474;3793.9241215175543;3866.7486613370043;831.6714897615408;996.9950150249348;997.576030187182;1005.2360206243308;1006.1548299428515;666.3636227402916;697.6337422853043;761.950473219239;804.7746630943345;834.6244190114472;6131.172291740647;6299.716512756937;6509.772157974543;6542.411182993458;6597.73609055642;932.4638332958576;998.2712619787595;998.9750256243652;1004.783971446128;1011.9494025298706;4097.508299004079;4108.096218831853;4119.629233369011;4207.305794543927;4240.830366785294;13218.339083046001;13561.457541698419;13570.660733481742;13591.52429664957;13633.454661813417;13479.258640774655;13534.323283835965;13545.796813047813;13548.661283467993;13607;9628.855567166498;9957.705498285177;10018.699439016842;10019.849702254473;10044.547995340226;5233.581313494988;6504.089427480251;6533.216014078341;6683.264840867598;6721.395074443323;11797.528098876292;12051.276923384625;12127.818082728943;12248.142630015813;12289.078319125923;10234.33476824004;11195.440227988405;12013.45939432745;12185.207961482476;12477.812832807334;8931.508767017616;9055.36612437123;9136.588853501742;9178.678746244117;9185;9893.406395616286;9966.152877005536;10111.89888101139;10211.183105351703;10216;9004.50475223869;9020.14308640678;9098.727038188865;9125.174965006892;9194.402363846328;8656.653733850575;8746.693865714924;8803.559822009001;8846.02693703705;8856.557172141238;7593;7621.504602200839;7693.6537855795505;7734.845303094019;7755.806104847424;5572.136318870582;5592.412796656293;5616.66300022;5829.329627092939;5967.37342579023;5708.942910571007;5733.770649173986;5860.677662728591;5916.437938395846;5967.522598192221 11:43:46 INFO - PROCESS | 1659 | |4;prototype.html;316.925522502212;370.4683778777453;377.10249605937867;377.1043771043771;378.7651655973297;4498.887527811807;4499.595036446719;5007.7496125193775;5105.192144320627;5159.613029022829;4155.33514637658;4222.472190976128;4781.569658730714;4786.56920877121;4957.330760347352;3448.293099914524;3945.9013524661827;4130.442390277304;4137.358709400048;4142.792860356985;3337.9958037765964;3689.7048236141177;4119.979400102995;4151.792410379484;4200.432941552882;3957.624025717567;4148;4174.373843923406;4180.352045432963;4201.915961680765;3944.7830369329677;4005.7396269242404;4048.898777530556;4126.071633882382;4136.296829538986;3327.4361050306316;3372.6627337266323;3756.981215093934;3767.3595488766973;3770.830312635938;4009.799510024487;4261.573842615745;4769.592970073802;4792.0895029944195;4927.310176575283;3857.4792403025513;4595.563421474954;4738.549837765407;4807.663463557552;4856.174450343415;4627.814887404534;4848.806047758121;5263.710495922723;5288.2596436498925;5363.302770639831;3601.9099522511883;3838.673712734421;4241.639460645818;4272.316429371285;4289.420928174688;3818.980905095457;5269.813027593544;5311.867203319909;5444.346678398539;5749.626274292199;3927.351986922183;4154.543000269968;4313.547077556874;4326.978365108154;4331.935020974624;3896.882494004785;4044.9595504045174;4290.528041915387;4326.762028088486;4385.824567017347;3939.783311917872;4644.6298341989195;4702.4592171899985;4728.233983119844;4734.976325118352;4557.407537020166;4943.382077240345;4952.969282594119;4995.325631039836;5031.974840125849;1354.288998275913;1434.0320283808387;1434.1968497641353;1464.8974571780086;1484.5397926642775;1015.5633077776627;1044.5456226541478;1089.1014912697058;1107.4628805029554;1123.5955056179769;4165.604267594574;4656.790444429941;4991.778658496934;5015.623828212899;5066.771995260222;4874.610031197496;4946.653734238569;5114.820981265712;5269.104252277122;5505.513511351993;4236.9364459533135;4433.623142032899;4524.9818790771815;4658.5558476872275;4852.908095678515;2396.5446565152915;2838.971610283912;2849.786266030056;2851.800373973802;2870.885164593393;5138.794448222104;5148.768305426265;5188.792448302026;5735.627184233012;5770.624909380961;4943.283223932582;5082.974585127125;5110.032637434614;5256.342957130359;5508.319962411503;4834.299026641117;5180.922286165786;5204.297419848272;5336.893262134658;5478.233047373371;4777.7372244525495;4943.65394422387;5016.448190698947;5063.265846433596;5286.444923283;5239.816606418757;5408.432114627907;5438.347398312228;5444.8094316698725;5452.928776238136;5045.621578381562;5071.416787069386;5087.796488140581;5148.43367229612;5786.450287222707;3755.868544600926;3962.077543232237;4124.298869192305;4236.068065025689;4419.403380543586;4670.136024835417;4893.535114164149;4948.901021979612;5250.632455728062;5507.642003269774;4872;5257.579393648422;5406.4052954175795;5419.861829015793;5474.343078830407;4577.862664120082;5365.490278423544;5368.221607866915;5384;5402.540784033401;4206.936895946625;5150.536451719363;5228.294180285613;5246.213068039825;5261.57907367402;4717.759064444362;5344.331958505187;5353.491418315254;5355.544778693855;5413.269208656781;4321.7406955582765;4530.88672783183;4635.490096089495;5307.57539396855;5335.546478549211 11:43:46 INFO - PROCESS | 1659 | |5;yui.html;688.2394953576302;704.2253521126761;743.9814004649883;790.1861083084423;799.7720649614861;14567.562973110797;15535.922320388396;16542.338306467744;17237.482875513724;17408.47774566762;15751.291191896364;15830.287637056332;15884.682306353867;16367.754483682755;16556.83443165568;927.8886533615959;943.8914524829629;951.9857202141974;952.5046975572698;953.0897992417259;869.9391042626987;904.1365495951351;922.9123233292827;947.7109481608106;949.178960199426;1004.8342023566103;1008.374807619277;1008.9848652270222;1009.106940357785;1009.5658866687359;1001.4241810958655;1004.4174378860243;1005.1104772276587;1005.8893521712606;1006.2101250518344;745.5601195294748;745.6458182363389;746.0674157303371;746.8207630168774;747.0512449189553;15088.019278746957;15390.999585026937;15428.614284642861;15481;15909.840901590951;13438.059335846494;13566.457341706418;13626.659333516742;13670.316484175752;13805.654858628513;9987.848729076255;11343.149263805166;11493.65519034422;11670.94164529172;11831.645050648494;3576.624454432299;3587.5336206293014;3647.6717095461536;3696.2237930034726;3802.4106263529197;104251.47874260656;109319;109421;111664;113211;10185.898141018642;10207.948960255151;10489.370637761758;10523.263371563917;10937.234393592373;21467.35597932033;21527.67708484374;21532.354029379145;21537.353879383645;21547.461313467287;7111.715531378791;7218.819529511804;7267.091613548307;7624.085109786861;7681.500702454323;3833.2525157594;4065.1259979104043;4334.241507736134;4344.413504176959;4346.500152482442;3397.8810741623925;3442.9311413772084;3478.530398396184;3493.3886569850174;3505.1412403961194;560.2632538212238;578.0981668597002;586.8444862111544;587.9029960056542;588.1559961455325;677.6340775981014;688.789919074677;693.9328169490863;705.1009962298111;715.2346988722121;9339.299552533586;9546.18387575667;9630.614775408905;9694.660686875926;10249.33379330341;561.1034702704912;602.4397310501188;605.9454649081604;647.2007071266981;705.9470539709542;4592.979089200741;4840.418388815096;4892.1830884934225;4968.378952630921;4971.45314015458;100211.49682754764;102558;102919;103812;105219;42210.15579688389;49303.52089437323;79767.60116199382;88143;90302.64546031815;69192;69486;73275.63362183262;75041;76071.61964190254;10785.298955567863;10849.240553161202;11162.274452160584;11168.274062185932;11230.7753844921;44736.552634473235;45344.546554534034;48465.5153448461;48712.5128748708;49782.755431114514;61377;61951.070733938126;63056.36943630505;63212.683936580026;63892.68053659888;11814.6953065387;12482.875171248172;12770.425330859947;12810.807837882252;13255.403506842407;14384.352704128549;14407.42370305176;14494.202818844644;14604.342804573607;15006.099634021994;13385.330733463483;13635.590932272047;13825.79261311061;14126.293685315488;14373.712525749217;10406.947965260126;13409.932950335186;13648.249346285653;13740.725185496434;13771.724565508834;13046.804297935349;13381.39783709755;13584.524541640994;13626.318684065558;13630.318484075955;9214;11005;11368.317900925971;11689.88310116888;11951.701207469883;10036.94981525117;10185.287029907835;11404.94297528507;11587.710307242387;11596.710082248012 11:43:46 INFO - PROCESS | 1659 | __end_tp_report 11:43:46 INFO - PROCESS | 1659 | __start_cc_report 11:43:46 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,3734 11:43:46 INFO - PROCESS | 1659 | __end_cc_report 11:43:46 INFO - PROCESS | 1659 | __startTimestamp1489776226097__endTimestamp 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | ------- Summary: start ------- 11:43:46 INFO - PROCESS | 1659 | Number of tests: 6 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5872.12 Median:6140.23 stddev:679.00 (11.1%) stddev-sans-first:633.78 11:43:46 INFO - PROCESS | 1659 | Values: 2697.8 3184.2 3452.1 3460.9 3504.5 5902.9 5910.0 5923.2 6033.5 6061.6 5914.5 5928.3 5982.8 6009.5 6037.0 5323.5 5327.6 5347.0 5408.2 5448.3 5276.5 5280.8 5294.0 5470.7 5501.0 5334.6 5338.0 5340.4 5341.4 5341.6 5322.3 5331.1 5347.5 5353.0 5355.6 5185.9 5299.4 5299.7 5312.5 5348.0 5932.7 5939.4 5943.7 5947.2 5952.5 6264.8 6274.5 6274.5 6278.0 6288.6 5305.7 6265.6 6275.5 6283.1 6344.9 6027.1 6074.8 6077.0 6079.9 6094.3 6240.6 6578.8 6582.2 6603.4 6603.9 6107.4 6230.8 6236.3 6242.8 6244.1 4897.4 6203.2 6284.4 6287.4 6401.1 6281.5 6297.5 6313.3 6315.9 6323.6 6325.7 6327.1 6348.4 6350.5 6351.1 5016.5 5034.4 5056.5 5160.0 5188.4 4511.1 4556.7 4563.4 4565.0 4572.1 5928.8 5941.0 5941.8 5944.6 5947.1 6145.8 6313.2 6346.4 6347.0 6355.3 5046.0 6130.2 6139.2 6141.2 6154.6 5635.9 5658.7 5659.2 5662.3 5701.3 6309.4 6361.3 6417.1 6634.9 6684.9 6330.4 6350.4 6355.6 6357.6 6364.0 6427.4 6508.3 6553.5 6630.3 6653.6 6358.8 6373.0 6375.1 6387.7 6395.9 6363.6 6364.1 6367.7 6381.9 6393.1 5135.9 6112.0 6142.4 6193.6 6210.1 6085.2 6180.4 6193.0 6197.7 6212.2 6175.3 6199.3 6228.7 6232.4 6237.3 6240.2 6246.4 6246.8 6248.8 6252.7 5268.0 5820.4 6051.2 6140.2 6152.6 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:54375.43 Median:35802.19 stddev:109737.80 (306.5%) stddev-sans-first:109971.64 11:43:46 INFO - PROCESS | 1659 | Values: 696.8 810.6 871.2 884.1 964.6 32288.5 37133.8 37535.0 39009.4 39498.8 37500.6 37706.8 37739.8 37755.0 37766.8 7691.4 7800.8 7813.3 7816.0 7821.3 7627.6 7732.3 7748.7 7749.1 7763.3 7681.7 7690.6 7699.7 7704.3 7753.9 7554.8 7616.9 7684.4 7691.4 7697.4 6710.2 6750.7 6754.8 6764.9 6766.0 30703.9 34228.0 35539.3 35577.6 35589.0 3522.1 3535.6 3556.0 3563.2 3656.9 24238.0 24394.5 26020.7 26202.0 26209.6 2716.6 2717.1 2719.5 2725.3 2812.0 365274.0 365743.0 366264.0 366723.0 368655.0 42222.8 42756.4 50459.7 51089.0 53633.0 52471.7 53348.9 53491.7 53549.2 53687.0 14183.2 14248.9 14254.2 14288.9 14294.6 12349.9 12383.5 12392.9 12549.8 12550.6 11999.8 12003.9 12037.0 12055.5 12084.8 5670.1 5694.4 5703.5 5712.3 5719.2 1054.3 1061.8 1073.6 1108.6 1113.4 22084.9 25644.7 26966.6 27211.3 27289.6 983.3 1135.2 1143.6 1164.8 1170.9 12766.2 13807.4 13868.1 13921.9 14255.3 431342.0 448537.0 448755.0 449629.0 449675.0 55042.0 55121.7 55123.2 55160.0 55163.0 1395.9 1445.6 1449.7 1452.5 1456.8 22435.7 26048.3 26176.3 26421.7 26590.9 40245.0 40886.2 44344.9 44491.0 44552.3 423744.0 423829.0 423858.0 423892.0 424923.0 32768.0 33579.7 33598.3 33660.0 33682.7 41966.6 42500.0 42506.4 42573.7 43136.8 28859.9 33087.3 34445.3 35800.3 36039.6 34351.7 34431.8 34445.0 35692.0 35703.6 29007.6 31783.2 32367.7 35804.1 35873.6 27664.3 27759.6 29176.3 29647.4 29763.1 22651.7 23176.2 23211.0 23394.5 23436.6 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:38080.88 Median:22000.73 stddev:101511.98 (461.4%) stddev-sans-first:101757.28 11:43:46 INFO - PROCESS | 1659 | Values: 379.6 394.9 399.9 414.5 441.5 12356.0 17448.3 20561.4 21921.0 22080.4 20352.3 20912.8 21723.7 22250.2 22552.5 5430.4 6528.6 6701.4 6738.8 6739.2 6376.2 7205.7 7664.1 7692.2 7740.1 7403.0 7557.1 7681.2 7681.4 7733.0 7103.3 7407.3 7568.5 7609.4 7657.5 6103.0 7279.8 7319.0 7331.6 7339.4 26165.5 26259.3 26597.0 26748.9 26931.5 2839.5 2851.9 2857.8 2870.8 2903.1 12861.8 14844.9 15964.8 16001.0 16840.3 1945.1 1952.3 1962.9 1989.5 1998.9 130729.0 134692.0 135207.0 135947.0 137404.0 13511.6 19501.9 19595.7 19830.0 19934.1 27024.6 27032.9 27035.0 27046.0 28845.0 9291.3 9317.6 9728.4 9833.6 9962.9 6820.8 7089.2 7123.7 7258.4 8258.5 7034.8 8873.5 9297.8 9407.5 9441.8 3851.8 3933.5 3947.6 3951.7 3963.3 1011.7 1025.7 1036.6 1075.6 1090.4 20867.8 21500.6 22239.9 22242.8 22268.8 1038.9 1061.9 1072.5 1075.4 1096.4 9778.8 10733.7 11504.3 11705.2 12771.4 503038.0 508136.0 512724.4 646159.0 778616.0 153984.0 161514.0 164280.3 166533.2 167283.0 992.9 1229.1 1260.3 1260.4 1262.4 19576.0 19636.3 20140.8 20206.9 20297.7 55934.4 59594.4 61051.7 62900.1 63879.0 84795.7 87348.0 88870.0 91110.5 91649.0 10673.0 10944.9 11207.3 11348.8 11430.4 10168.6 12297.8 12475.1 12489.9 12590.2 9692.1 10834.1 10969.1 11109.2 11121.4 10670.8 10940.4 11063.8 11212.6 11297.3 10811.1 11363.5 11387.5 11687.5 11842.1 11467.1 11675.4 11717.6 11725.7 11895.6 10693.3 10726.5 10736.3 10863.2 11076.8 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:6545.38 Median:3674.52 stddev:4098.78 (111.5%) stddev-sans-first:4093.02 11:43:46 INFO - PROCESS | 1659 | Values: 1540.2 1552.6 1576.6 1579.4 1587.2 10212.5 10730.3 10731.2 10748.8 10756.2 10402.0 10831.2 10896.3 10907.0 10907.3 2370.5 2404.7 2410.6 2411.6 2416.1 2338.6 2374.2 2374.9 2383.4 2394.7 2329.7 2349.0 2357.4 2359.3 2364.5 2295.6 2319.2 2319.8 2323.1 2328.5 2268.7 2315.3 2318.9 2321.4 2324.0 9808.2 9886.6 9896.2 9906.1 9937.9 3848.7 5699.2 5702.6 5709.6 5721.8 3417.2 3466.1 3544.1 3550.3 3567.3 991.2 1126.0 1137.4 1150.5 1183.5 13504.5 13863.7 14267.8 15077.8 15136.8 4149.1 4273.2 4276.7 4289.4 4529.5 11326.7 11331.6 11338.0 11351.8 11362.4 5612.0 5615.7 5620.7 5621.7 5630.8 4836.4 5145.8 5181.7 5188.1 5207.0 3397.3 3545.7 3781.8 3793.9 3866.7 831.7 997.0 997.6 1005.2 1006.2 666.4 697.6 762.0 804.8 834.6 6131.2 6299.7 6509.8 6542.4 6597.7 932.5 998.3 999.0 1004.8 1011.9 4097.5 4108.1 4119.6 4207.3 4240.8 13218.3 13561.5 13570.7 13591.5 13633.5 13479.3 13534.3 13545.8 13548.7 13607.0 9628.9 9957.7 10018.7 10019.8 10044.5 5233.6 6504.1 6533.2 6683.3 6721.4 11797.5 12051.3 12127.8 12248.1 12289.1 10234.3 11195.4 12013.5 12185.2 12477.8 8931.5 9055.4 9136.6 9178.7 9185.0 9893.4 9966.2 10111.9 10211.2 10216.0 9004.5 9020.1 9098.7 9125.2 9194.4 8656.7 8746.7 8803.6 8846.0 8856.6 7593.0 7621.5 7693.7 7734.8 7755.8 5572.1 5592.4 5616.7 5829.3 5967.4 5708.9 5733.8 5860.7 5916.4 5967.5 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4348.92 Median:4710.11 stddev:1213.51 (25.8%) stddev-sans-first:1178.57 11:43:46 INFO - PROCESS | 1659 | Values: 316.9 370.5 377.1 377.1 378.8 4498.9 4499.6 5007.7 5105.2 5159.6 4155.3 4222.5 4781.6 4786.6 4957.3 3448.3 3945.9 4130.4 4137.4 4142.8 3338.0 3689.7 4120.0 4151.8 4200.4 3957.6 4148.0 4174.4 4180.4 4201.9 3944.8 4005.7 4048.9 4126.1 4136.3 3327.4 3372.7 3757.0 3767.4 3770.8 4009.8 4261.6 4769.6 4792.1 4927.3 3857.5 4595.6 4738.5 4807.7 4856.2 4627.8 4848.8 5263.7 5288.3 5363.3 3601.9 3838.7 4241.6 4272.3 4289.4 3819.0 5269.8 5311.9 5444.3 5749.6 3927.4 4154.5 4313.5 4327.0 4331.9 3896.9 4045.0 4290.5 4326.8 4385.8 3939.8 4644.6 4702.5 4728.2 4735.0 4557.4 4943.4 4953.0 4995.3 5032.0 1354.3 1434.0 1434.2 1464.9 1484.5 1015.6 1044.5 1089.1 1107.5 1123.6 4165.6 4656.8 4991.8 5015.6 5066.8 4874.6 4946.7 5114.8 5269.1 5505.5 4236.9 4433.6 4525.0 4658.6 4852.9 2396.5 2839.0 2849.8 2851.8 2870.9 5138.8 5148.8 5188.8 5735.6 5770.6 4943.3 5083.0 5110.0 5256.3 5508.3 4834.3 5180.9 5204.3 5336.9 5478.2 4777.7 4943.7 5016.4 5063.3 5286.4 5239.8 5408.4 5438.3 5444.8 5452.9 5045.6 5071.4 5087.8 5148.4 5786.5 3755.9 3962.1 4124.3 4236.1 4419.4 4670.1 4893.5 4948.9 5250.6 5507.6 4872.0 5257.6 5406.4 5419.9 5474.3 4577.9 5365.5 5368.2 5384.0 5402.5 4206.9 5150.5 5228.3 5246.2 5261.6 4717.8 5344.3 5353.5 5355.5 5413.3 4321.7 4530.9 4635.5 5307.6 5335.5 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:19748.18 Median:21530.02 stddev:28211.04 (131.0%) stddev-sans-first:28253.88 11:43:46 INFO - PROCESS | 1659 | Values: 688.2 704.2 744.0 790.2 799.8 14567.6 15535.9 16542.3 17237.5 17408.5 15751.3 15830.3 15884.7 16367.8 16556.8 927.9 943.9 952.0 952.5 953.1 869.9 904.1 922.9 947.7 949.2 1004.8 1008.4 1009.0 1009.1 1009.6 1001.4 1004.4 1005.1 1005.9 1006.2 745.6 745.6 746.1 746.8 747.1 15088.0 15391.0 15428.6 15481.0 15909.8 13438.1 13566.5 13626.7 13670.3 13805.7 9987.8 11343.1 11493.7 11670.9 11831.6 3576.6 3587.5 3647.7 3696.2 3802.4 104251.5 109319.0 109421.0 111664.0 113211.0 10185.9 10207.9 10489.4 10523.3 10937.2 21467.4 21527.7 21532.4 21537.4 21547.5 7111.7 7218.8 7267.1 7624.1 7681.5 3833.3 4065.1 4334.2 4344.4 4346.5 3397.9 3442.9 3478.5 3493.4 3505.1 560.3 578.1 586.8 587.9 588.2 677.6 688.8 693.9 705.1 715.2 9339.3 9546.2 9630.6 9694.7 10249.3 561.1 602.4 605.9 647.2 705.9 4593.0 4840.4 4892.2 4968.4 4971.5 100211.5 102558.0 102919.0 103812.0 105219.0 42210.2 49303.5 79767.6 88143.0 90302.6 69192.0 69486.0 73275.6 75041.0 76071.6 10785.3 10849.2 11162.3 11168.3 11230.8 44736.6 45344.5 48465.5 48712.5 49782.8 61377.0 61951.1 63056.4 63212.7 63892.7 11814.7 12482.9 12770.4 12810.8 13255.4 14384.4 14407.4 14494.2 14604.3 15006.1 13385.3 13635.6 13825.8 14126.3 14373.7 10406.9 13409.9 13648.2 13740.7 13771.7 13046.8 13381.4 13584.5 13626.3 13630.3 9214.0 11005.0 11368.3 11689.9 11951.7 10036.9 10185.3 11404.9 11587.7 11596.7 11:43:46 INFO - PROCESS | 1659 | -------- Summary: end -------- 11:43:46 INFO - PROCESS | 1659 | 11:43:46 INFO - TEST-INFO | 1659: exit 0 11:43:46 INFO - TEST-OK | dromaeo_css | took 1121118ms 11:43:46 INFO - TEST-START | kraken 11:43:46 INFO - operating with platform_type : mac_ 11:43:46 INFO - Initialising browser for kraken test... 11:43:46 INFO - TEST-INFO | started process 1782 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpE26Bhf/profile http://localhost:49247/getInfo.html) 11:43:49 INFO - PROCESS | 1782 | __metrics Screen width/height:1600/1200 11:43:49 INFO - PROCESS | 1782 | colorDepth:24 11:43:49 INFO - PROCESS | 1782 | Browser inner width/height: 1024/689 11:43:49 INFO - PROCESS | 1782 | __metrics 11:43:49 INFO - PROCESS | 1782 | 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" 11:43:49 INFO - PROCESS | 1782 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:49 INFO - TEST-INFO | 1782: exit 0 11:43:49 INFO - Browser initialized. 11:43:49 INFO - Running cycle 1/1 for kraken test... 11:43:49 INFO - TEST-INFO | started process 1783 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpE26Bhf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:02 INFO - PROCESS | 1783 | RSS: Main: 214818816 11:44:02 INFO - PROCESS | 1783 | 11:44:04 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:05 INFO - PROCESS | 1783 | RSS: Main: 267726848 11:44:05 INFO - PROCESS | 1783 | 11:44:08 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 11:44:08 INFO - PROCESS | 1783 | RSS: Main: 278831104 11:44:08 INFO - PROCESS | 1783 | 11:44:12 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 11:44:12 INFO - PROCESS | 1783 | RSS: Main: 375828480 11:44:12 INFO - PROCESS | 1783 | 11:44:14 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 11:44:15 INFO - PROCESS | 1783 | RSS: Main: 280133632 11:44:15 INFO - PROCESS | 1783 | 11:44:17 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:17 INFO - PROCESS | 1783 | RSS: Main: 281694208 11:44:17 INFO - PROCESS | 1783 | 11:44:20 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:21 INFO - PROCESS | 1783 | RSS: Main: 321003520 11:44:21 INFO - PROCESS | 1783 | 11:44:24 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:25 INFO - PROCESS | 1783 | RSS: Main: 321470464 11:44:25 INFO - PROCESS | 1783 | 11:44:28 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 11:44:29 INFO - PROCESS | 1783 | RSS: Main: 320991232 11:44:29 INFO - PROCESS | 1783 | 11:44:30 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:31 INFO - PROCESS | 1783 | RSS: Main: 296009728 11:44:31 INFO - PROCESS | 1783 | 11:44:33 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:33 INFO - PROCESS | 1783 | RSS: Main: 296972288 11:44:33 INFO - PROCESS | 1783 | 11:44:35 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:36 INFO - PROCESS | 1783 | RSS: Main: 305782784 11:44:36 INFO - PROCESS | 1783 | 11:44:39 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:40 INFO - PROCESS | 1783 | RSS: Main: 319217664 11:44:40 INFO - PROCESS | 1783 | 11:44:43 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:43 INFO - PROCESS | 1783 | RSS: Main: 312975360 11:44:43 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 11:44:45 INFO - PROCESS | 1783 | RSS: Main: 357072896 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | __start_tp_report 11:44:45 INFO - PROCESS | 1783 | _x_x_mozilla_page_load 11:44:45 INFO - PROCESS | 1783 | _x_x_mozilla_page_load_details 11:44:45 INFO - PROCESS | 1783 | |i|pagename|runs| 11:44:45 INFO - PROCESS | 1783 | |0;ai-astar;118;115;115;115;116;114;116;114;114;116 11:44:45 INFO - PROCESS | 1783 | |1;audio-beat-detection;132;108;110;141;108;110;110;108;129;112 11:44:45 INFO - PROCESS | 1783 | |2;audio-dft;185;185;181;184;186;188;187;183;188;183 11:44:45 INFO - PROCESS | 1783 | |3;audio-fft;82;60;61;94;63;60;60;62;75;83 11:44:45 INFO - PROCESS | 1783 | |4;audio-oscillator;89;68;87;70;69;68;82;68;68;84 11:44:45 INFO - PROCESS | 1783 | |5;imaging-gaussian-blur;90;90;90;90;91;90;91;89;90;95 11:44:45 INFO - PROCESS | 1783 | |6;imaging-darkroom;97;98;96;108;150;145;153;100;121;151 11:44:45 INFO - PROCESS | 1783 | |7;imaging-desaturate;86;83;85;84;84;83;100;115;103;83 11:44:45 INFO - PROCESS | 1783 | |8;json-parse-financial;60;60;63;64;67;67;66;66;66;65 11:44:45 INFO - PROCESS | 1783 | |9;json-stringify-tinderbox;57;61;59;63;62;59;57;58;61;60 11:44:45 INFO - PROCESS | 1783 | |10;stanford-crypto-aes;84;87;87;83;86;83;85;81;90;90 11:44:45 INFO - PROCESS | 1783 | |11;stanford-crypto-ccm;145;144;128;138;135;136;143;125;194;174 11:44:45 INFO - PROCESS | 1783 | |12;stanford-crypto-pbkdf2;166;164;164;165;167;162;166;164;161;166 11:44:45 INFO - PROCESS | 1783 | |13;stanford-crypto-sha256-iterative;66;65;66;69;80;84;85;77;63;66 11:44:45 INFO - PROCESS | 1783 | __end_tp_report 11:44:45 INFO - PROCESS | 1783 | __start_cc_report 11:44:45 INFO - PROCESS | 1783 | _x_x_mozilla_cycle_collect,2226 11:44:45 INFO - PROCESS | 1783 | __end_cc_report 11:44:45 INFO - PROCESS | 1783 | __startTimestamp1489776285900__endTimestamp 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | ------- Summary: start ------- 11:44:45 INFO - PROCESS | 1783 | Number of tests: 14 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.50 stddev:1.25 (1.1%) stddev-sans-first:0.87 11:44:45 INFO - PROCESS | 1783 | Values: 118.0 115.0 115.0 115.0 116.0 114.0 116.0 114.0 114.0 116.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:111.00 stddev:12.29 (11.1%) stddev-sans-first:11.74 11:44:45 INFO - PROCESS | 1783 | Values: 132.0 108.0 110.0 141.0 108.0 110.0 110.0 108.0 129.0 112.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:2.31 (1.2%) stddev-sans-first:2.45 11:44:45 INFO - PROCESS | 1783 | Values: 185.0 185.0 181.0 184.0 186.0 188.0 187.0 183.0 188.0 183.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#3] audio-fft Cycles:10 Average:70.00 Median:69.00 stddev:12.51 (18.1%) stddev-sans-first:12.49 11:44:45 INFO - PROCESS | 1783 | Values: 82.0 60.0 61.0 94.0 63.0 60.0 60.0 62.0 75.0 83.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.00 stddev:8.98 (11.8%) stddev-sans-first:8.04 11:44:45 INFO - PROCESS | 1783 | Values: 89.0 68.0 87.0 70.0 69.0 68.0 82.0 68.0 68.0 84.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:90.00 stddev:1.65 (1.8%) stddev-sans-first:1.73 11:44:45 INFO - PROCESS | 1783 | Values: 90.0 90.0 90.0 90.0 91.0 90.0 91.0 89.0 90.0 95.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#6] imaging-darkroom Cycles:10 Average:121.90 Median:152.00 stddev:25.11 (16.5%) stddev-sans-first:24.96 11:44:45 INFO - PROCESS | 1783 | Values: 97.0 98.0 96.0 108.0 150.0 145.0 153.0 100.0 121.0 151.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:83.50 stddev:11.31 (13.5%) stddev-sans-first:11.87 11:44:45 INFO - PROCESS | 1783 | Values: 86.0 83.0 85.0 84.0 84.0 83.0 100.0 115.0 103.0 83.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:66.00 stddev:2.63 (4.0%) stddev-sans-first:2.26 11:44:45 INFO - PROCESS | 1783 | Values: 60.0 60.0 63.0 64.0 67.0 67.0 66.0 66.0 66.0 65.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.50 stddev:2.06 (3.4%) stddev-sans-first:1.94 11:44:45 INFO - PROCESS | 1783 | Values: 57.0 61.0 59.0 63.0 62.0 59.0 57.0 58.0 61.0 60.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.50 stddev:2.99 (3.5%) stddev-sans-first:3.11 11:44:45 INFO - PROCESS | 1783 | Values: 84.0 87.0 87.0 83.0 86.0 83.0 85.0 81.0 90.0 90.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:143.50 stddev:21.48 (15.0%) stddev-sans-first:22.78 11:44:45 INFO - PROCESS | 1783 | Values: 145.0 144.0 128.0 138.0 135.0 136.0 143.0 125.0 194.0 174.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.50 stddev:1.90 (1.1%) stddev-sans-first:1.94 11:44:45 INFO - PROCESS | 1783 | Values: 166.0 164.0 164.0 165.0 167.0 162.0 166.0 164.0 161.0 166.0 11:44:45 INFO - PROCESS | 1783 | 11:44:45 INFO - PROCESS | 1783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:73.00 stddev:8.49 (11.6%) stddev-sans-first:8.71 11:44:45 INFO - PROCESS | 1783 | Values: 66.0 65.0 66.0 69.0 80.0 84.0 85.0 77.0 63.0 66.0 11:44:45 INFO - PROCESS | 1783 | -------- Summary: end -------- 11:44:45 INFO - PROCESS | 1783 | 11:44:46 INFO - TEST-INFO | 1783: exit 0 11:44:46 INFO - TEST-OK | kraken | took 60118ms 11:44:46 INFO - SUITE-END | took 1181s 11:44:47 INFO - Completed test suite (00:19:41) 11:44:47 INFO - javascript benchmark 11:44:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7469.482118605593, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.8111532192743, 3184.2039490127468, 3452.0679416557546, 3460.8961731148074, 3504.5093686883843, 5902.911456328153, 5910.0248459004215, 5923.229980102591, 6033.547483938712, 6061.605995610288, 5914.526837852972, 5928.258967629046, 5982.790602328909, 6009.549283803722, 6037.0340745480735, 5323.467653234675, 5327.600429967768, 5346.973265133688, 5408.161734931092, 5448.318960129984, 5276.498732620415, 5280.841574752763, 5293.9735301323635, 5470.7264636768205, 5500.972495137538, 5334.5732341412595, 5338.0, 5340.385855626614, 5341.439148889369, 5341.572674186055, 5322.308099947001, 5331.067063263913, 5347.465253474641, 5353.03645343838, 5355.6251062425645, 5185.870353241162, 5299.4435584263865, 5299.655522391071, 5312.521873031407, 5348.010618035637, 5932.7330270137945, 5939.3763654816485, 5943.732532036069, 5947.167396564484, 5952.494038006775, 6264.7807326743805, 6274.498040156776, 6274.498040156776, 6278.0, 6288.62268263901, 5305.65513241638, 6265.624062556261, 6275.529335299871, 6283.057541368831, 6344.873102537924, 6027.065804800219, 6074.817755467343, 6077.026711276575, 6079.939200607982, 6094.268687757498, 6240.594361366497, 6578.8355291118105, 6582.17722784652, 6603.372679595431, 6603.867922641616, 6107.378548143503, 6230.844228894314, 6236.345183755731, 6242.781502647385, 6244.094606282155, 4897.440360770301, 6203.2245969253845, 6284.4344009039405, 6287.371262873676, 6401.071844582602, 6281.497480201573, 6297.4647154992335, 6313.337099604567, 6315.905261421082, 6323.620582765049, 6325.683715814191, 6327.082573026885, 6348.396902294275, 6350.4919606432295, 6351.079093531412, 5016.5485106339875, 5034.395872495251, 5056.494350564914, 5160.045391602565, 5188.377394712658, 4511.075229577928, 4556.72659640416, 4563.361129441881, 4564.977175114103, 4572.108438854458, 5928.822135335947, 5941.0, 5941.792037278675, 5944.554158438134, 5947.1376650385455, 6145.8156255312415, 6313.2424109107205, 6346.397092276226, 6346.9682651586445, 6355.3326900674765, 5045.9747701261995, 6130.153553065287, 6139.19845745766, 6141.170941922873, 6154.569180157346, 5635.915461268084, 5658.7170641467765, 5659.207710920475, 5662.348829884616, 5701.344345400332, 6309.432151106423, 6361.268454127835, 6417.069524918954, 6634.86730265392, 6684.866302674017, 6330.430261276507, 6350.364963503613, 6355.5551111421755, 6357.618542887441, 6364.045393191059, 6427.389398007182, 6508.251551071688, 6553.475721942328, 6630.30381809903, 6653.634050127096, 6358.777442789666, 6373.0, 6375.107484952017, 6387.680615969276, 6395.93604063972, 6363.649999250086, 6364.140840986408, 6367.745290188526, 6381.904271436025, 6393.073004414427, 5135.87160320995, 6111.95640283616, 6142.3759981611065, 6193.566450348432, 6210.099535567408, 6085.178500902499, 6180.351063138485, 6193.009118541012, 6197.721102550306, 6212.192414986023, 6175.320714721287, 6199.287081985449, 6228.657423841732, 6232.376762323732, 6237.251529816451, 6240.188775459343, 6246.437820596168, 6246.750129994749, 6248.781292654735, 6252.656103914146, 5268.0, 5820.417958204146, 6051.183090282755, 6140.232470941132, 6152.64641778808], "value": 5827.490661908658, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.8153439338577, 810.5825499867569, 871.2072014466836, 884.0540621534956, 964.5611246882669, 32288.515672264904, 37133.81433092834, 37535.0, 39009.41485877714, 39498.8025059875, 37500.624993750054, 37706.81146594263, 37739.81130094346, 37755.0, 37766.811165944135, 7691.42314326425, 7800.79087741401, 7813.296803287703, 7816.022997125359, 7821.296083352498, 7627.618619069052, 7732.304092631662, 7748.690052397926, 7749.147593764681, 7763.301302882739, 7681.692732290701, 7690.5770182639935, 7699.653515591784, 7704.26809453101, 7753.883691744629, 7554.848903021963, 7616.923830761677, 7684.4236682248775, 7691.423143264277, 7697.422693297969, 6710.194776626788, 6750.729970801162, 6754.797356079325, 6764.9323506764795, 6765.9661701691175, 30703.925362612426, 34227.97316080522, 35539.28921421583, 35577.64422355769, 35589.0, 3522.1018640246575, 3535.611082780892, 3555.982220088883, 3563.2160924596546, 3656.945145822788, 24238.0, 24394.512109757707, 26020.73979260221, 26202.0, 26209.60685589718, 2716.5653495440833, 2717.1033558925506, 2719.456108778252, 2725.318670332417, 2811.9718802812117, 365274.0, 365743.0, 366264.0, 366723.0, 368655.0, 42222.78888605537, 42756.358654620206, 50459.74770126126, 51089.0, 53633.0, 52471.73764131155, 53348.933021339355, 53491.73254133704, 53549.1967620486, 53687.0, 14183.21992290434, 14248.93133015028, 14254.216018118896, 14288.928555357365, 14294.642633934234, 12349.93825030869, 12383.504659813687, 12392.876071239172, 12549.811752823714, 12550.623481295575, 11999.760004799855, 12003.879961200451, 12037.0, 12055.517779288906, 12084.818727719092, 5670.121131224667, 5694.430556944355, 5703.515201207943, 5712.257406537124, 5719.19931209631, 1054.3341520397753, 1061.8266815169127, 1073.6027669762238, 1108.5510368300852, 1113.3876367997732, 22084.88957555234, 25644.71776411172, 26966.5955010675, 27211.319717007234, 27289.590656140175, 983.2969426859829, 1135.1883403366633, 1143.6454699043322, 1164.8019836627793, 1170.9063274937985, 12766.234025958473, 13807.378667959765, 13868.098573592684, 13921.860781392057, 14255.287235638176, 431342.0, 448537.0, 448755.0, 449629.0, 449675.0, 55042.0, 55121.724391377786, 55123.17315240275, 55160.0, 55163.0, 1395.937182826755, 1445.551878917539, 1449.6955639315652, 1452.5061479097158, 1456.8178977627797, 22435.663465048365, 26048.34879128037, 26176.34559136037, 26421.73578264193, 26590.86704566542, 40245.0, 40886.1822763549, 44344.891377715816, 44491.0, 44552.33171502495, 423744.0, 423829.0, 423858.0, 423892.0, 424923.0, 32768.0, 33579.66420335766, 33598.3280334387, 33660.0, 33682.66317336795, 41966.58033419749, 42500.0, 42506.36240456334, 42573.722788315165, 43136.7647426438, 28859.85570072136, 33087.338253235284, 34445.31109377849, 35800.28399431945, 36039.63960360363, 34351.65648343485, 34431.827840860635, 34445.0, 35692.0, 35703.642963571074, 29007.564886526296, 31783.205419864687, 32367.676323237407, 35804.10489737777, 35873.64126358808, 27664.308392290353, 27759.583606246328, 29176.27059323534, 29647.407051859274, 29763.12976412876, 22651.660225096308, 23176.188833390752, 23210.955507001887, 23394.532109358057, 23436.648450272918], "value": 17620.040055427366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5900427538259, 394.8795617336712, 399.93831797085994, 414.51501742960744, 441.52756550490966, 12356.0, 17448.302067917284, 20561.38315850525, 21921.01355439005, 22080.447988800246, 20352.287669931517, 20912.790872091275, 21723.6741448878, 22250.221242256524, 22552.54894902101, 5430.402655707889, 6528.608283502981, 6701.363370479797, 6738.764143254987, 6739.2249891262645, 6376.234851817789, 7205.711771529132, 7664.118626357985, 7692.230776922319, 7740.109887362941, 7403.0, 7557.130929943072, 7681.23187681233, 7681.385489160882, 7733.0, 7103.254158313354, 7407.259274072603, 7568.470207085506, 7609.391248700091, 7657.540547567164, 6103.0, 7279.781606551759, 7318.9634051829935, 7331.560106393634, 7339.412846972229, 26165.476690466083, 26259.343516412053, 26597.0, 26748.866255668792, 26931.461370772475, 2839.5030869597945, 2851.9429611407863, 2857.8428186449737, 2870.8277503349864, 2903.1000389878996, 12861.807072893915, 14844.925775371163, 15964.840351596451, 16000.959937604019, 16840.326386944507, 1945.1441365799003, 1952.3069310394746, 1962.941111766635, 1989.4727897107277, 1998.9000549972588, 130729.0, 134692.0, 135207.0, 135947.0, 137403.999999999, 13511.594652160451, 19501.902490487457, 19595.706064409045, 19830.008499574964, 19934.102965366594, 27024.59463108055, 27032.91868325245, 27035.0, 27046.0, 28844.990425335014, 9291.349605527548, 9317.627294908129, 9728.416295022322, 9833.557489912828, 9962.900370996342, 6820.795376138723, 7089.22018577956, 7123.715051397886, 7258.419326453871, 8258.504489730636, 7034.788956331318, 8873.511956842307, 9297.814043719223, 9407.519217889425, 9441.76395590102, 3851.826667799956, 3933.527976642821, 3947.624975627311, 3951.7233793634746, 3963.3460479020637, 1011.6560369474414, 1025.7128004158847, 1036.5853658536646, 1075.6181555547669, 1090.432974853088, 20867.791322086585, 21500.569988600142, 22239.888800555895, 22242.777572224393, 22268.777312226994, 1038.9324693895023, 1061.9044286014296, 1072.484291521638, 1075.3762817565948, 1096.4024606589269, 9778.75553111178, 10733.658292713411, 11504.252223605607, 11705.180637355474, 12771.361431928552, 503038.0, 508136.0, 512724.4363778157, 646159.0, 778616.0, 153984.0, 161514.0, 164280.32177908398, 166533.16733416254, 167283.0, 992.9205663546899, 1229.1027549888452, 1260.3383223807575, 1260.3950103950156, 1262.444524409257, 19576.0, 19636.312729054414, 20140.798592013893, 20206.89896550508, 20297.69553456729, 55934.44065559455, 59594.40405595888, 61051.69474152601, 62900.05649915346, 63879.04181437375, 84795.72806408032, 87348.0, 88870.0, 91110.54444727734, 91649.0, 10673.0, 10944.945275273572, 11207.271527350696, 11348.829767553329, 11430.428478576205, 10168.644097456554, 12297.815532767194, 12475.126741128033, 12489.875101248872, 12590.24458532491, 9692.079252471003, 10834.133269338592, 10969.067629251284, 11109.166812489257, 11121.388323641953, 10670.8399374011, 10940.39827809478, 11063.834042489209, 11212.607558735404, 11297.322160670386, 10811.081058109834, 11363.488643010918, 11387.54449822031, 11687.539057617798, 11842.052635789289, 11467.139964502529, 11675.3578553177, 11717.60589778833, 11725.706857328634, 11895.643130706092, 10693.251472396858, 10726.517306721373, 10736.30214036085, 10863.239573230114, 11076.833847492455], "value": 11345.1303588309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.1606124662057, 1552.6351307442749, 1576.5506830553295, 1579.3761464221632, 1587.246058122392, 10212.540435680394, 10730.302530335523, 10731.195160362984, 10748.838767418485, 10756.247062705614, 10402.0, 10831.241813073068, 10896.346219226853, 10907.018368346848, 10907.34555926645, 2370.466645004873, 2404.651325557793, 2410.5660981023498, 2411.590029694947, 2416.0577374823833, 2338.649202619604, 2374.2165085521824, 2374.9287521374386, 2383.4398916254668, 2394.7006624171977, 2329.7087864017, 2349.048635302705, 2357.4106473381653, 2359.256834097254, 2364.4916342986253, 2295.621222498286, 2319.1651005637955, 2319.7564255753073, 2323.082382458928, 2328.464453175779, 2268.65970104484, 2315.305408377497, 2318.9188378406675, 2321.419645088728, 2323.9767602323927, 9808.21534277256, 9886.604535818558, 9896.208303335716, 9906.05892440217, 9937.850932236022, 3848.692104631623, 5699.202111704365, 5702.572307076985, 5709.628874123168, 5721.799737009226, 3417.1627951151877, 3466.0814884055744, 3544.0962554548682, 3550.2721942002086, 3567.250877315767, 991.2070343725063, 1125.9605913792977, 1137.3858116617016, 1150.5397840863639, 1183.4851839449866, 13504.527341543097, 13863.722725545533, 14267.785983210364, 15077.849221507755, 15136.848631513763, 4149.066460046526, 4273.166732487197, 4276.72201306914, 4289.442372491556, 4529.501754806968, 11326.716832079264, 11331.603393881174, 11338.0, 11351.772964540663, 11362.375069371265, 5612.017896868032, 5615.6630602164005, 5620.718964051781, 5621.690807005654, 5630.831075067755, 4836.419629644465, 5145.794168233228, 5181.715005674724, 5188.11801993662, 5207.036698210767, 3397.303552771725, 3545.6631619996574, 3781.7920014399474, 3793.9241215175543, 3866.7486613370043, 831.6714897615408, 996.9950150249348, 997.576030187182, 1005.2360206243308, 1006.1548299428515, 666.3636227402916, 697.6337422853043, 761.950473219239, 804.7746630943345, 834.6244190114472, 6131.172291740647, 6299.716512756937, 6509.772157974543, 6542.411182993458, 6597.73609055642, 932.4638332958576, 998.2712619787595, 998.9750256243652, 1004.783971446128, 1011.9494025298706, 4097.508299004079, 4108.096218831853, 4119.629233369011, 4207.305794543927, 4240.830366785294, 13218.339083046001, 13561.457541698419, 13570.660733481742, 13591.52429664957, 13633.454661813417, 13479.258640774655, 13534.323283835965, 13545.796813047813, 13548.661283467993, 13607.0, 9628.855567166498, 9957.705498285177, 10018.699439016842, 10019.849702254473, 10044.547995340226, 5233.581313494988, 6504.089427480251, 6533.216014078341, 6683.264840867598, 6721.395074443323, 11797.528098876292, 12051.276923384625, 12127.818082728943, 12248.142630015813, 12289.078319125923, 10234.33476824004, 11195.440227988405, 12013.45939432745, 12185.207961482476, 12477.812832807334, 8931.508767017616, 9055.36612437123, 9136.588853501742, 9178.678746244117, 9185.0, 9893.406395616286, 9966.152877005536, 10111.89888101139, 10211.183105351703, 10216.0, 9004.50475223869, 9020.14308640678, 9098.727038188865, 9125.174965006892, 9194.402363846328, 8656.653733850575, 8746.693865714924, 8803.559822009001, 8846.02693703705, 8856.557172141238, 7593.0, 7621.504602200839, 7693.6537855795505, 7734.845303094019, 7755.806104847424, 5572.136318870582, 5592.412796656293, 5616.66300022, 5829.329627092939, 5967.37342579023, 5708.942910571007, 5733.770649173986, 5860.677662728591, 5916.437938395846, 5967.522598192221], "value": 4968.542743039776, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.925522502212, 370.4683778777453, 377.10249605937867, 377.1043771043771, 378.7651655973297, 4498.887527811807, 4499.595036446719, 5007.7496125193775, 5105.192144320627, 5159.613029022829, 4155.33514637658, 4222.472190976128, 4781.569658730714, 4786.56920877121, 4957.330760347352, 3448.293099914524, 3945.9013524661827, 4130.442390277304, 4137.358709400048, 4142.792860356985, 3337.9958037765964, 3689.7048236141177, 4119.979400102995, 4151.792410379484, 4200.432941552882, 3957.624025717567, 4148.0, 4174.373843923406, 4180.352045432963, 4201.915961680765, 3944.7830369329677, 4005.7396269242404, 4048.898777530556, 4126.071633882382, 4136.296829538986, 3327.4361050306316, 3372.6627337266323, 3756.981215093934, 3767.3595488766973, 3770.830312635938, 4009.799510024487, 4261.573842615745, 4769.592970073802, 4792.0895029944195, 4927.310176575283, 3857.4792403025513, 4595.563421474954, 4738.549837765407, 4807.663463557552, 4856.174450343415, 4627.814887404534, 4848.806047758121, 5263.710495922723, 5288.2596436498925, 5363.302770639831, 3601.9099522511883, 3838.673712734421, 4241.639460645818, 4272.316429371285, 4289.420928174688, 3818.980905095457, 5269.813027593544, 5311.867203319909, 5444.346678398539, 5749.626274292199, 3927.351986922183, 4154.543000269968, 4313.547077556874, 4326.978365108154, 4331.935020974624, 3896.882494004785, 4044.9595504045174, 4290.528041915387, 4326.762028088486, 4385.824567017347, 3939.783311917872, 4644.6298341989195, 4702.4592171899985, 4728.233983119844, 4734.976325118352, 4557.407537020166, 4943.382077240345, 4952.969282594119, 4995.325631039836, 5031.974840125849, 1354.288998275913, 1434.0320283808387, 1434.1968497641353, 1464.8974571780086, 1484.5397926642775, 1015.5633077776627, 1044.5456226541478, 1089.1014912697058, 1107.4628805029554, 1123.5955056179769, 4165.604267594574, 4656.790444429941, 4991.778658496934, 5015.623828212899, 5066.771995260222, 4874.610031197496, 4946.653734238569, 5114.820981265712, 5269.104252277122, 5505.513511351993, 4236.9364459533135, 4433.623142032899, 4524.9818790771815, 4658.5558476872275, 4852.908095678515, 2396.5446565152915, 2838.971610283912, 2849.786266030056, 2851.800373973802, 2870.885164593393, 5138.794448222104, 5148.768305426265, 5188.792448302026, 5735.627184233012, 5770.624909380961, 4943.283223932582, 5082.974585127125, 5110.032637434614, 5256.342957130359, 5508.319962411503, 4834.299026641117, 5180.922286165786, 5204.297419848272, 5336.893262134658, 5478.233047373371, 4777.7372244525495, 4943.65394422387, 5016.448190698947, 5063.265846433596, 5286.444923283, 5239.816606418757, 5408.432114627907, 5438.347398312228, 5444.8094316698725, 5452.928776238136, 5045.621578381562, 5071.416787069386, 5087.796488140581, 5148.43367229612, 5786.450287222707, 3755.868544600926, 3962.077543232237, 4124.298869192305, 4236.068065025689, 4419.403380543586, 4670.136024835417, 4893.535114164149, 4948.901021979612, 5250.632455728062, 5507.642003269774, 4872.0, 5257.579393648422, 5406.4052954175795, 5419.861829015793, 5474.343078830407, 4577.862664120082, 5365.490278423544, 5368.221607866915, 5384.0, 5402.540784033401, 4206.936895946625, 5150.536451719363, 5228.294180285613, 5246.213068039825, 5261.57907367402, 4717.759064444362, 5344.331958505187, 5353.491418315254, 5355.544778693855, 5413.269208656781, 4321.7406955582765, 4530.88672783183, 4635.490096089495, 5307.57539396855, 5335.546478549211], "value": 3997.6401618646073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.2394953576302, 704.2253521126761, 743.9814004649883, 790.1861083084423, 799.7720649614861, 14567.562973110797, 15535.922320388396, 16542.338306467744, 17237.482875513724, 17408.47774566762, 15751.291191896364, 15830.287637056332, 15884.682306353867, 16367.754483682755, 16556.83443165568, 927.8886533615959, 943.8914524829629, 951.9857202141974, 952.5046975572698, 953.0897992417259, 869.9391042626987, 904.1365495951351, 922.9123233292827, 947.7109481608106, 949.178960199426, 1004.8342023566103, 1008.374807619277, 1008.9848652270222, 1009.106940357785, 1009.5658866687359, 1001.4241810958655, 1004.4174378860243, 1005.1104772276587, 1005.8893521712606, 1006.2101250518344, 745.5601195294748, 745.6458182363389, 746.0674157303371, 746.8207630168774, 747.0512449189553, 15088.019278746957, 15390.999585026937, 15428.614284642861, 15481.0, 15909.840901590951, 13438.059335846494, 13566.457341706418, 13626.659333516742, 13670.316484175752, 13805.654858628513, 9987.848729076255, 11343.149263805166, 11493.65519034422, 11670.94164529172, 11831.645050648494, 3576.624454432299, 3587.5336206293014, 3647.6717095461536, 3696.2237930034726, 3802.4106263529197, 104251.47874260656, 109319.0, 109421.0, 111664.0, 113211.0, 10185.898141018642, 10207.948960255151, 10489.370637761758, 10523.263371563917, 10937.234393592373, 21467.35597932033, 21527.67708484374, 21532.354029379145, 21537.353879383645, 21547.461313467287, 7111.715531378791, 7218.819529511804, 7267.091613548307, 7624.085109786861, 7681.500702454323, 3833.2525157594, 4065.1259979104043, 4334.241507736134, 4344.413504176959, 4346.500152482442, 3397.8810741623925, 3442.9311413772084, 3478.530398396184, 3493.3886569850174, 3505.1412403961194, 560.2632538212238, 578.0981668597002, 586.8444862111544, 587.9029960056542, 588.1559961455325, 677.6340775981014, 688.789919074677, 693.9328169490863, 705.1009962298111, 715.2346988722121, 9339.299552533586, 9546.18387575667, 9630.614775408905, 9694.660686875926, 10249.33379330341, 561.1034702704912, 602.4397310501188, 605.9454649081604, 647.2007071266981, 705.9470539709542, 4592.979089200741, 4840.418388815096, 4892.1830884934225, 4968.378952630921, 4971.45314015458, 100211.49682754764, 102558.0, 102919.0, 103812.0, 105219.0, 42210.15579688389, 49303.52089437323, 79767.60116199382, 88143.0, 90302.64546031815, 69192.0, 69486.0, 73275.63362183262, 75041.0, 76071.61964190254, 10785.298955567863, 10849.240553161202, 11162.274452160584, 11168.274062185932, 11230.7753844921, 44736.552634473235, 45344.546554534034, 48465.5153448461, 48712.5128748708, 49782.755431114514, 61377.0, 61951.070733938126, 63056.36943630505, 63212.683936580026, 63892.68053659888, 11814.6953065387, 12482.875171248172, 12770.425330859947, 12810.807837882252, 13255.403506842407, 14384.352704128549, 14407.42370305176, 14494.202818844644, 14604.342804573607, 15006.099634021994, 13385.330733463483, 13635.590932272047, 13825.79261311061, 14126.293685315488, 14373.712525749217, 10406.947965260126, 13409.932950335186, 13648.249346285653, 13740.725185496434, 13771.724565508834, 13046.804297935349, 13381.39783709755, 13584.524541640994, 13626.318684065558, 13630.318484075955, 9214.0, 11005.0, 11368.317900925971, 11689.88310116888, 11951.701207469883, 10036.94981525117, 10185.287029907835, 11404.94297528507, 11587.710307242387, 11596.710082248012], "value": 7505.32937081192, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 115.0, 115.0, 116.0, 114.0, 116.0, 114.0, 114.0, 116.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 108.0, 110.0, 141.0, 108.0, 110.0, 110.0, 108.0, 129.0, 112.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 181.0, 184.0, 186.0, 188.0, 187.0, 183.0, 188.0, 183.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 61.0, 94.0, 63.0, 60.0, 60.0, 62.0, 75.0, 83.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 87.0, 70.0, 69.0, 68.0, 82.0, 68.0, 68.0, 84.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 90.0, 91.0, 90.0, 91.0, 89.0, 90.0, 95.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 108.0, 150.0, 145.0, 153.0, 100.0, 121.0, 151.0], "value": 121.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 84.0, 84.0, 83.0, 100.0, 115.0, 103.0, 83.0], "value": 90.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 63.0, 64.0, 67.0, 67.0, 66.0, 66.0, 66.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 59.0, 63.0, 62.0, 59.0, 57.0, 58.0, 61.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 87.0, 83.0, 86.0, 83.0, 85.0, 81.0, 90.0, 90.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 128.0, 138.0, 135.0, 136.0, 143.0, 125.0, 194.0, 174.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 165.0, 167.0, 162.0, 166.0, 164.0, 161.0, 166.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 69.0, 80.0, 84.0, 85.0, 77.0, 63.0, 66.0], "value": 72.1, "unit": "score"}]}]} 11:44:47 INFO - Return code: 0 11:44:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:47 ERROR - # TBPL SUCCESS # 11:44:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:44:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:44:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:44:47 INFO - 2017-03-17 11:44:47.257 screenresolution[1793:10381] starting screenresolution argv=screenresolution get 11:44:47 INFO - 2017-03-17 11:44:47.260 screenresolution[1793:10381] Display 0: 1600x1200x32@60 11:44:47 INFO - 2017-03-17 11:44:47.266 screenresolution[1794:10384] starting screenresolution argv=screenresolution list 11:44:47 INFO - Available Modes on Display 0 11:44:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:44:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:44:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:44:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:44:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:44:47 INFO - Intel Iris: 11:44:47 INFO - Chipset Model: Intel Iris 11:44:47 INFO - Type: GPU 11:44:47 INFO - Bus: Built-In 11:44:47 INFO - VRAM (Dynamic, Max): 1536 MB 11:44:47 INFO - Vendor: Intel (0x8086) 11:44:47 INFO - Device ID: 0x0a2e 11:44:47 INFO - Revision ID: 0x0009 11:44:47 INFO - Displays: 11:44:47 INFO - Display: 11:44:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:44:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:44:47 INFO - Display Serial Number: 1600x1200 60 11:44:47 INFO - Main Display: Yes 11:44:47 INFO - Mirror: Off 11:44:47 INFO - Online: Yes 11:44:47 INFO - Rotation: Supported 11:44:47 INFO - Return code: 0 11:44:47 INFO - Running post-action listener: _resource_record_post_action 11:44:47 INFO - [mozharness: 2017-03-17 18:44:47.510742Z] Finished run-tests step (success) 11:44:47 INFO - Running post-run listener: _resource_record_post_run 11:44:47 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 36971520; Write bytes: 511540224; Read time: 241; Write time: 1628 11:44:47 INFO - TinderboxPrint: CPU usage
53.7% 11:44:47 INFO - TinderboxPrint: I/O read bytes / time
36,971,520 / 241 11:44:47 INFO - TinderboxPrint: I/O write bytes / time
511,540,224 / 1,628 11:44:47 INFO - TinderboxPrint: CPU idle
2,227.8 (46.3%) 11:44:47 INFO - TinderboxPrint: CPU system
959.0 (19.9%) 11:44:47 INFO - TinderboxPrint: CPU user
1,622.7 (33.7%) 11:44:47 INFO - TinderboxPrint: Swap in / out
245,035,008 / 0 11:44:47 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 197458432; Write bytes: 192574976; Read time: 15678; Write time: 394 11:44:47 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35984384; Write bytes: 299210240; Read time: 228; Write time: 1175 11:44:48 INFO - Running post-run listener: _upload_blobber_files 11:44:48 INFO - Blob upload gear active. 11:44:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:48 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 11:44:48 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'] 11:44:48 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 11:44:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:49 INFO - (blobuploader) - INFO - Done attempting. 11:44:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:50 INFO - (blobuploader) - INFO - Done attempting. 11:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:44:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:51 INFO - (blobuploader) - INFO - Done attempting. 11:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:54 INFO - (blobuploader) - INFO - Done attempting. 11:44:54 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:54 INFO - Return code: 0 11:44:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/493ecb075a96d061d8880cceab91db7fe8a9389a5734b769985bfeaef47b5617f4c111d93a4f030bb92e665f6caf40432f9353cb0147e02effe5937c6282856c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f8c782fd000e48a6600fc43be7a72b2ecfdd22ab72472856b92999a74f708d76a148a14fea86f72b2c6833b084f408496630ac7cfa825becdd7c3a68539ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e299bd849a5a700f6d47f7f10cdfed5238c5ad4aa3b473ca7917dc60507304655f32370cf7389f51a47e95496a32e75a5adf8922b518c1757ecfc8e5804a407c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f64ec98db1ca64001a90cbcd13c919a550b1c838afd7948f950601ba2f2884d05a06fcc860a1dd091ebb0da6c2a449ee254bafb9b9f206fc6de848265dcb18a1"} 11:44:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:54 INFO - Contents: 11:44:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/493ecb075a96d061d8880cceab91db7fe8a9389a5734b769985bfeaef47b5617f4c111d93a4f030bb92e665f6caf40432f9353cb0147e02effe5937c6282856c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f8c782fd000e48a6600fc43be7a72b2ecfdd22ab72472856b92999a74f708d76a148a14fea86f72b2c6833b084f408496630ac7cfa825becdd7c3a68539ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e299bd849a5a700f6d47f7f10cdfed5238c5ad4aa3b473ca7917dc60507304655f32370cf7389f51a47e95496a32e75a5adf8922b518c1757ecfc8e5804a407c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f64ec98db1ca64001a90cbcd13c919a550b1c838afd7948f950601ba2f2884d05a06fcc860a1dd091ebb0da6c2a449ee254bafb9b9f206fc6de848265dcb18a1"} 11:44:54 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:54 INFO - Copying logs to upload dir... 11:44:54 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.310542 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-17 11:44:54.171670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 11:44:54.176364) ========= 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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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/493ecb075a96d061d8880cceab91db7fe8a9389a5734b769985bfeaef47b5617f4c111d93a4f030bb92e665f6caf40432f9353cb0147e02effe5937c6282856c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f8c782fd000e48a6600fc43be7a72b2ecfdd22ab72472856b92999a74f708d76a148a14fea86f72b2c6833b084f408496630ac7cfa825becdd7c3a68539ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e299bd849a5a700f6d47f7f10cdfed5238c5ad4aa3b473ca7917dc60507304655f32370cf7389f51a47e95496a32e75a5adf8922b518c1757ecfc8e5804a407c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f64ec98db1ca64001a90cbcd13c919a550b1c838afd7948f950601ba2f2884d05a06fcc860a1dd091ebb0da6c2a449ee254bafb9b9f206fc6de848265dcb18a1"} build_url:https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/a1vMKP0HQi6mqE2e5uQZqA/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/493ecb075a96d061d8880cceab91db7fe8a9389a5734b769985bfeaef47b5617f4c111d93a4f030bb92e665f6caf40432f9353cb0147e02effe5937c6282856c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f8c782fd000e48a6600fc43be7a72b2ecfdd22ab72472856b92999a74f708d76a148a14fea86f72b2c6833b084f408496630ac7cfa825becdd7c3a68539ec0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e299bd849a5a700f6d47f7f10cdfed5238c5ad4aa3b473ca7917dc60507304655f32370cf7389f51a47e95496a32e75a5adf8922b518c1757ecfc8e5804a407c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f64ec98db1ca64001a90cbcd13c919a550b1c838afd7948f950601ba2f2884d05a06fcc860a1dd091ebb0da6c2a449ee254bafb9b9f206fc6de848265dcb18a1"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 11:44:54.470830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:44:54.471171) ========= 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.NNkgWkFTK2/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.BDHvOGLGHw/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005305 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 11:44:54.519910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 11:44:54.520254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 11:44:54.520573) ========= ========= Total master_lag: 0.44 =========