builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0151 starttime: 1493045163.38 results: success (0) buildid: 20170424065420 builduid: 79f062eaf83a4c3d84a370ba439c4f79 revision: 62b649c6b314f756f21cb95f2b0d491e2664e944 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.384334) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.384807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.385098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.411767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.412195) ========= 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.EHkk1ldwch/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.DQuBA5bfxm/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-04-24 07:46:03-- 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% 155M=0s 2017-04-24 07:46:03 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131662 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.569630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.570015) ========= 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.EHkk1ldwch/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.DQuBA5bfxm/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.028495 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:03.621290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 07:46:03.621657) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 62b649c6b314f756f21cb95f2b0d491e2664e944 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 62b649c6b314f756f21cb95f2b0d491e2664e944 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EHkk1ldwch/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.DQuBA5bfxm/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-04-24 07:46:03,724 truncating revision to first 12 chars 2017-04-24 07:46:03,724 Setting DEBUG logging. 2017-04-24 07:46:03,724 attempt 1/10 2017-04-24 07:46:03,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/62b649c6b314?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 07:46:05,480 unpacking tar archive at: mozilla-central-62b649c6b314/testing/mozharness/ program finished with exit code 0 elapsedTime=2.035448 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 07:46:05.875588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:05.875986) ========= script_repo_revision: 62b649c6b314f756f21cb95f2b0d491e2664e944 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:05.876461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:05.876738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 07:46:05.898093) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-24 07:46:05.898382) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EHkk1ldwch/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.DQuBA5bfxm/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:46:06 INFO - MultiFileLogger online at 20170424 07:46:06 in /builds/slave/test 07:46:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:46:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:06 INFO - {'append_to_log': False, 07:46:06 INFO - 'base_work_dir': '/builds/slave/test', 07:46:06 INFO - 'blob_upload_branch': 'Firefox', 07:46:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:06 INFO - 'branch': 'Firefox', 07:46:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:06 INFO - 'config_files': ('talos/mac_config.py',), 07:46:06 INFO - 'default_actions': ('clobber', 07:46:06 INFO - 'read-buildbot-config', 07:46:06 INFO - 'download-and-extract', 07:46:06 INFO - 'populate-webroot', 07:46:06 INFO - 'create-virtualenv', 07:46:06 INFO - 'install', 07:46:06 INFO - 'run-tests'), 07:46:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:06 INFO - 'download_minidump_stackwalk': True, 07:46:06 INFO - 'download_symbols': 'ondemand', 07:46:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:06 INFO - 'gecko_profile': False, 07:46:06 INFO - 'gecko_profile_interval': 0, 07:46:06 INFO - 'installer_path': 'installer.exe', 07:46:06 INFO - 'log_level': 'info', 07:46:06 INFO - 'log_name': 'talos', 07:46:06 INFO - 'log_to_console': True, 07:46:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:46:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:46:06 INFO - 'opt_config_files': (), 07:46:06 INFO - 'pip_index': False, 07:46:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:06 INFO - 'cmd': ('bash', 07:46:06 INFO - '-c', 07:46:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:06 INFO - 'enabled': True, 07:46:06 INFO - 'halt_on_failure': False, 07:46:06 INFO - 'name': 'check_screen_resolution'},), 07:46:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:06 INFO - 'cmd': ('bash', 07:46:06 INFO - '-c', 07:46:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:06 INFO - 'enabled': True, 07:46:06 INFO - 'halt_on_failure': False, 07:46:06 INFO - 'name': 'check_screen_resolution'},), 07:46:06 INFO - 'run_cmd_checks_enabled': True, 07:46:06 INFO - 'suite': 'dromaeojs', 07:46:06 INFO - 'system_bits': '32', 07:46:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:06 INFO - 'title': 't-yosemite-r7-0151', 07:46:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:06 INFO - 'use_talos_json': True, 07:46:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:06 INFO - 'work_dir': 'build'} 07:46:06 INFO - [mozharness: 2017-04-24 14:46:06.114232Z] Running clobber step. 07:46:06 INFO - Running pre-action listener: _resource_record_pre_action 07:46:06 INFO - Running main action method: clobber 07:46:06 INFO - rmtree: /builds/slave/test/build 07:46:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:08 INFO - Running post-action listener: _resource_record_post_action 07:46:08 INFO - [mozharness: 2017-04-24 14:46:08.657135Z] Finished clobber step (success) 07:46:08 INFO - [mozharness: 2017-04-24 14:46:08.657400Z] Running read-buildbot-config step. 07:46:08 INFO - Running pre-action listener: _resource_record_pre_action 07:46:08 INFO - Running main action method: read_buildbot_config 07:46:08 INFO - Using buildbot properties: 07:46:08 INFO - { 07:46:08 INFO - "project": "", 07:46:08 INFO - "product": "firefox", 07:46:08 INFO - "script_repo_revision": "production", 07:46:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:46:08 INFO - "repository": "", 07:46:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:46:08 INFO - "buildid": "20170424065420", 07:46:08 INFO - "pgo_build": "False", 07:46:08 INFO - "basedir": "/builds/slave/test", 07:46:08 INFO - "buildnumber": 36, 07:46:08 INFO - "slavename": "t-yosemite-r7-0151", 07:46:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:46:08 INFO - "platform": "yosemite_r7", 07:46:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:46:08 INFO - "branch": "mozilla-central", 07:46:08 INFO - "repo_path": "mozilla-central", 07:46:08 INFO - "revision": "62b649c6b314f756f21cb95f2b0d491e2664e944", 07:46:08 INFO - "stage_platform": "macosx64", 07:46:08 INFO - "builduid": "79f062eaf83a4c3d84a370ba439c4f79", 07:46:08 INFO - "slavebuilddir": "test" 07:46:08 INFO - } 07:46:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 07:46:08 INFO - Running post-action listener: _resource_record_post_action 07:46:08 INFO - [mozharness: 2017-04-24 14:46:08.663286Z] Finished read-buildbot-config step (success) 07:46:08 INFO - [mozharness: 2017-04-24 14:46:08.663518Z] Running download-and-extract step. 07:46:08 INFO - Running pre-action listener: _resource_record_pre_action 07:46:08 INFO - Running main action method: download_and_extract 07:46:08 INFO - mkdir: /builds/slave/test/build/tests 07:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:08 INFO - trying https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 07:46:08 INFO - Downloading https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:46:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 07:46:09 INFO - Downloaded 1325 bytes. 07:46:09 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:46:09 INFO - Using the following test package requirements: 07:46:09 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 07:46:09 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:46:09 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 07:46:09 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 07:46:09 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'jsshell-mac.zip'], 07:46:09 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 07:46:09 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:46:09 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 07:46:09 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 07:46:09 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 07:46:09 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:46:09 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 07:46:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:46:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:46:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:09 INFO - Fetch https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:46:11 INFO - Content-Length response header: 52522796 07:46:11 INFO - Bytes received: 52522796 07:46:27 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:46:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:46:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:27 INFO - Fetch https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:46:29 INFO - Content-Length response header: 52522796 07:46:29 INFO - Bytes received: 52522796 07:46:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 07:46:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:46:45 INFO - Fetch https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 07:46:46 INFO - Content-Length response header: 14408822 07:46:46 INFO - Bytes received: 14408822 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:47 INFO - trying https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 07:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 07:46:49 INFO - Downloaded 71039084 bytes. 07:46:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:49 INFO - mkdir: /builds/slave/test/properties 07:46:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:49 INFO - Contents: 07:46:49 INFO - build_url:https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:49 INFO - Running post-action listener: _resource_record_post_action 07:46:49 INFO - Running post-action listener: set_extra_try_arguments 07:46:49 INFO - [mozharness: 2017-04-24 14:46:49.883735Z] Finished download-and-extract step (success) 07:46:49 INFO - [mozharness: 2017-04-24 14:46:49.883895Z] Running populate-webroot step. 07:46:49 INFO - Running pre-action listener: _resource_record_pre_action 07:46:49 INFO - Running main action method: populate_webroot 07:46:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:49 INFO - '--tppagecycles', 07:46:49 INFO - '7'], 07:46:49 INFO - 'tests': ['tsvgm']}}, 07:46:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:46:49 INFO - 'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:46:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:46:49 INFO - 'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['damp', 'tps']}, 07:46:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:46:49 INFO - 'tests': ['damp', 'tps']}, 07:46:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['dromaeo_dom']}, 07:46:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:46:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:46:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['a11yr', 07:46:49 INFO - 'ts_paint', 07:46:49 INFO - 'tpaint', 07:46:49 INFO - 'sessionrestore', 07:46:49 INFO - 'sessionrestore_no_auto_restore', 07:46:49 INFO - 'tabpaint']}, 07:46:49 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:49 INFO - 'ts_paint', 07:46:49 INFO - 'tpaint', 07:46:49 INFO - 'sessionrestore', 07:46:49 INFO - 'sessionrestore_no_auto_restore', 07:46:49 INFO - 'tabpaint']}, 07:46:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:49 INFO - 'ts_paint', 07:46:49 INFO - 'tpaint', 07:46:49 INFO - 'sessionrestore', 07:46:49 INFO - 'sessionrestore_no_auto_restore', 07:46:49 INFO - 'tabpaint']}, 07:46:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:49 INFO - 'ts_paint', 07:46:49 INFO - 'tpaint', 07:46:49 INFO - 'sessionrestore', 07:46:49 INFO - 'sessionrestore_no_auto_restore', 07:46:49 INFO - 'tabpaint']}, 07:46:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['a11yr', 07:46:49 INFO - 'ts_paint', 07:46:49 INFO - 'tpaint', 07:46:49 INFO - 'sessionrestore', 07:46:49 INFO - 'sessionrestore_no_auto_restore', 07:46:49 INFO - 'tabpaint']}, 07:46:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['a11yr', 07:46:49 INFO - 'ts_paint', 07:46:49 INFO - 'tpaint', 07:46:49 INFO - 'sessionrestore', 07:46:49 INFO - 'sessionrestore_no_auto_restore', 07:46:49 INFO - 'tabpaint']}, 07:46:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:46:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:46:49 INFO - 'bloom_basic_ref']}, 07:46:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['tsvgx', 07:46:49 INFO - 'tsvgr_opacity', 07:46:49 INFO - 'tart', 07:46:49 INFO - 'tscrollx', 07:46:49 INFO - 'cart', 07:46:49 INFO - 'tsvg_static']}, 07:46:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:49 INFO - 'tsvgr_opacity', 07:46:49 INFO - 'tart', 07:46:49 INFO - 'tscrollx', 07:46:49 INFO - 'cart', 07:46:49 INFO - 'tsvg_static']}, 07:46:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:46:49 INFO - 'talos_options': ['--disable-e10s'], 07:46:49 INFO - 'tests': ['tp5o']}, 07:46:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:46:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:46:49 INFO - 'talos_options': ['--disable-e10s', 07:46:49 INFO - '--xperf_path', 07:46:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:49 INFO - 'tests': ['tp5n']}, 07:46:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:46:49 INFO - 'talos_options': ['--xperf_path', 07:46:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:49 INFO - 'tests': ['tp5n']}}, 07:46:49 INFO - 'talos.zip': {'path': '', 07:46:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:49 INFO - Running post-action listener: _resource_record_post_action 07:46:49 INFO - [mozharness: 2017-04-24 14:46:49.903343Z] Finished populate-webroot step (success) 07:46:49 INFO - [mozharness: 2017-04-24 14:46:49.903472Z] Running create-virtualenv step. 07:46:49 INFO - Running pre-action listener: _resource_record_pre_action 07:46:49 INFO - Running main action method: create_virtualenv 07:46:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:46:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:50 INFO - Using real prefix '/tools/python27' 07:46:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:53 INFO - Installing pip.................done. 07:46:53 INFO - Return code: 0 07:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:46:54 INFO - Reading from file tmpfile_stdout 07:46:54 INFO - Output received: 07:46:54 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:46:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:54 INFO - 'HOME': '/Users/cltbld', 07:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:54 INFO - 'LOGNAME': 'cltbld', 07:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:54 INFO - 'MOZ_NO_REMOTE': '1', 07:46:54 INFO - 'NO_EM_RESTART': '1', 07:46:54 INFO - 'PAGER': '/bin/cat', 07:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:54 INFO - 'PWD': '/builds/slave/test', 07:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:54 INFO - 'SHELL': '/bin/bash', 07:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:46:54 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:54 INFO - 'USER': 'cltbld', 07:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:54 INFO - 'XPC_FLAGS': '0x0', 07:46:54 INFO - 'XPC_SERVICE_NAME': '0', 07:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:46:54 INFO - Cleaning up... 07:46:54 INFO - Return code: 0 07:46:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:54 INFO - 'HOME': '/Users/cltbld', 07:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:54 INFO - 'LOGNAME': 'cltbld', 07:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:54 INFO - 'MOZ_NO_REMOTE': '1', 07:46:54 INFO - 'NO_EM_RESTART': '1', 07:46:54 INFO - 'PAGER': '/bin/cat', 07:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:54 INFO - 'PWD': '/builds/slave/test', 07:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:54 INFO - 'SHELL': '/bin/bash', 07:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:46:54 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:54 INFO - 'USER': 'cltbld', 07:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:54 INFO - 'XPC_FLAGS': '0x0', 07:46:54 INFO - 'XPC_SERVICE_NAME': '0', 07:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:54 INFO - Downloading/unpacking psutil>=3.1.1 07:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:58 INFO - Installing collected packages: psutil 07:46:58 INFO - Running setup.py install for psutil 07:46:58 INFO - building 'psutil._psutil_osx' extension 07:46:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:46:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:46:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:46:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:46:59 INFO - building 'psutil._psutil_posix' extension 07:46:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:46:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:46:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:46:59 INFO - ^ 07:46:59 INFO - 1 warning generated. 07:46:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:59 INFO - Successfully installed psutil 07:46:59 INFO - Cleaning up... 07:46:59 INFO - Return code: 0 07:46:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:00 INFO - 'HOME': '/Users/cltbld', 07:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:00 INFO - 'LOGNAME': 'cltbld', 07:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:00 INFO - 'MOZ_NO_REMOTE': '1', 07:47:00 INFO - 'NO_EM_RESTART': '1', 07:47:00 INFO - 'PAGER': '/bin/cat', 07:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:00 INFO - 'PWD': '/builds/slave/test', 07:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:00 INFO - 'SHELL': '/bin/bash', 07:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:00 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:00 INFO - 'USER': 'cltbld', 07:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:00 INFO - 'XPC_FLAGS': '0x0', 07:47:00 INFO - 'XPC_SERVICE_NAME': '0', 07:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:03 INFO - Installing collected packages: mozsystemmonitor 07:47:03 INFO - Running setup.py install for mozsystemmonitor 07:47:04 INFO - Successfully installed mozsystemmonitor 07:47:04 INFO - Cleaning up... 07:47:04 INFO - Return code: 0 07:47:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:04 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:04 INFO - 'HOME': '/Users/cltbld', 07:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:04 INFO - 'LOGNAME': 'cltbld', 07:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:04 INFO - 'MOZ_NO_REMOTE': '1', 07:47:04 INFO - 'NO_EM_RESTART': '1', 07:47:04 INFO - 'PAGER': '/bin/cat', 07:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:04 INFO - 'PWD': '/builds/slave/test', 07:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:04 INFO - 'SHELL': '/bin/bash', 07:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:04 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:04 INFO - 'USER': 'cltbld', 07:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:04 INFO - 'XPC_FLAGS': '0x0', 07:47:04 INFO - 'XPC_SERVICE_NAME': '0', 07:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:04 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:07 INFO - warning: no files found matching '*.txt' 07:47:07 INFO - no previously-included directories found matching 'build' 07:47:07 INFO - no previously-included directories found matching 'dist' 07:47:07 INFO - no previously-included directories found matching '.git*' 07:47:07 INFO - Installing collected packages: jsonschema, functools32 07:47:07 INFO - Running setup.py install for functools32 07:47:07 INFO - warning: no files found matching '*.txt' 07:47:07 INFO - no previously-included directories found matching 'build' 07:47:07 INFO - no previously-included directories found matching 'dist' 07:47:07 INFO - no previously-included directories found matching '.git*' 07:47:07 INFO - Successfully installed jsonschema functools32 07:47:07 INFO - Cleaning up... 07:47:07 INFO - Return code: 0 07:47:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:07 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:07 INFO - 'HOME': '/Users/cltbld', 07:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:07 INFO - 'LOGNAME': 'cltbld', 07:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:07 INFO - 'MOZ_NO_REMOTE': '1', 07:47:07 INFO - 'NO_EM_RESTART': '1', 07:47:07 INFO - 'PAGER': '/bin/cat', 07:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:07 INFO - 'PWD': '/builds/slave/test', 07:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:07 INFO - 'SHELL': '/bin/bash', 07:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:07 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:07 INFO - 'USER': 'cltbld', 07:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:07 INFO - 'XPC_FLAGS': '0x0', 07:47:07 INFO - 'XPC_SERVICE_NAME': '0', 07:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:08 INFO - Cleaning up... 07:47:08 INFO - Return code: 0 07:47:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:08 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:47:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:08 INFO - 'HOME': '/Users/cltbld', 07:47:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:08 INFO - 'LOGNAME': 'cltbld', 07:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:08 INFO - 'MOZ_NO_REMOTE': '1', 07:47:08 INFO - 'NO_EM_RESTART': '1', 07:47:08 INFO - 'PAGER': '/bin/cat', 07:47:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:08 INFO - 'PWD': '/builds/slave/test', 07:47:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:08 INFO - 'SHELL': '/bin/bash', 07:47:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:08 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:08 INFO - 'USER': 'cltbld', 07:47:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:08 INFO - 'XPC_FLAGS': '0x0', 07:47:08 INFO - 'XPC_SERVICE_NAME': '0', 07:47:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:12 INFO - Downloading docopt-0.6.1.tar.gz 07:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:12 INFO - Running setup.py install for blobuploader 07:47:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:12 INFO - Running setup.py install for requests 07:47:12 INFO - Running setup.py install for docopt 07:47:13 INFO - Successfully installed blobuploader requests docopt 07:47:13 INFO - Cleaning up... 07:47:13 INFO - Return code: 0 07:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:13 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:47:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:13 INFO - 'HOME': '/Users/cltbld', 07:47:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:13 INFO - 'LOGNAME': 'cltbld', 07:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:13 INFO - 'MOZ_NO_REMOTE': '1', 07:47:13 INFO - 'NO_EM_RESTART': '1', 07:47:13 INFO - 'PAGER': '/bin/cat', 07:47:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:13 INFO - 'PWD': '/builds/slave/test', 07:47:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:13 INFO - 'SHELL': '/bin/bash', 07:47:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:13 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:13 INFO - 'USER': 'cltbld', 07:47:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:13 INFO - 'XPC_FLAGS': '0x0', 07:47:13 INFO - 'XPC_SERVICE_NAME': '0', 07:47:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:13 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-TuEQ12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:13 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-1mclhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:13 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-uSAnkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:13 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-4LfulP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:13 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-LX7wtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:13 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-88H04d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-aEcQ98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-qWDl4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-VBldfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-WrH4_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-ed8hdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-7sW36b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-GrkERC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-8Whp8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-zH0YgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:14 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-f1ZqkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:15 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Alnaqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:15 INFO - Running setup.py install for manifestparser 07:47:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:15 INFO - Running setup.py install for mozcrash 07:47:15 INFO - Running setup.py install for mozdebug 07:47:15 INFO - Running setup.py install for mozdevice 07:47:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:15 INFO - Running setup.py install for mozfile 07:47:15 INFO - Running setup.py install for mozhttpd 07:47:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Running setup.py install for mozinfo 07:47:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Running setup.py install for mozInstall 07:47:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Running setup.py install for mozleak 07:47:16 INFO - Running setup.py install for mozlog 07:47:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Running setup.py install for moznetwork 07:47:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:16 INFO - Running setup.py install for mozprocess 07:47:16 INFO - Running setup.py install for mozprofile 07:47:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:17 INFO - Running setup.py install for mozrunner 07:47:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:17 INFO - Running setup.py install for mozscreenshot 07:47:17 INFO - Running setup.py install for moztest 07:47:17 INFO - Running setup.py install for mozversion 07:47:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:17 INFO - Cleaning up... 07:47:17 INFO - Return code: 0 07:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:17 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:17 INFO - 'HOME': '/Users/cltbld', 07:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:17 INFO - 'LOGNAME': 'cltbld', 07:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:17 INFO - 'MOZ_NO_REMOTE': '1', 07:47:17 INFO - 'NO_EM_RESTART': '1', 07:47:17 INFO - 'PAGER': '/bin/cat', 07:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:17 INFO - 'PWD': '/builds/slave/test', 07:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:17 INFO - 'SHELL': '/bin/bash', 07:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:17 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:17 INFO - 'USER': 'cltbld', 07:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:17 INFO - 'XPC_FLAGS': '0x0', 07:47:17 INFO - 'XPC_SERVICE_NAME': '0', 07:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:17 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-5hhSQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-nDo78M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-yPYM_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-HAkJKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Tb0I53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-wGLncW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-AuFhlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-ccPnsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-PjRZQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:18 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Q8dkCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:19 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-VjmcV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:19 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Ud2Qry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:19 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)) 07:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:19 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-RaasMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:19 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-xDJQfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:19 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-i66dl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:19 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-KVlHxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:19 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-zVglsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:47:19 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:19 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:22 INFO - Downloading blessings-1.6.tar.gz 07:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:22 INFO - Installing collected packages: blessings 07:47:22 INFO - Running setup.py install for blessings 07:47:22 INFO - Successfully installed blessings 07:47:22 INFO - Cleaning up... 07:47:22 INFO - Return code: 0 07:47:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:22 INFO - Reading from file tmpfile_stdout 07:47:22 INFO - Current package versions: 07:47:22 INFO - blessings == 1.6 07:47:22 INFO - blobuploader == 1.2.4 07:47:22 INFO - docopt == 0.6.1 07:47:22 INFO - functools32 == 3.2.3-2 07:47:22 INFO - jsonschema == 2.5.1 07:47:22 INFO - manifestparser == 1.1 07:47:22 INFO - mozInstall == 1.12 07:47:22 INFO - mozcrash == 1.0 07:47:22 INFO - mozdebug == 0.1 07:47:22 INFO - mozdevice == 0.50 07:47:22 INFO - mozfile == 1.2 07:47:22 INFO - mozhttpd == 0.7 07:47:22 INFO - mozinfo == 0.9 07:47:22 INFO - mozleak == 0.1 07:47:22 INFO - mozlog == 3.4 07:47:22 INFO - moznetwork == 0.27 07:47:22 INFO - mozprocess == 0.25 07:47:22 INFO - mozprofile == 0.28 07:47:22 INFO - mozrunner == 6.13 07:47:22 INFO - mozscreenshot == 0.1 07:47:22 INFO - mozsystemmonitor == 0.3 07:47:22 INFO - moztest == 0.8 07:47:22 INFO - mozversion == 1.4 07:47:22 INFO - psutil == 3.1.1 07:47:22 INFO - requests == 1.2.3 07:47:22 INFO - wsgiref == 0.1.2 07:47:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:22 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:22 INFO - 'HOME': '/Users/cltbld', 07:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:22 INFO - 'LOGNAME': 'cltbld', 07:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:22 INFO - 'MOZ_NO_REMOTE': '1', 07:47:22 INFO - 'NO_EM_RESTART': '1', 07:47:22 INFO - 'PAGER': '/bin/cat', 07:47:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:22 INFO - 'PWD': '/builds/slave/test', 07:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:22 INFO - 'SHELL': '/bin/bash', 07:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:22 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:22 INFO - 'USER': 'cltbld', 07:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:22 INFO - 'XPC_FLAGS': '0x0', 07:47:22 INFO - 'XPC_SERVICE_NAME': '0', 07:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:23 INFO - Cleaning up... 07:47:23 INFO - Return code: 0 07:47:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:23 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 0x10f5abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fb1587840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, '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.EHkk1ldwch/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.DQuBA5bfxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:23 INFO - 'HOME': '/Users/cltbld', 07:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:23 INFO - 'LOGNAME': 'cltbld', 07:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:23 INFO - 'MOZ_NO_REMOTE': '1', 07:47:23 INFO - 'NO_EM_RESTART': '1', 07:47:23 INFO - 'PAGER': '/bin/cat', 07:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:23 INFO - 'PWD': '/builds/slave/test', 07:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:23 INFO - 'SHELL': '/bin/bash', 07:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:23 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:23 INFO - 'USER': 'cltbld', 07:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:23 INFO - 'XPC_FLAGS': '0x0', 07:47:23 INFO - 'XPC_SERVICE_NAME': '0', 07:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:23 INFO - Cleaning up... 07:47:23 INFO - Return code: 0 07:47:23 INFO - Running post-action listener: _resource_record_post_action 07:47:23 INFO - Running post-action listener: _start_resource_monitoring 07:47:23 INFO - Starting resource monitoring. 07:47:23 INFO - [mozharness: 2017-04-24 14:47:23.550718Z] Finished create-virtualenv step (success) 07:47:23 INFO - [mozharness: 2017-04-24 14:47:23.551675Z] Running install step. 07:47:23 INFO - Running pre-action listener: _resource_record_pre_action 07:47:23 INFO - Running main action method: install 07:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:23 INFO - Reading from file tmpfile_stdout 07:47:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:23 INFO - Reading from file tmpfile_stdout 07:47:23 INFO - Output received: 07:47:23 INFO - Usage: mozinstall [options] installer 07:47:23 INFO - Options: 07:47:23 INFO - -h, --help show this help message and exit 07:47:23 INFO - -d DEST, --destination=DEST 07:47:23 INFO - Directory to install application into. [default: 07:47:23 INFO - "/builds/slave/test"] 07:47:23 INFO - --app=APP Application being installed. [default: firefox] 07:47:23 INFO - mkdir: /builds/slave/test/build/application 07:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:47:43 INFO - Reading from file tmpfile_stdout 07:47:43 INFO - Output received: 07:47:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:47:43 INFO - Running post-action listener: _resource_record_post_action 07:47:43 INFO - [mozharness: 2017-04-24 14:47:43.467558Z] Finished install step (success) 07:47:43 INFO - [mozharness: 2017-04-24 14:47:43.467719Z] Running run-tests step. 07:47:43 INFO - Running pre-action listener: _resource_record_pre_action 07:47:43 INFO - Running main action method: run_tests 07:47:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:43 INFO - 2017-04-24 07:47:43.482 screenresolution[1627:7290] starting screenresolution argv=screenresolution get 07:47:43 INFO - 2017-04-24 07:47:43.484 screenresolution[1627:7290] Display 0: 1600x1200x32@60 07:47:43 INFO - 2017-04-24 07:47:43.490 screenresolution[1628:7292] starting screenresolution argv=screenresolution list 07:47:43 INFO - Available Modes on Display 0 07:47:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:43 INFO - Intel Iris: 07:47:43 INFO - Chipset Model: Intel Iris 07:47:43 INFO - Type: GPU 07:47:43 INFO - Bus: Built-In 07:47:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:43 INFO - Vendor: Intel (0x8086) 07:47:43 INFO - Device ID: 0x0a2e 07:47:43 INFO - Revision ID: 0x0009 07:47:43 INFO - Displays: 07:47:43 INFO - Display: 07:47:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:43 INFO - Display Serial Number: 1600x1200 60 07:47:43 INFO - Main Display: Yes 07:47:43 INFO - Mirror: Off 07:47:43 INFO - Online: Yes 07:47:43 INFO - Rotation: Supported 07:47:43 INFO - Return code: 0 07:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:43 INFO - Python 2.7.3 07:47:43 INFO - Return code: 0 07:47:43 INFO - grabbing minidump binary from tooltool 07:47: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')]} 07:47:43 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 0x10f389d30>, '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 0x10f2afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f37ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:47:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:47:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:47:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:43 INFO - Return code: 0 07:47:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:47:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:43 INFO - ENV: RUST_BACKTRACE is now 1 07:47:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:47:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0151 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EHkk1ldwch/Render', 07:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:43 INFO - 'HOME': '/Users/cltbld', 07:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:43 INFO - 'LOGNAME': 'cltbld', 07:47:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:43 INFO - 'MOZ_NO_REMOTE': '1', 07:47:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:43 INFO - 'NO_EM_RESTART': '1', 07:47:43 INFO - 'PAGER': '/bin/cat', 07:47:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:43 INFO - 'PWD': '/builds/slave/test', 07:47:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:43 INFO - 'RUST_BACKTRACE': '1', 07:47:43 INFO - 'SHELL': '/bin/bash', 07:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DQuBA5bfxm/Listeners', 07:47:43 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 07:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:43 INFO - 'USER': 'cltbld', 07:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:43 INFO - 'XPC_FLAGS': '0x0', 07:47:43 INFO - 'XPC_SERVICE_NAME': '0', 07:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:47:44 INFO - mozversion application_buildid: 20170424065420 07:47:44 INFO - mozversion application_changeset: 62b649c6b314f756f21cb95f2b0d491e2664e944 07:47:44 INFO - mozversion application_display_name: Nightly 07:47:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:44 INFO - mozversion application_name: Firefox 07:47:44 INFO - mozversion application_remotingname: firefox 07:47:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:47:44 INFO - mozversion application_vendor: Mozilla 07:47:44 INFO - mozversion application_version: 55.0a1 07:47:44 INFO - mozversion platform_buildid: 20170424065420 07:47:44 INFO - mozversion platform_changeset: 62b649c6b314f756f21cb95f2b0d491e2664e944 07:47:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:47:44 INFO - mozversion platform_version: 55.0a1 07:47:44 INFO - using testdate: 1493045264 07:47:44 INFO - actual date: 1493045264 07:47:44 INFO - starting webserver on 'localhost:49245' 07:47:44 INFO - SUITE-START | Running 2 tests 07:47:44 INFO - TEST-START | dromaeo_css 07:47:44 INFO - operating with platform_type : mac_ 07:47:44 INFO - Initialising browser for dromaeo_css test... 07:47:44 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpwA69Bc/profile http://localhost:49245/getInfo.html) 07:47:46 INFO - PID 1638 | __metrics Screen width/height:1600/1200 07:47:46 INFO - PID 1638 | colorDepth:24 07:47:46 INFO - PID 1638 | Browser inner width/height: 1024/689 07:47:46 INFO - PID 1638 | __metrics 07:47:46 INFO - PID 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:47:46 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:47 INFO - TEST-INFO | 1638: exit 0 07:47:47 INFO - Browser initialized. 07:47:47 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:47 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpwA69Bc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:59 INFO - PID 1640 | RSS: Main: 242237440 07:47:59 INFO - PID 1640 | 07:51:04 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 07:51:06 INFO - PID 1640 | RSS: Main: 401850368 07:51:06 INFO - PID 1640 | 07:52:49 INFO - PID 1640 | ************************* 07:52:49 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 07:52:49 INFO - PID 1640 | 07:52:49 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:49 INFO - PID 1640 | Full stack: 07:52:49 INFO - PID 1640 | ************************* 07:52:49 INFO - PID 1640 | ************************* 07:52:49 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 07:52:49 INFO - PID 1640 | 07:52:49 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:49 INFO - PID 1640 | Full stack: 07:52:49 INFO - PID 1640 | ************************* 07:52:49 INFO - PID 1640 | ************************* 07:52:49 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 07:52:49 INFO - PID 1640 | 07:52:49 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:49 INFO - PID 1640 | Full stack: 07:52:49 INFO - PID 1640 | ************************* 07:52:49 INFO - PID 1640 | ************************* 07:52:49 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 07:52:49 INFO - PID 1640 | 07:52:49 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:49 INFO - PID 1640 | Full stack: 07:52:49 INFO - PID 1640 | ************************* 07:54:09 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 07:54:09 INFO - PID 1640 | RSS: Main: 369917952 07:54:09 INFO - PID 1640 | 07:57:11 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 07:57:12 INFO - PID 1640 | RSS: Main: 323194880 07:57:12 INFO - PID 1640 | 08:00:14 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 08:00:15 INFO - PID 1640 | RSS: Main: 334610432 08:00:15 INFO - PID 1640 | 08:03:18 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 08:03:19 INFO - PID 1640 | RSS: Main: 333742080 08:03:19 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 08:06:21 INFO - PID 1640 | RSS: Main: 381640704 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | __start_tp_report 08:06:21 INFO - PID 1640 | _x_x_mozilla_page_load 08:06:21 INFO - PID 1640 | _x_x_mozilla_page_load_details 08:06:21 INFO - PID 1640 | |i|pagename|runs| 08:06:21 INFO - PID 1640 | |0;dojo.html;3275.7706960512764;3554.9289014219717;3559.1635965548107;3595.2449985503044;3625.5286812714357;5045.217991211368;6018.307894592123;6244.094606282087;6247.468965137963;6252.218472690914;6130.092410195547;6171.660558669271;6206.472449841769;6222.284437289713;6270.372962703727;5149.459306772791;5353.7590808413715;5360.3299587551555;5373.220882971967;5406.107992181305;5419.972900135514;5474.452554744534;5476.780928762844;5484.177373394003;5520.475554822286;5265.4997775211295;5327.334083239595;5335.626506144571;5356.464353564651;5432.70120143392;5368.946310536884;5389.326334208224;5396.83809485716;5416.512513873731;5461.2627295315415;5324.227986941872;5347.54545863602;5350.170723537819;5354.063038968204;5373.842252370327;6083.178770865965;6134.111951286458;6209.192804935375;6214;6222.719977601018;6446.774362897323;6507.544471886969;6598.8350291243105;6599.3070727573395;6603.702833372462;6259.935810912156;6692.297308782605;6701.497387695894;6710.16122984627;6715.294894036154;5713.428657134295;6170.405020193642;6283.214598175228;6299.496040316763;6300.275468321156;6494.707738151795;6610.537262391586;6753.12209412783;6821.93178068213;6838.384545390939;6266.373362663697;6330.177076979963;6331.335209802996;6336.239651241881;6477.255115661665;6560.376764207393;6602.867942641216;6620.172478440195;6624.735010599618;6674.132362792903;6502.122213501211;6573.80278591643;6600.966995164993;6612.7354905804195;6622.4039836413995;6328.936710632926;6388.201474815648;6521.576097553644;6561.245456772437;6581.769638062645;5257.684538927677;5294.100002999499;5301.973490132602;5305.867353316121;5309.283246761715;4204.915901681949;4426.136903303889;4434.6031000234825;4705.223638099744;4756.7145971241835;5943.494802941798;6179.567430279927;6184.443400094013;6235.906461403082;6239.469645080128;6418.646974416359;6525.4453371463005;6566.244881838554;6621.205455345389;6633.237177724527;6196.194494715658;6246.812595622047;6248.593841400295;6252.249730032425;6258.780942666985;5205.6616319939085;5498.477644623755;5826.329972053268;5833.154192642043;5854.912176317359;6101.610781564156;6701.061851340914;6702.497312701469;6714.194296684429;6826.180858296937;6458.741650334122;6517.576357536745;6524.347565243438;6532.542722009413;6545.607263564201;6748.527603067738;6880.8967865483055;6881.071055407456;6888.207856096613;6892.379685828299;6509.967450162909;6593.901091483535;6599.571027883172;6611.636360000246;6612.041254018044;6429.32492088324;6679.23188833271;6707.664616769044;6710.865782684416;6725.0921125649365;6150.323464418821;6416.101745755504;6442.516811239082;6481.967590162019;6509.218893732783;6342.904856427065;6370.1718776558755;6377.330380310186;6447.871042579216;6469.708863101266;5501.899620075921;6204.317525072148;6320.367963203827;6378.48972082223;6383.202099737533;6273.560850740587;6492.448141907991;6493.772717954849;6508.8047358579315;6511.120998665119;5189.844304670866;6216.813495595139;6236.563440559117;6245.500359971101;6306.684665766602 08:06:21 INFO - PID 1640 | |1;ext.html;722.6242353975932;776.196636481242;788.9447738658295;1064.3720205079007;1079.1528650009743;27159.321016974587;31935.36129277413;35505.75729849456;37293;37339.43990840133;39764.40353394694;39990.60009399905;40048.79975600125;40087.39868901969;40093;6114.2357205349335;8453.746387608366;8617.181367770083;8621.827563448727;8623.223909848113;6184.041473571604;8305.418620696553;8537.829243415128;8539.06070332263;8554.657813687476;8571.185737354941;8625.741227763147;8643.006054303742;8645.178708022759;8652.740417787476;8543.316534677242;8602.52686102261;8605.913940860573;8607.18231767981;8623.267022303111;8522.062573116953;8579.828403431959;8587.184217499327;8605.053444121142;8609.655613775441;37515.62484375149;37619.87140385765;37733.62266377356;37742.8112859434;37781.24437511262;3635.800030998294;3678.8528458861615;3679.7608155470075;3682;3683.4658974448553;30578.38843223123;30580.694193058007;30602.38795224083;30669.926552570552;30700.53949190764;3151.2909595341093;3181.3637272545584;3206.422843888099;3209.422303985282;3222.436073687119;205067;286417.5679121612;287233;287843;288276;48490.5150948493;48517;48569;48634.27048594274;48637;51678.741606291725;51767;51817;51853.70365740886;51855.44433666996;13863.029587928748;13967;13969.371378288002;13969.511067112806;14025;9785.608575657036;9812.65655702047;11343.319400835977;11345.489452974636;11363.659090227306;10855.402952837512;12351.505939762488;12490.43793029316;12513.874861251454;12628.62114136559;4426.114777044604;4999.3000979862845;5095.210242412432;5125.282460455539;5126.15418455958;988.4168340679034;989.1098011789447;997.8652881860855;1004.6031817432073;1029.2949329709172;24268.87865560696;24318.513629727306;24359.512809743705;24442.91978641524;24601.261962141165;1090.4384242115316;1098.9175811814146;1121.6410748560545;1130.5760339872547;1132.6205721083365;12205.267683938991;12426.351901732529;12434.502619895284;16130.354785808671;16359.427420040241;278912;279240;279263;279389;279610;53598.196027059625;53625.731871340395;53664;53667.73166134222;53749.731251343495;1345.3945724424048;1475.3279322877472;1475.6089636246404;1513.49297985174;1516.9696606067816;28577.285567860137;28996;29465;29544.704552954194;29618.963336283126;37834.86495405142;37879.74984127588;37956.86129416122;38000.619993800814;38002.80998594989;178971.10514447343;180006.19993799896;180032;180053;180129;29876.70123298826;30041.94853180128;34555.13612159716;34633.9609811706;34633.9609811706;37044.6295537052;37119;44977;45009.32486012647;45130.77434612806;26297;28087.71912280851;29064.27339316534;30827.845860770554;31277.06168814939;30869.228269293446;31406.37187256288;31513;31564.368712626077;31699.84150079327;36852.81573592115;37732.43401348927;38179;38244;38519.422208667456;29871;29907.55138672965;30590.84704576463;30971.380572388876;31645.367092657558;21284.72291662505;22865.77134228703;22976.19583314576;24324.635130472703;24715.62926556067 08:06:21 INFO - PID 1640 | |2;jquery.html;434.76305413549613;437.91241751649676;440.90520538084303;444.3978409255459;454.9499555048946;16610.75083873743;20235.696464553006;21354.786452135475;22037;22058.007389667462;21412.25057123001;22313.99587018584;22432.214872479468;22620.095196192175;23292.835358232107;4957.305977163191;6243.843903902393;6277.717502712366;6285.560010799223;6286.622802631857;5898.498627616657;6179.5056395488255;6243.375662433766;6249.937500624981;6267.717952692117;6069.878602427971;6195.039768835838;6215.720292586821;6225.968870155642;6230.96884515579;6009.06859436788;6166.414190651881;6196.907046394308;6204.348543402968;6215.34738852423;4679.719216847;5068.72122033288;5180.171172612401;5445.210444485567;5543.972280138614;26784.866075669495;26848.865755671097;27003.594946075824;27016.32459188536;27291.45417091647;2252.662100684894;2309.81521478283;2320.709911261092;2326.6975293211945;2333.6382860656627;14445.92777036108;17700.380486682905;17733;17956.55108622282;18316.63366732658;1846.8430183434425;2162.48100455891;2190.5509370579152;2205.2171479125;2206.5917805205927;135625;135726.999999999;135857;135864;137513;9728.25462197045;10757.503811261371;11621.825672614748;11807.291562506278;12148.635540933787;16499.257533410786;16521;16541.834581654028;16545.751813722803;16554.255058522394;8422.747317580483;8732.956335218283;8769.161631797024;8964.955175224213;8967.058458861726;6871.209810871814;8289.668413263402;8317.41778075541;8467.872981905277;8469.830603387898;6370.84072898172;7505.62471876404;7664.425168112414;7706.884396734054;7738.342240909473;2097.1820989813987;2117.4388786971463;2117.5764847030655;2118.7371447969954;2121.5332626822074;901.782829476237;977.3256453047375;979.7844474215661;982.6413359123868;1027.7482016905906;16764.83235167657;17164.369384908412;20236.392908212776;20461.590768184553;21953.890230549063;1006.6828948881079;1013.1185868294631;1037.7768779712399;1053.757635743783;1054.2567489919588;10401.5839366426;11217.775644487065;11306.717332066764;11334.773304534028;11386.886131138748;527082;528893;536439;570896;578145;121867;124826;125855.3707231458;126755.36622317015;128296.3585182068;1155.4973586489905;1163.0307618195602;1193.570314686712;1204.4339160594507;1207.5049229815734;16755.66488670244;22482.775172248723;22612.459947313015;22676.659850101933;22801.88599056994;45499.86250343768;55356.33930982077;55744;56516;58668;52848.73575632097;62636.68681656563;71445.28554714595;71451.14195432124;73433;7628.970089037909;7889.763307100796;8638.13618638131;8648.394612377326;9106.497427924318;11747.47136378848;13235.470581176645;13671.658208544866;13777.448902043807;14235;11802.350870702194;11851.881481185423;11947.402629868298;12096.939515302367;12233.632991010283;10789.892101078889;11156.386398747822;11162.274452160584;11281.887181128084;11474.655760327203;11641.708957276136;11889.687841977295;11982.64052078439;12192.512299508275;12231.75536489283;8606.61270242853;8625.784355390915;8664.263537599123;9004.829372181575;9097.1812536872;11721;11889.881101188877;12015.09886758514;12038.157328986887;12058.758824823279 08:06:21 INFO - PID 1640 | |3;mootools.html;1416.7379034878545;1455.3450947073813;1471.3673120558155;1479.1716638682335;1481.0077248243683;10306;10935.671929842098;11506.194566380347;11739.765204695901;11753.471093800777;9882.308238423313;11460.770784584323;11698.649040528777;11802.350870702108;11811.763764724701;2501.16211069292;2553.6552565403617;2557.207265747615;2564.6281289213052;2570.5244529762053;2472.83926544774;2529.064246228898;2532.1770424612073;2532.6201069839485;2539.5301869154173;2484.3664865459373;2516.55960206964;2540.720520742717;2545.0710490670863;2548.554003049468;2452.484978154581;2471.369800700828;2508.7114981777145;2508.7742103210708;2510.9372265693505;2468.222509909373;2478.368016155887;2497.250824752567;2503.0238207099246;2504.3238325652155;11665.941670291595;11760.117991150611;11790.646280611596;11791;11849.289042657469;6480.125183100268;6747.493937954673;6771.492138089663;6771.72913083476;6772.864542709168;3895.7078219133396;4171.645410140141;4265.253580623409;4301.3117901135665;4312.460942382202;1231.6058861164431;1248.082659245454;1288.896888248947;1291.0123755327088;1293.9935300323439;15060.698786024219;15429.30568124437;15442.227888605637;16374.836251637451;16487.67024659512;5416.187571864173;5556.694381809039;5733.168690539848;5736.42635736423;5739.613627959524;12233.938830305791;12257.93871030657;12260.44827982743;12266.26402415858;12271.877281227073;4693.882652933636;5844.59087863854;6575.408213260829;6591.769288074895;6598;6005.219321488178;6094.695265236809;6237.500999919996;6247.875042499125;6264.091706702594;4275.486941567032;4368.497622773358;4374.496932852699;4419.292913133948;4439.733615983051;1287.8905293050195;1291.3026965438746;1292.7802273613509;1309.6136639691315;1309.6267563744286;789.5815217934504;791.5725508225494;809.8501777171124;815.808285053012;826.9090400055989;6095.4818840398175;6198.101275315054;6277.309495955441;6351.745930162834;6457.870842583122;589.8289496046099;599.0834023943287;602.2501985028667;602.9939700603026;607.8541150123939;3076.6769489203757;3702.907642245544;3870.1872606752895;3904.863329783501;3946.131850992777;14012.229327387091;14625.926870365793;15063;15077.321520531383;15107;14793.63015924589;14929.178895160654;15202.46791362297;15232.466863659718;15258.46595369179;7486.363659088929;8407.873881891777;8602.31181505478;8690.608922598372;8691.608877600524;4504.3919070925;5879.559033072451;6849.520533562602;7133.322334378226;7145.321194486515;10534.947325263325;12393.194442361579;12726.554570589984;12804.61586152417;12902.612921612366;13292.734145316846;13419.530316438877;13766.380512876744;13809.585712428643;14227.928860355632;9343.252539796937;9651.662191823252;9655.565499552396;9678.661246856327;9686.757831053998;10504.054635082879;10703.464826758787;10808.837867431837;10814.621488247874;10817.296875703054;7760.92239077602;9056.184943354867;9097.49963752;9151.816963660822;9172.816543669223;8971.461712297283;9001.099890010946;9015.81968360616;9037.638494460149;9069.319801014819;8087.716929907425;8260.380471464545;8263.00843898736;8280.461769984931;8293.460925039853;5747.8275651728845;5915.585908986502;5918.319393269657;6123.234595675541;6186.752529898754;5804.564657650609;5976.043832986701;6193.783217587363;6213.347598502273;6307.6838786477465 08:06:21 INFO - PID 1640 | |4;prototype.html;341.6429830826786;386.2005648308002;398.71093457243495;412.3381971935046;415.4453804171429;5455.263539422177;5825.097109947959;5881.794137205198;5920.851978700534;5951.226340575725;5546.334439867212;5644.209810626506;5719.651187182224;5729.79131686256;5756.5970382073165;3607.1342877709294;4285.57144285572;4295.892602684927;4305.956940430603;4307.547707490716;4157.896052598694;4292.59220374064;4307.418498502709;4316.136772645484;4333.414988976495;3783.7729736215915;4136;4237.724547904391;4279.972806526427;4306.817047609536;4189.245935731567;4253.723507971972;4259.190753756792;4273.269325923006;4280.850170244026;3695.427208782643;3706.388445906422;3718.4608231806506;3727.5713292971386;3731.4962480065115;5104.412992505835;5427.45725427458;5623.718814059322;5625.578081643852;5698.316202055738;4251.914961700749;4489.551044895517;5047.813763765512;5088.542031217208;5094.31226784383;5306.6550674206055;6067.998780201261;6094;6098.603590766586;6123.663198524079;4005.5193376794973;4172.311568591179;4202.957970420287;4219;4222.1766755482695;6170.259568851721;6266.091416744546;6278.968605156945;6341.651209183493;6415.807525774234;3686.9631303687156;4182.849716328034;4258.1483703258855;4259.041715614024;4263.488381394252;4282.721623094551;4300.376445415397;4313.805878735465;4331.306990881444;4345.913081738411;4774.3077253798;4861.833160041565;4908.852734417973;5063.468335824759;5082.763584023018;4787.922717388629;5417.295751552273;5763.94236057634;6158.568900177034;6180.81457556274;1245.6014075495755;1278.897688184943;1424.6509605146598;1465.3113036872653;1468.3759402254;885.203317014692;907.9228265597366;917.2616044084442;989.9653512127041;1001.1490233301636;5073.315102461194;5761.6254943429385;5779.971100144472;5816.621919575214;5828.446297601721;6342.5243106767175;6350.301122023122;6354.586951848115;6359.872802544016;6386.233651961795;5063.5695965843315;5418.83743487696;5700;5701.543876489871;5793.797217097465;3040.528718048706;3247.512873069011;3282.2778988622463;3315.5855518060243;3319.1038419626566;6146.416090471398;6465.579737317059;6483.805485835338;6498.935010649928;6574.276829548746;5810.709464526757;6403.295637479873;6486.481081513468;6542.0186971953635;6567.376099270562;5933.258342707161;6187.628742275478;6531.314212007671;6560.179977502812;6572.211334639874;6276.623402595859;6340.541675414588;6359.17330747;6404.295527492065;6416.294207637063;5233.424323324355;6269.31037585856;6276.184096067482;6281.905771413524;6297.874042519033;5230.8169214077325;5342.839714808562;5385.2191432241325;6558.508111891722;6574.967125164344;4259.765712885821;4264.360345948008;4269.9146017078865;4307.923019245189;4309.827606895689;6154.753809847556;6395.424411802774;6423.357664233539;6452.9677351612945;6478.315637934077;4775.164346239325;5853.414658534112;6216.471599913877;6230.376962303733;6234.288084683178;5452.700101494297;6080.270367555921;6174.44430001302;6181.567290289637;6240.687965601611;5718.25662663851;5995.790147344822;6049.153118563493;6114;6116.602420842631;5262.158054711228;6041.516678665784;6206.848315897704;6213.751449942132;6230.719617617308;4995.750212489434;5813.244278243801;5998.220231369894;6028.698565071817;6046.486048685735 08:06:21 INFO - PID 1640 | |5;yui.html;690.7720452250752;822.5969275055223;835.319214839905;837.1461109668139;845.2097289034751;13148.276844773534;13470.259135747543;17826.465206043824;18363.173657185424;18384.72422913654;16858.157092145404;16946.406875759352;16977.405790797326;16982.83017169828;16991.57521061971;936.3632729743789;958.1903291718487;964.2045312617084;969.8060387922409;987.4914419074182;966.6520052780993;966.840471322231;967.7096870938725;968.7674958010062;992.2855544008303;1024.7694268789537;1024.825779617463;1025.902539258773;1026.1636766035695;1037.6990672704906;1013.3767732844248;1016.4104819204844;1016.6035246253966;1018.1549314069342;1030.7732298894232;752.3755283115001;755.0788038592908;756.5574139128616;762.329150347696;773.7988123087981;16144.59638509035;16259.18704064804;16432.014079155288;16793.91603041977;17008.40470583536;16810.24353904065;16834;17063.40278090261;17257.827421725746;17316.04761738104;13707.177569345871;14014.929925350309;14047.203801889947;14197.432102715879;14205.928970355082;3489.65103489649;3508.5965114011706;3510.9297814043575;3511.20997775501;3511.8244087795506;99264;122372.38813805963;122911;123841;125612.37193814064;13057.934710326388;13080.476780928657;13099.017573682013;13157.53948611794;13356.46574137043;24204.031838726252;24372.025118995043;25205.99176032938;25762;25777.226683199533;7690.923090769021;7805.648745806452;7880.881786773203;7885;7887.9605601971625;3784.545854497423;3845.4808600839087;3916.5104361954754;3921.3725803871243;3922.8626998054933;4310.827566897352;4358.150160718693;4396.648268138541;4403.713758605681;4403.735775853459;947.824652439301;952.1716106986966;964.8745663063897;967.6516454076527;968.0899954043177;610.4658423879106;644.2269276867684;656.5404217048085;660.0956689335641;677.3125277842993;10322.535485903152;11779.587714430125;11789.528418863321;11871.64385068432;11878.346690932081;637.3180696654535;651.5732195412013;655.2988302516262;655.9442447392025;673.4679603113583;5233.528982391603;5322.627416080837;5323.228131920927;5374.768584977594;5391.137418013099;110326.34510482349;112521.80955571057;113526;114103;115580.42209788898;97039.51480242553;98454;99511;101071;101522;86180;87877;87900.99999999872;88657;88686;10550.314229575053;10784.676459706221;10882.891171088188;10921.968811500601;11022.724431889266;40819.79590102149;42562.5743742571;42812.29378711737;42872.78563607162;43458;55814;56402.71798640981;56867.431325686215;56923.71538142448;57230.42769572251;13755;16111.227764945612;16117.838821611635;16819.91590042042;16823.41118060862;18309.45071647853;18375.54061148482;18480.983545905103;18617.348392806187;18703.438896833115;14559.19924404168;14637.707245855236;15842.762358564862;17220.31118755286;17276.963382197107;16536.421225257058;17294.394696186075;17310.394136205174;17382.478525644252;17482.73775893337;14103.942204334511;15989.1205983672;16037.518874433787;16470;16821.831781682515;11247.156463265124;11386.43067846621;11477.598284060017;11803.645890623295;12052.51789928393;12834.935825320814;13518.133471950287;13527.797083043959;13855.445782169003;13858.65353366174 08:06:21 INFO - PID 1640 | __end_tp_report 08:06:21 INFO - PID 1640 | __start_cc_report 08:06:21 INFO - PID 1640 | _x_x_mozilla_cycle_collect,1688 08:06:21 INFO - PID 1640 | __end_cc_report 08:06:21 INFO - PID 1640 | __startTimestamp1493046381966__endTimestamp 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | ------- Summary: start ------- 08:06:21 INFO - PID 1640 | Number of tests: 6 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6056.79 Median:6273.56 stddev:723.14 (11.5%) stddev-sans-first:691.67 08:06:21 INFO - PID 1640 | Values: 3275.8 3554.9 3559.2 3595.2 3625.5 5045.2 6018.3 6244.1 6247.5 6252.2 6130.1 6171.7 6206.5 6222.3 6270.4 5149.5 5353.8 5360.3 5373.2 5406.1 5420.0 5474.5 5476.8 5484.2 5520.5 5265.5 5327.3 5335.6 5356.5 5432.7 5368.9 5389.3 5396.8 5416.5 5461.3 5324.2 5347.5 5350.2 5354.1 5373.8 6083.2 6134.1 6209.2 6214.0 6222.7 6446.8 6507.5 6598.8 6599.3 6603.7 6259.9 6692.3 6701.5 6710.2 6715.3 5713.4 6170.4 6283.2 6299.5 6300.3 6494.7 6610.5 6753.1 6821.9 6838.4 6266.4 6330.2 6331.3 6336.2 6477.3 6560.4 6602.9 6620.2 6624.7 6674.1 6502.1 6573.8 6601.0 6612.7 6622.4 6328.9 6388.2 6521.6 6561.2 6581.8 5257.7 5294.1 5302.0 5305.9 5309.3 4204.9 4426.1 4434.6 4705.2 4756.7 5943.5 6179.6 6184.4 6235.9 6239.5 6418.6 6525.4 6566.2 6621.2 6633.2 6196.2 6246.8 6248.6 6252.2 6258.8 5205.7 5498.5 5826.3 5833.2 5854.9 6101.6 6701.1 6702.5 6714.2 6826.2 6458.7 6517.6 6524.3 6532.5 6545.6 6748.5 6880.9 6881.1 6888.2 6892.4 6510.0 6593.9 6599.6 6611.6 6612.0 6429.3 6679.2 6707.7 6710.9 6725.1 6150.3 6416.1 6442.5 6482.0 6509.2 6342.9 6370.2 6377.3 6447.9 6469.7 5501.9 6204.3 6320.4 6378.5 6383.2 6273.6 6492.4 6493.8 6508.8 6511.1 5189.8 6216.8 6236.6 6245.5 6306.7 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:40379.71 Median:18888.79 stddev:64889.45 (343.5%) stddev-sans-first:65003.17 08:06:21 INFO - PID 1640 | Values: 722.6 776.2 788.9 1064.4 1079.2 27159.3 31935.4 35505.8 37293.0 37339.4 39764.4 39990.6 40048.8 40087.4 40093.0 6114.2 8453.7 8617.2 8621.8 8623.2 6184.0 8305.4 8537.8 8539.1 8554.7 8571.2 8625.7 8643.0 8645.2 8652.7 8543.3 8602.5 8605.9 8607.2 8623.3 8522.1 8579.8 8587.2 8605.1 8609.7 37515.6 37619.9 37733.6 37742.8 37781.2 3635.8 3678.9 3679.8 3682.0 3683.5 30578.4 30580.7 30602.4 30669.9 30700.5 3151.3 3181.4 3206.4 3209.4 3222.4 205067.0 286417.6 287233.0 287843.0 288276.0 48490.5 48517.0 48569.0 48634.3 48637.0 51678.7 51767.0 51817.0 51853.7 51855.4 13863.0 13967.0 13969.4 13969.5 14025.0 9785.6 9812.7 11343.3 11345.5 11363.7 10855.4 12351.5 12490.4 12513.9 12628.6 4426.1 4999.3 5095.2 5125.3 5126.2 988.4 989.1 997.9 1004.6 1029.3 24268.9 24318.5 24359.5 24442.9 24601.3 1090.4 1098.9 1121.6 1130.6 1132.6 12205.3 12426.4 12434.5 16130.4 16359.4 278912.0 279240.0 279263.0 279389.0 279610.0 53598.2 53625.7 53664.0 53667.7 53749.7 1345.4 1475.3 1475.6 1513.5 1517.0 28577.3 28996.0 29465.0 29544.7 29619.0 37834.9 37879.7 37956.9 38000.6 38002.8 178971.1 180006.2 180032.0 180053.0 180129.0 29876.7 30041.9 34555.1 34634.0 34634.0 37044.6 37119.0 44977.0 45009.3 45130.8 26297.0 28087.7 29064.3 30827.8 31277.1 30869.2 31406.4 31513.0 31564.4 31699.8 36852.8 37732.4 38179.0 38244.0 38519.4 29871.0 29907.6 30590.8 30971.4 31645.4 21284.7 22865.8 22976.2 24324.6 24715.6 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:34420.67 Median:12432.56 stddev:92266.18 (742.1%) stddev-sans-first:92489.73 08:06:21 INFO - PID 1640 | Values: 434.8 437.9 440.9 444.4 454.9 16610.8 20235.7 21354.8 22037.0 22058.0 21412.3 22314.0 22432.2 22620.1 23292.8 4957.3 6243.8 6277.7 6285.6 6286.6 5898.5 6179.5 6243.4 6249.9 6267.7 6069.9 6195.0 6215.7 6226.0 6231.0 6009.1 6166.4 6196.9 6204.3 6215.3 4679.7 5068.7 5180.2 5445.2 5544.0 26784.9 26848.9 27003.6 27016.3 27291.5 2252.7 2309.8 2320.7 2326.7 2333.6 14445.9 17700.4 17733.0 17956.6 18316.6 1846.8 2162.5 2190.6 2205.2 2206.6 135625.0 135727.0 135857.0 135864.0 137513.0 9728.3 10757.5 11621.8 11807.3 12148.6 16499.3 16521.0 16541.8 16545.8 16554.3 8422.7 8733.0 8769.2 8965.0 8967.1 6871.2 8289.7 8317.4 8467.9 8469.8 6370.8 7505.6 7664.4 7706.9 7738.3 2097.2 2117.4 2117.6 2118.7 2121.5 901.8 977.3 979.8 982.6 1027.7 16764.8 17164.4 20236.4 20461.6 21953.9 1006.7 1013.1 1037.8 1053.8 1054.3 10401.6 11217.8 11306.7 11334.8 11386.9 527082.0 528893.0 536439.0 570896.0 578145.0 121867.0 124826.0 125855.4 126755.4 128296.4 1155.5 1163.0 1193.6 1204.4 1207.5 16755.7 22482.8 22612.5 22676.7 22801.9 45499.9 55356.3 55744.0 56516.0 58668.0 52848.7 62636.7 71445.3 71451.1 73433.0 7629.0 7889.8 8638.1 8648.4 9106.5 11747.5 13235.5 13671.7 13777.4 14235.0 11802.4 11851.9 11947.4 12096.9 12233.6 10789.9 11156.4 11162.3 11281.9 11474.7 11641.7 11889.7 11982.6 12192.5 12231.8 8606.6 8625.8 8664.3 9004.8 9097.2 11721.0 11889.9 12015.1 12038.2 12058.8 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7014.67 Median:3786.55 stddev:4442.90 (117.3%) stddev-sans-first:4435.45 08:06:21 INFO - PID 1640 | Values: 1416.7 1455.3 1471.4 1479.2 1481.0 10306.0 10935.7 11506.2 11739.8 11753.5 9882.3 11460.8 11698.6 11802.4 11811.8 2501.2 2553.7 2557.2 2564.6 2570.5 2472.8 2529.1 2532.2 2532.6 2539.5 2484.4 2516.6 2540.7 2545.1 2548.6 2452.5 2471.4 2508.7 2508.8 2510.9 2468.2 2478.4 2497.3 2503.0 2504.3 11665.9 11760.1 11790.6 11791.0 11849.3 6480.1 6747.5 6771.5 6771.7 6772.9 3895.7 4171.6 4265.3 4301.3 4312.5 1231.6 1248.1 1288.9 1291.0 1294.0 15060.7 15429.3 15442.2 16374.8 16487.7 5416.2 5556.7 5733.2 5736.4 5739.6 12233.9 12257.9 12260.4 12266.3 12271.9 4693.9 5844.6 6575.4 6591.8 6598.0 6005.2 6094.7 6237.5 6247.9 6264.1 4275.5 4368.5 4374.5 4419.3 4439.7 1287.9 1291.3 1292.8 1309.6 1309.6 789.6 791.6 809.9 815.8 826.9 6095.5 6198.1 6277.3 6351.7 6457.9 589.8 599.1 602.3 603.0 607.9 3076.7 3702.9 3870.2 3904.9 3946.1 14012.2 14625.9 15063.0 15077.3 15107.0 14793.6 14929.2 15202.5 15232.5 15258.5 7486.4 8407.9 8602.3 8690.6 8691.6 4504.4 5879.6 6849.5 7133.3 7145.3 10534.9 12393.2 12726.6 12804.6 12902.6 13292.7 13419.5 13766.4 13809.6 14227.9 9343.3 9651.7 9655.6 9678.7 9686.8 10504.1 10703.5 10808.8 10814.6 10817.3 7760.9 9056.2 9097.5 9151.8 9172.8 8971.5 9001.1 9015.8 9037.6 9069.3 8087.7 8260.4 8263.0 8280.5 8293.5 5747.8 5915.6 5918.3 6123.2 6186.8 5804.6 5976.0 6193.8 6213.3 6307.7 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:4971.98 Median:5634.89 stddev:1546.17 (27.4%) stddev-sans-first:1510.94 08:06:21 INFO - PID 1640 | Values: 341.6 386.2 398.7 412.3 415.4 5455.3 5825.1 5881.8 5920.9 5951.2 5546.3 5644.2 5719.7 5729.8 5756.6 3607.1 4285.6 4295.9 4306.0 4307.5 4157.9 4292.6 4307.4 4316.1 4333.4 3783.8 4136.0 4237.7 4280.0 4306.8 4189.2 4253.7 4259.2 4273.3 4280.9 3695.4 3706.4 3718.5 3727.6 3731.5 5104.4 5427.5 5623.7 5625.6 5698.3 4251.9 4489.6 5047.8 5088.5 5094.3 5306.7 6068.0 6094.0 6098.6 6123.7 4005.5 4172.3 4203.0 4219.0 4222.2 6170.3 6266.1 6279.0 6341.7 6415.8 3687.0 4182.8 4258.1 4259.0 4263.5 4282.7 4300.4 4313.8 4331.3 4345.9 4774.3 4861.8 4908.9 5063.5 5082.8 4787.9 5417.3 5763.9 6158.6 6180.8 1245.6 1278.9 1424.7 1465.3 1468.4 885.2 907.9 917.3 990.0 1001.1 5073.3 5761.6 5780.0 5816.6 5828.4 6342.5 6350.3 6354.6 6359.9 6386.2 5063.6 5418.8 5700.0 5701.5 5793.8 3040.5 3247.5 3282.3 3315.6 3319.1 6146.4 6465.6 6483.8 6498.9 6574.3 5810.7 6403.3 6486.5 6542.0 6567.4 5933.3 6187.6 6531.3 6560.2 6572.2 6276.6 6340.5 6359.2 6404.3 6416.3 5233.4 6269.3 6276.2 6281.9 6297.9 5230.8 5342.8 5385.2 6558.5 6575.0 4259.8 4264.4 4269.9 4307.9 4309.8 6154.8 6395.4 6423.4 6453.0 6478.3 4775.2 5853.4 6216.5 6230.4 6234.3 5452.7 6080.3 6174.4 6181.6 6240.7 5718.3 5995.8 6049.2 6114.0 6116.6 5262.2 6041.5 6206.8 6213.8 6230.7 4995.8 5813.2 5998.2 6028.7 6046.5 08:06:21 INFO - PID 1640 | 08:06:21 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:22255.22 Median:18369.36 stddev:31743.90 (172.8%) stddev-sans-first:31791.65 08:06:21 INFO - PID 1640 | Values: 690.8 822.6 835.3 837.1 845.2 13148.3 13470.3 17826.5 18363.2 18384.7 16858.2 16946.4 16977.4 16982.8 16991.6 936.4 958.2 964.2 969.8 987.5 966.7 966.8 967.7 968.8 992.3 1024.8 1024.8 1025.9 1026.2 1037.7 1013.4 1016.4 1016.6 1018.2 1030.8 752.4 755.1 756.6 762.3 773.8 16144.6 16259.2 16432.0 16793.9 17008.4 16810.2 16834.0 17063.4 17257.8 17316.0 13707.2 14014.9 14047.2 14197.4 14205.9 3489.7 3508.6 3510.9 3511.2 3511.8 99264.0 122372.4 122911.0 123841.0 125612.4 13057.9 13080.5 13099.0 13157.5 13356.5 24204.0 24372.0 25206.0 25762.0 25777.2 7690.9 7805.6 7880.9 7885.0 7888.0 3784.5 3845.5 3916.5 3921.4 3922.9 4310.8 4358.2 4396.6 4403.7 4403.7 947.8 952.2 964.9 967.7 968.1 610.5 644.2 656.5 660.1 677.3 10322.5 11779.6 11789.5 11871.6 11878.3 637.3 651.6 655.3 655.9 673.5 5233.5 5322.6 5323.2 5374.8 5391.1 110326.3 112521.8 113526.0 114103.0 115580.4 97039.5 98454.0 99511.0 101071.0 101522.0 86180.0 87877.0 87901.0 88657.0 88686.0 10550.3 10784.7 10882.9 10922.0 11022.7 40819.8 42562.6 42812.3 42872.8 43458.0 55814.0 56402.7 56867.4 56923.7 57230.4 13755.0 16111.2 16117.8 16819.9 16823.4 18309.5 18375.5 18481.0 18617.3 18703.4 14559.2 14637.7 15842.8 17220.3 17277.0 16536.4 17294.4 17310.4 17382.5 17482.7 14103.9 15989.1 16037.5 16470.0 16821.8 11247.2 11386.4 11477.6 11803.6 12052.5 12834.9 13518.1 13527.8 13855.4 13858.7 08:06:21 INFO - PID 1640 | -------- Summary: end -------- 08:06:21 INFO - PID 1640 | 08:06:22 INFO - TEST-INFO | 1640: exit 0 08:06:22 INFO - TEST-OK | dromaeo_css | took 1118502ms 08:06:22 INFO - TEST-START | kraken 08:06:22 INFO - operating with platform_type : mac_ 08:06:22 INFO - Initialising browser for kraken test... 08:06:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpOeSh1D/profile http://localhost:49245/getInfo.html) 08:06:25 INFO - PID 1650 | __metrics Screen width/height:1600/1200 08:06:25 INFO - PID 1650 | colorDepth:24 08:06:25 INFO - PID 1650 | Browser inner width/height: 1024/689 08:06:25 INFO - PID 1650 | __metrics 08:06:25 INFO - PID 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:25 INFO - PID 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:26 INFO - TEST-INFO | 1650: exit 0 08:06:26 INFO - Browser initialized. 08:06:26 INFO - Running cycle 1/1 for kraken test... 08:06:26 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpOeSh1D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:38 INFO - PID 1651 | RSS: Main: 242208768 08:06:38 INFO - PID 1651 | 08:06:41 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:41 INFO - PID 1651 | RSS: Main: 312766464 08:06:41 INFO - PID 1651 | 08:06:44 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 08:06:45 INFO - PID 1651 | RSS: Main: 293945344 08:06:45 INFO - PID 1651 | 08:06:48 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 08:06:49 INFO - PID 1651 | RSS: Main: 386543616 08:06:49 INFO - PID 1651 | 08:06:51 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 08:06:51 INFO - PID 1651 | RSS: Main: 288690176 08:06:51 INFO - PID 1651 | 08:06:53 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:54 INFO - PID 1651 | RSS: Main: 291352576 08:06:54 INFO - PID 1651 | 08:06:56 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:57 INFO - PID 1651 | RSS: Main: 354054144 08:06:57 INFO - PID 1651 | 08:07:00 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:01 INFO - PID 1651 | RSS: Main: 370315264 08:07:01 INFO - PID 1651 | 08:07:03 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 08:07:04 INFO - PID 1651 | RSS: Main: 376381440 08:07:04 INFO - PID 1651 | 08:07:05 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:06 INFO - PID 1651 | RSS: Main: 332812288 08:07:06 INFO - PID 1651 | 08:07:08 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:09 INFO - PID 1651 | RSS: Main: 333643776 08:07:09 INFO - PID 1651 | 08:07:11 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:11 INFO - PID 1651 | RSS: Main: 335630336 08:07:11 INFO - PID 1651 | 08:07:14 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:15 INFO - PID 1651 | RSS: Main: 350867456 08:07:15 INFO - PID 1651 | 08:07:18 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:19 INFO - PID 1651 | RSS: Main: 343580672 08:07:19 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 08:07:21 INFO - PID 1651 | RSS: Main: 385957888 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | __start_tp_report 08:07:21 INFO - PID 1651 | _x_x_mozilla_page_load 08:07:21 INFO - PID 1651 | _x_x_mozilla_page_load_details 08:07:21 INFO - PID 1651 | |i|pagename|runs| 08:07:21 INFO - PID 1651 | |0;ai-astar;111;110;109;111;110;111;109;111;111;109 08:07:21 INFO - PID 1651 | |1;audio-beat-detection;144;111;107;148;109;111;143;141;135;108 08:07:21 INFO - PID 1651 | |2;audio-dft;187;184;182;185;185;184;183;184;185;183 08:07:21 INFO - PID 1651 | |3;audio-fft;80;61;57;87;60;57;57;58;84;58 08:07:21 INFO - PID 1651 | |4;audio-oscillator;91;71;85;69;67;69;88;67;67;90 08:07:21 INFO - PID 1651 | |5;imaging-gaussian-blur;87;86;86;86;86;85;87;87;87;87 08:07:21 INFO - PID 1651 | |6;imaging-darkroom;93;94;99;94;94;94;94;95;93;94 08:07:21 INFO - PID 1651 | |7;imaging-desaturate;83;82;87;88;84;86;83;85;86;85 08:07:21 INFO - PID 1651 | |8;json-parse-financial;51;48;48;47;50;49;50;49;48;50 08:07:21 INFO - PID 1651 | |9;json-stringify-tinderbox;54;65;67;62;63;59;58;55;57;57 08:07:21 INFO - PID 1651 | |10;stanford-crypto-aes;83;82;83;83;96;72;83;95;103;105 08:07:21 INFO - PID 1651 | |11;stanford-crypto-ccm;147;132;126;144;141;126;128;121;208;158 08:07:21 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;182;185;185;187;184;180;178;181;206;207 08:07:21 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;68;66;68;66;67;68;63;91;96;94 08:07:21 INFO - PID 1651 | __end_tp_report 08:07:21 INFO - PID 1651 | __start_cc_report 08:07:21 INFO - PID 1651 | _x_x_mozilla_cycle_collect,2139 08:07:21 INFO - PID 1651 | __end_cc_report 08:07:21 INFO - PID 1651 | __startTimestamp1493046441288__endTimestamp 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | ------- Summary: start ------- 08:07:21 INFO - PID 1651 | Number of tests: 14 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 08:07:21 INFO - PID 1651 | Values: 111.0 110.0 109.0 111.0 110.0 111.0 109.0 111.0 111.0 109.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:138.00 stddev:17.72 (12.8%) stddev-sans-first:17.51 08:07:21 INFO - PID 1651 | Values: 144.0 111.0 107.0 148.0 109.0 111.0 143.0 141.0 135.0 108.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.40 (0.8%) stddev-sans-first:1.05 08:07:21 INFO - PID 1651 | Values: 187.0 184.0 182.0 185.0 185.0 184.0 183.0 184.0 185.0 183.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.50 stddev:12.44 (20.6%) stddev-sans-first:12.10 08:07:21 INFO - PID 1651 | Values: 80.0 61.0 57.0 87.0 60.0 57.0 57.0 58.0 84.0 58.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:78.00 stddev:10.60 (13.6%) stddev-sans-first:9.83 08:07:21 INFO - PID 1651 | Values: 91.0 71.0 85.0 69.0 67.0 69.0 88.0 67.0 67.0 90.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 08:07:21 INFO - PID 1651 | Values: 87.0 86.0 86.0 86.0 86.0 85.0 87.0 87.0 87.0 87.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.00 stddev:1.71 (1.8%) stddev-sans-first:1.74 08:07:21 INFO - PID 1651 | Values: 93.0 94.0 99.0 94.0 94.0 94.0 94.0 95.0 93.0 94.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.91 (2.2%) stddev-sans-first:1.90 08:07:21 INFO - PID 1651 | Values: 83.0 82.0 87.0 88.0 84.0 86.0 83.0 85.0 86.0 85.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:49.50 stddev:1.25 (2.5%) stddev-sans-first:1.09 08:07:21 INFO - PID 1651 | Values: 51.0 48.0 48.0 47.0 50.0 49.0 50.0 49.0 48.0 50.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.50 stddev:4.35 (7.2%) stddev-sans-first:4.09 08:07:21 INFO - PID 1651 | Values: 54.0 65.0 67.0 62.0 63.0 59.0 58.0 55.0 57.0 57.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:83.00 stddev:10.63 (12.8%) stddev-sans-first:11.08 08:07:21 INFO - PID 1651 | Values: 83.0 82.0 83.0 83.0 96.0 72.0 83.0 95.0 103.0 105.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:142.50 stddev:25.56 (17.9%) stddev-sans-first:27.07 08:07:21 INFO - PID 1651 | Values: 147.0 132.0 126.0 144.0 141.0 126.0 128.0 121.0 208.0 158.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.50 Median:185.00 stddev:10.36 (5.6%) stddev-sans-first:10.80 08:07:21 INFO - PID 1651 | Values: 182.0 185.0 185.0 187.0 184.0 180.0 178.0 181.0 206.0 207.0 08:07:21 INFO - PID 1651 | 08:07:21 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:68.00 stddev:13.22 (19.4%) stddev-sans-first:13.80 08:07:21 INFO - PID 1651 | Values: 68.0 66.0 68.0 66.0 67.0 68.0 63.0 91.0 96.0 94.0 08:07:21 INFO - PID 1651 | -------- Summary: end -------- 08:07:21 INFO - PID 1651 | 08:07:22 INFO - TEST-INFO | 1651: exit 0 08:07:22 INFO - TEST-OK | kraken | took 59803ms 08:07:22 INFO - SUITE-END | took 1178s 08:07:22 INFO - Completed test suite (00:19:38) 08:07:22 INFO - javascript benchmark 08:07:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7698.951266995736, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.7706960512764, 3554.9289014219717, 3559.1635965548107, 3595.2449985503044, 3625.5286812714357, 5045.217991211368, 6018.307894592123, 6244.094606282087, 6247.468965137963, 6252.218472690914, 6130.092410195547, 6171.660558669271, 6206.472449841769, 6222.284437289713, 6270.372962703727, 5149.459306772791, 5353.7590808413715, 5360.3299587551555, 5373.220882971967, 5406.107992181305, 5419.972900135514, 5474.452554744534, 5476.780928762844, 5484.177373394003, 5520.475554822286, 5265.4997775211295, 5327.334083239595, 5335.626506144571, 5356.464353564651, 5432.70120143392, 5368.946310536884, 5389.326334208224, 5396.83809485716, 5416.512513873731, 5461.2627295315415, 5324.227986941872, 5347.54545863602, 5350.170723537819, 5354.063038968204, 5373.842252370327, 6083.178770865965, 6134.111951286458, 6209.192804935375, 6214.0, 6222.719977601018, 6446.774362897323, 6507.544471886969, 6598.8350291243105, 6599.3070727573395, 6603.702833372462, 6259.935810912156, 6692.297308782605, 6701.497387695894, 6710.16122984627, 6715.294894036154, 5713.428657134295, 6170.405020193642, 6283.214598175228, 6299.496040316763, 6300.275468321156, 6494.707738151795, 6610.537262391586, 6753.12209412783, 6821.93178068213, 6838.384545390939, 6266.373362663697, 6330.177076979963, 6331.335209802996, 6336.239651241881, 6477.255115661665, 6560.376764207393, 6602.867942641216, 6620.172478440195, 6624.735010599618, 6674.132362792903, 6502.122213501211, 6573.80278591643, 6600.966995164993, 6612.7354905804195, 6622.4039836413995, 6328.936710632926, 6388.201474815648, 6521.576097553644, 6561.245456772437, 6581.769638062645, 5257.684538927677, 5294.100002999499, 5301.973490132602, 5305.867353316121, 5309.283246761715, 4204.915901681949, 4426.136903303889, 4434.6031000234825, 4705.223638099744, 4756.7145971241835, 5943.494802941798, 6179.567430279927, 6184.443400094013, 6235.906461403082, 6239.469645080128, 6418.646974416359, 6525.4453371463005, 6566.244881838554, 6621.205455345389, 6633.237177724527, 6196.194494715658, 6246.812595622047, 6248.593841400295, 6252.249730032425, 6258.780942666985, 5205.6616319939085, 5498.477644623755, 5826.329972053268, 5833.154192642043, 5854.912176317359, 6101.610781564156, 6701.061851340914, 6702.497312701469, 6714.194296684429, 6826.180858296937, 6458.741650334122, 6517.576357536745, 6524.347565243438, 6532.542722009413, 6545.607263564201, 6748.527603067738, 6880.8967865483055, 6881.071055407456, 6888.207856096613, 6892.379685828299, 6509.967450162909, 6593.901091483535, 6599.571027883172, 6611.636360000246, 6612.041254018044, 6429.32492088324, 6679.23188833271, 6707.664616769044, 6710.865782684416, 6725.0921125649365, 6150.323464418821, 6416.101745755504, 6442.516811239082, 6481.967590162019, 6509.218893732783, 6342.904856427065, 6370.1718776558755, 6377.330380310186, 6447.871042579216, 6469.708863101266, 5501.899620075921, 6204.317525072148, 6320.367963203827, 6378.48972082223, 6383.202099737533, 6273.560850740587, 6492.448141907991, 6493.772717954849, 6508.8047358579315, 6511.120998665119, 5189.844304670866, 6216.813495595139, 6236.563440559117, 6245.500359971101, 6306.684665766602], "value": 6008.442223558325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.6242353975932, 776.196636481242, 788.9447738658295, 1064.3720205079007, 1079.1528650009743, 27159.321016974587, 31935.36129277413, 35505.75729849456, 37293.0, 37339.43990840133, 39764.40353394694, 39990.60009399905, 40048.79975600125, 40087.39868901969, 40093.0, 6114.2357205349335, 8453.746387608366, 8617.181367770083, 8621.827563448727, 8623.223909848113, 6184.041473571604, 8305.418620696553, 8537.829243415128, 8539.06070332263, 8554.657813687476, 8571.185737354941, 8625.741227763147, 8643.006054303742, 8645.178708022759, 8652.740417787476, 8543.316534677242, 8602.52686102261, 8605.913940860573, 8607.18231767981, 8623.267022303111, 8522.062573116953, 8579.828403431959, 8587.184217499327, 8605.053444121142, 8609.655613775441, 37515.62484375149, 37619.87140385765, 37733.62266377356, 37742.8112859434, 37781.24437511262, 3635.800030998294, 3678.8528458861615, 3679.7608155470075, 3682.0, 3683.4658974448553, 30578.38843223123, 30580.694193058007, 30602.38795224083, 30669.926552570552, 30700.53949190764, 3151.2909595341093, 3181.3637272545584, 3206.422843888099, 3209.422303985282, 3222.436073687119, 205067.0, 286417.5679121612, 287233.0, 287843.0, 288276.0, 48490.5150948493, 48517.0, 48569.0, 48634.27048594274, 48637.0, 51678.741606291725, 51767.0, 51817.0, 51853.70365740886, 51855.44433666996, 13863.029587928748, 13967.0, 13969.371378288002, 13969.511067112806, 14025.0, 9785.608575657036, 9812.65655702047, 11343.319400835977, 11345.489452974636, 11363.659090227306, 10855.402952837512, 12351.505939762488, 12490.43793029316, 12513.874861251454, 12628.62114136559, 4426.114777044604, 4999.3000979862845, 5095.210242412432, 5125.282460455539, 5126.15418455958, 988.4168340679034, 989.1098011789447, 997.8652881860855, 1004.6031817432073, 1029.2949329709172, 24268.87865560696, 24318.513629727306, 24359.512809743705, 24442.91978641524, 24601.261962141165, 1090.4384242115316, 1098.9175811814146, 1121.6410748560545, 1130.5760339872547, 1132.6205721083365, 12205.267683938991, 12426.351901732529, 12434.502619895284, 16130.354785808671, 16359.427420040241, 278912.0, 279240.0, 279263.0, 279389.0, 279610.0, 53598.196027059625, 53625.731871340395, 53664.0, 53667.73166134222, 53749.731251343495, 1345.3945724424048, 1475.3279322877472, 1475.6089636246404, 1513.49297985174, 1516.9696606067816, 28577.285567860137, 28996.0, 29465.0, 29544.704552954194, 29618.963336283126, 37834.86495405142, 37879.74984127588, 37956.86129416122, 38000.619993800814, 38002.80998594989, 178971.10514447343, 180006.19993799896, 180032.0, 180053.0, 180129.0, 29876.70123298826, 30041.94853180128, 34555.13612159716, 34633.9609811706, 34633.9609811706, 37044.6295537052, 37119.0, 44977.0, 45009.32486012647, 45130.77434612806, 26297.0, 28087.71912280851, 29064.27339316534, 30827.845860770554, 31277.06168814939, 30869.228269293446, 31406.37187256288, 31513.0, 31564.368712626077, 31699.84150079327, 36852.81573592115, 37732.43401348927, 38179.0, 38244.0, 38519.422208667456, 29871.0, 29907.55138672965, 30590.84704576463, 30971.380572388876, 31645.367092657558, 21284.72291662505, 22865.77134228703, 22976.19583314576, 24324.635130472703, 24715.62926556067], "value": 17076.29566688331, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.76305413549613, 437.91241751649676, 440.90520538084303, 444.3978409255459, 454.9499555048946, 16610.75083873743, 20235.696464553006, 21354.786452135475, 22037.0, 22058.007389667462, 21412.25057123001, 22313.99587018584, 22432.214872479468, 22620.095196192175, 23292.835358232107, 4957.305977163191, 6243.843903902393, 6277.717502712366, 6285.560010799223, 6286.622802631857, 5898.498627616657, 6179.5056395488255, 6243.375662433766, 6249.937500624981, 6267.717952692117, 6069.878602427971, 6195.039768835838, 6215.720292586821, 6225.968870155642, 6230.96884515579, 6009.06859436788, 6166.414190651881, 6196.907046394308, 6204.348543402968, 6215.34738852423, 4679.719216847, 5068.72122033288, 5180.171172612401, 5445.210444485567, 5543.972280138614, 26784.866075669495, 26848.865755671097, 27003.594946075824, 27016.32459188536, 27291.45417091647, 2252.662100684894, 2309.81521478283, 2320.709911261092, 2326.6975293211945, 2333.6382860656627, 14445.92777036108, 17700.380486682905, 17733.0, 17956.55108622282, 18316.63366732658, 1846.8430183434425, 2162.48100455891, 2190.5509370579152, 2205.2171479125, 2206.5917805205927, 135625.0, 135726.999999999, 135857.0, 135864.0, 137513.0, 9728.25462197045, 10757.503811261371, 11621.825672614748, 11807.291562506278, 12148.635540933787, 16499.257533410786, 16521.0, 16541.834581654028, 16545.751813722803, 16554.255058522394, 8422.747317580483, 8732.956335218283, 8769.161631797024, 8964.955175224213, 8967.058458861726, 6871.209810871814, 8289.668413263402, 8317.41778075541, 8467.872981905277, 8469.830603387898, 6370.84072898172, 7505.62471876404, 7664.425168112414, 7706.884396734054, 7738.342240909473, 2097.1820989813987, 2117.4388786971463, 2117.5764847030655, 2118.7371447969954, 2121.5332626822074, 901.782829476237, 977.3256453047375, 979.7844474215661, 982.6413359123868, 1027.7482016905906, 16764.83235167657, 17164.369384908412, 20236.392908212776, 20461.590768184553, 21953.890230549063, 1006.6828948881079, 1013.1185868294631, 1037.7768779712399, 1053.757635743783, 1054.2567489919588, 10401.5839366426, 11217.775644487065, 11306.717332066764, 11334.773304534028, 11386.886131138748, 527082.0, 528893.0, 536439.0, 570896.0, 578145.0, 121867.0, 124826.0, 125855.3707231458, 126755.36622317015, 128296.3585182068, 1155.4973586489905, 1163.0307618195602, 1193.570314686712, 1204.4339160594507, 1207.5049229815734, 16755.66488670244, 22482.775172248723, 22612.459947313015, 22676.659850101933, 22801.88599056994, 45499.86250343768, 55356.33930982077, 55744.0, 56516.0, 58668.0, 52848.73575632097, 62636.68681656563, 71445.28554714595, 71451.14195432124, 73433.0, 7628.970089037909, 7889.763307100796, 8638.13618638131, 8648.394612377326, 9106.497427924318, 11747.47136378848, 13235.470581176645, 13671.658208544866, 13777.448902043807, 14235.0, 11802.350870702194, 11851.881481185423, 11947.402629868298, 12096.939515302367, 12233.632991010283, 10789.892101078889, 11156.386398747822, 11162.274452160584, 11281.887181128084, 11474.655760327203, 11641.708957276136, 11889.687841977295, 11982.64052078439, 12192.512299508275, 12231.75536489283, 8606.61270242853, 8625.784355390915, 8664.263537599123, 9004.829372181575, 9097.1812536872, 11721.0, 11889.881101188877, 12015.09886758514, 12038.157328986887, 12058.758824823279], "value": 10252.475137534806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.7379034878545, 1455.3450947073813, 1471.3673120558155, 1479.1716638682335, 1481.0077248243683, 10306.0, 10935.671929842098, 11506.194566380347, 11739.765204695901, 11753.471093800777, 9882.308238423313, 11460.770784584323, 11698.649040528777, 11802.350870702108, 11811.763764724701, 2501.16211069292, 2553.6552565403617, 2557.207265747615, 2564.6281289213052, 2570.5244529762053, 2472.83926544774, 2529.064246228898, 2532.1770424612073, 2532.6201069839485, 2539.5301869154173, 2484.3664865459373, 2516.55960206964, 2540.720520742717, 2545.0710490670863, 2548.554003049468, 2452.484978154581, 2471.369800700828, 2508.7114981777145, 2508.7742103210708, 2510.9372265693505, 2468.222509909373, 2478.368016155887, 2497.250824752567, 2503.0238207099246, 2504.3238325652155, 11665.941670291595, 11760.117991150611, 11790.646280611596, 11791.0, 11849.289042657469, 6480.125183100268, 6747.493937954673, 6771.492138089663, 6771.72913083476, 6772.864542709168, 3895.7078219133396, 4171.645410140141, 4265.253580623409, 4301.3117901135665, 4312.460942382202, 1231.6058861164431, 1248.082659245454, 1288.896888248947, 1291.0123755327088, 1293.9935300323439, 15060.698786024219, 15429.30568124437, 15442.227888605637, 16374.836251637451, 16487.67024659512, 5416.187571864173, 5556.694381809039, 5733.168690539848, 5736.42635736423, 5739.613627959524, 12233.938830305791, 12257.93871030657, 12260.44827982743, 12266.26402415858, 12271.877281227073, 4693.882652933636, 5844.59087863854, 6575.408213260829, 6591.769288074895, 6598.0, 6005.219321488178, 6094.695265236809, 6237.500999919996, 6247.875042499125, 6264.091706702594, 4275.486941567032, 4368.497622773358, 4374.496932852699, 4419.292913133948, 4439.733615983051, 1287.8905293050195, 1291.3026965438746, 1292.7802273613509, 1309.6136639691315, 1309.6267563744286, 789.5815217934504, 791.5725508225494, 809.8501777171124, 815.808285053012, 826.9090400055989, 6095.4818840398175, 6198.101275315054, 6277.309495955441, 6351.745930162834, 6457.870842583122, 589.8289496046099, 599.0834023943287, 602.2501985028667, 602.9939700603026, 607.8541150123939, 3076.6769489203757, 3702.907642245544, 3870.1872606752895, 3904.863329783501, 3946.131850992777, 14012.229327387091, 14625.926870365793, 15063.0, 15077.321520531383, 15107.0, 14793.63015924589, 14929.178895160654, 15202.46791362297, 15232.466863659718, 15258.46595369179, 7486.363659088929, 8407.873881891777, 8602.31181505478, 8690.608922598372, 8691.608877600524, 4504.3919070925, 5879.559033072451, 6849.520533562602, 7133.322334378226, 7145.321194486515, 10534.947325263325, 12393.194442361579, 12726.554570589984, 12804.61586152417, 12902.612921612366, 13292.734145316846, 13419.530316438877, 13766.380512876744, 13809.585712428643, 14227.928860355632, 9343.252539796937, 9651.662191823252, 9655.565499552396, 9678.661246856327, 9686.757831053998, 10504.054635082879, 10703.464826758787, 10808.837867431837, 10814.621488247874, 10817.296875703054, 7760.92239077602, 9056.184943354867, 9097.49963752, 9151.816963660822, 9172.816543669223, 8971.461712297283, 9001.099890010946, 9015.81968360616, 9037.638494460149, 9069.319801014819, 8087.716929907425, 8260.380471464545, 8263.00843898736, 8280.461769984931, 8293.460925039853, 5747.8275651728845, 5915.585908986502, 5918.319393269657, 6123.234595675541, 6186.752529898754, 5804.564657650609, 5976.043832986701, 6193.783217587363, 6213.347598502273, 6307.6838786477465], "value": 5275.873075253106, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6429830826786, 386.2005648308002, 398.71093457243495, 412.3381971935046, 415.4453804171429, 5455.263539422177, 5825.097109947959, 5881.794137205198, 5920.851978700534, 5951.226340575725, 5546.334439867212, 5644.209810626506, 5719.651187182224, 5729.79131686256, 5756.5970382073165, 3607.1342877709294, 4285.57144285572, 4295.892602684927, 4305.956940430603, 4307.547707490716, 4157.896052598694, 4292.59220374064, 4307.418498502709, 4316.136772645484, 4333.414988976495, 3783.7729736215915, 4136.0, 4237.724547904391, 4279.972806526427, 4306.817047609536, 4189.245935731567, 4253.723507971972, 4259.190753756792, 4273.269325923006, 4280.850170244026, 3695.427208782643, 3706.388445906422, 3718.4608231806506, 3727.5713292971386, 3731.4962480065115, 5104.412992505835, 5427.45725427458, 5623.718814059322, 5625.578081643852, 5698.316202055738, 4251.914961700749, 4489.551044895517, 5047.813763765512, 5088.542031217208, 5094.31226784383, 5306.6550674206055, 6067.998780201261, 6094.0, 6098.603590766586, 6123.663198524079, 4005.5193376794973, 4172.311568591179, 4202.957970420287, 4219.0, 4222.1766755482695, 6170.259568851721, 6266.091416744546, 6278.968605156945, 6341.651209183493, 6415.807525774234, 3686.9631303687156, 4182.849716328034, 4258.1483703258855, 4259.041715614024, 4263.488381394252, 4282.721623094551, 4300.376445415397, 4313.805878735465, 4331.306990881444, 4345.913081738411, 4774.3077253798, 4861.833160041565, 4908.852734417973, 5063.468335824759, 5082.763584023018, 4787.922717388629, 5417.295751552273, 5763.94236057634, 6158.568900177034, 6180.81457556274, 1245.6014075495755, 1278.897688184943, 1424.6509605146598, 1465.3113036872653, 1468.3759402254, 885.203317014692, 907.9228265597366, 917.2616044084442, 989.9653512127041, 1001.1490233301636, 5073.315102461194, 5761.6254943429385, 5779.971100144472, 5816.621919575214, 5828.446297601721, 6342.5243106767175, 6350.301122023122, 6354.586951848115, 6359.872802544016, 6386.233651961795, 5063.5695965843315, 5418.83743487696, 5700.0, 5701.543876489871, 5793.797217097465, 3040.528718048706, 3247.512873069011, 3282.2778988622463, 3315.5855518060243, 3319.1038419626566, 6146.416090471398, 6465.579737317059, 6483.805485835338, 6498.935010649928, 6574.276829548746, 5810.709464526757, 6403.295637479873, 6486.481081513468, 6542.0186971953635, 6567.376099270562, 5933.258342707161, 6187.628742275478, 6531.314212007671, 6560.179977502812, 6572.211334639874, 6276.623402595859, 6340.541675414588, 6359.17330747, 6404.295527492065, 6416.294207637063, 5233.424323324355, 6269.31037585856, 6276.184096067482, 6281.905771413524, 6297.874042519033, 5230.8169214077325, 5342.839714808562, 5385.2191432241325, 6558.508111891722, 6574.967125164344, 4259.765712885821, 4264.360345948008, 4269.9146017078865, 4307.923019245189, 4309.827606895689, 6154.753809847556, 6395.424411802774, 6423.357664233539, 6452.9677351612945, 6478.315637934077, 4775.164346239325, 5853.414658534112, 6216.471599913877, 6230.376962303733, 6234.288084683178, 5452.700101494297, 6080.270367555921, 6174.44430001302, 6181.567290289637, 6240.687965601611, 5718.25662663851, 5995.790147344822, 6049.153118563493, 6114.0, 6116.602420842631, 5262.158054711228, 6041.516678665784, 6206.848315897704, 6213.751449942132, 6230.719617617308, 4995.750212489434, 5813.244278243801, 5998.220231369894, 6028.698565071817, 6046.486048685735], "value": 4489.536691036471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.7720452250752, 822.5969275055223, 835.319214839905, 837.1461109668139, 845.2097289034751, 13148.276844773534, 13470.259135747543, 17826.465206043824, 18363.173657185424, 18384.72422913654, 16858.157092145404, 16946.406875759352, 16977.405790797326, 16982.83017169828, 16991.57521061971, 936.3632729743789, 958.1903291718487, 964.2045312617084, 969.8060387922409, 987.4914419074182, 966.6520052780993, 966.840471322231, 967.7096870938725, 968.7674958010062, 992.2855544008303, 1024.7694268789537, 1024.825779617463, 1025.902539258773, 1026.1636766035695, 1037.6990672704906, 1013.3767732844248, 1016.4104819204844, 1016.6035246253966, 1018.1549314069342, 1030.7732298894232, 752.3755283115001, 755.0788038592908, 756.5574139128616, 762.329150347696, 773.7988123087981, 16144.59638509035, 16259.18704064804, 16432.014079155288, 16793.91603041977, 17008.40470583536, 16810.24353904065, 16834.0, 17063.40278090261, 17257.827421725746, 17316.04761738104, 13707.177569345871, 14014.929925350309, 14047.203801889947, 14197.432102715879, 14205.928970355082, 3489.65103489649, 3508.5965114011706, 3510.9297814043575, 3511.20997775501, 3511.8244087795506, 99264.0, 122372.38813805963, 122911.0, 123841.0, 125612.37193814064, 13057.934710326388, 13080.476780928657, 13099.017573682013, 13157.53948611794, 13356.46574137043, 24204.031838726252, 24372.025118995043, 25205.99176032938, 25762.0, 25777.226683199533, 7690.923090769021, 7805.648745806452, 7880.881786773203, 7885.0, 7887.9605601971625, 3784.545854497423, 3845.4808600839087, 3916.5104361954754, 3921.3725803871243, 3922.8626998054933, 4310.827566897352, 4358.150160718693, 4396.648268138541, 4403.713758605681, 4403.735775853459, 947.824652439301, 952.1716106986966, 964.8745663063897, 967.6516454076527, 968.0899954043177, 610.4658423879106, 644.2269276867684, 656.5404217048085, 660.0956689335641, 677.3125277842993, 10322.535485903152, 11779.587714430125, 11789.528418863321, 11871.64385068432, 11878.346690932081, 637.3180696654535, 651.5732195412013, 655.2988302516262, 655.9442447392025, 673.4679603113583, 5233.528982391603, 5322.627416080837, 5323.228131920927, 5374.768584977594, 5391.137418013099, 110326.34510482349, 112521.80955571057, 113526.0, 114103.0, 115580.42209788898, 97039.51480242553, 98454.0, 99511.0, 101071.0, 101522.0, 86180.0, 87877.0, 87900.99999999872, 88657.0, 88686.0, 10550.314229575053, 10784.676459706221, 10882.891171088188, 10921.968811500601, 11022.724431889266, 40819.79590102149, 42562.5743742571, 42812.29378711737, 42872.78563607162, 43458.0, 55814.0, 56402.71798640981, 56867.431325686215, 56923.71538142448, 57230.42769572251, 13755.0, 16111.227764945612, 16117.838821611635, 16819.91590042042, 16823.41118060862, 18309.45071647853, 18375.54061148482, 18480.983545905103, 18617.348392806187, 18703.438896833115, 14559.19924404168, 14637.707245855236, 15842.762358564862, 17220.31118755286, 17276.963382197107, 16536.421225257058, 17294.394696186075, 17310.394136205174, 17382.478525644252, 17482.73775893337, 14103.942204334511, 15989.1205983672, 16037.518874433787, 16470.0, 16821.831781682515, 11247.156463265124, 11386.43067846621, 11477.598284060017, 11803.645890623295, 12052.51789928393, 12834.935825320814, 13518.133471950287, 13527.797083043959, 13855.445782169003, 13858.65353366174], "value": 8357.50520644889, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 109.0, 111.0, 110.0, 111.0, 109.0, 111.0, 111.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 107.0, 148.0, 109.0, 111.0, 143.0, 141.0, 135.0, 108.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 182.0, 185.0, 185.0, 184.0, 183.0, 184.0, 185.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 57.0, 87.0, 60.0, 57.0, 57.0, 58.0, 84.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 85.0, 69.0, 67.0, 69.0, 88.0, 67.0, 67.0, 90.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 86.0, 85.0, 87.0, 87.0, 87.0, 87.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 99.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 87.0, 88.0, 84.0, 86.0, 83.0, 85.0, 86.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 48.0, 47.0, 50.0, 49.0, 50.0, 49.0, 48.0, 50.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 65.0, 67.0, 62.0, 63.0, 59.0, 58.0, 55.0, 57.0, 57.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 96.0, 72.0, 83.0, 95.0, 103.0, 105.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 132.0, 126.0, 144.0, 141.0, 126.0, 128.0, 121.0, 208.0, 158.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 185.0, 187.0, 184.0, 180.0, 178.0, 181.0, 206.0, 207.0], "value": 187.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 66.0, 67.0, 68.0, 63.0, 91.0, 96.0, 94.0], "value": 74.7, "unit": "score"}]}]} 08:07:22 INFO - Return code: 0 08:07:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:22 ERROR - # TBPL SUCCESS # 08:07:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:22 INFO - 2017-04-24 08:07:22.585 screenresolution[1655:9716] starting screenresolution argv=screenresolution get 08:07:22 INFO - 2017-04-24 08:07:22.588 screenresolution[1655:9716] Display 0: 1600x1200x32@60 08:07:22 INFO - 2017-04-24 08:07:22.594 screenresolution[1656:9719] starting screenresolution argv=screenresolution list 08:07:22 INFO - Available Modes on Display 0 08:07:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:22 INFO - Intel Iris: 08:07:22 INFO - Chipset Model: Intel Iris 08:07:22 INFO - Type: GPU 08:07:22 INFO - Bus: Built-In 08:07:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:22 INFO - Vendor: Intel (0x8086) 08:07:22 INFO - Device ID: 0x0a2e 08:07:22 INFO - Revision ID: 0x0009 08:07:22 INFO - Displays: 08:07:22 INFO - Display: 08:07:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:22 INFO - Display Serial Number: 1600x1200 60 08:07:22 INFO - Main Display: Yes 08:07:22 INFO - Mirror: Off 08:07:22 INFO - Online: Yes 08:07:22 INFO - Rotation: Supported 08:07:22 INFO - Return code: 0 08:07:22 INFO - Running post-action listener: _resource_record_post_action 08:07:22 INFO - [mozharness: 2017-04-24 15:07:22.837839Z] Finished run-tests step (success) 08:07:22 INFO - Running post-run listener: _resource_record_post_run 08:07:22 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 39187456; Write bytes: 504175616; Read time: 381; Write time: 1506 08:07:22 INFO - TinderboxPrint: CPU usage
53.2% 08:07:22 INFO - TinderboxPrint: I/O read bytes / time
39,187,456 / 381 08:07:22 INFO - TinderboxPrint: I/O write bytes / time
504,175,616 / 1,506 08:07:22 INFO - TinderboxPrint: CPU idle
2,244.0 (46.8%) 08:07:22 INFO - TinderboxPrint: CPU system
951.1 (19.8%) 08:07:22 INFO - TinderboxPrint: CPU user
1,598.5 (33.3%) 08:07:22 INFO - TinderboxPrint: Swap in / out
247,099,392 / 0 08:07:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194636288; Write bytes: 193120256; Read time: 14889; Write time: 355 08:07:22 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 38216704; Write bytes: 294233088; Read time: 363; Write time: 1101 08:07:23 INFO - Running post-run listener: _upload_blobber_files 08:07:23 INFO - Blob upload gear active. 08:07:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:24 INFO - (blobuploader) - INFO - Done attempting. 08:07:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:25 INFO - (blobuploader) - INFO - Done attempting. 08:07:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:07:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:07:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:26 INFO - (blobuploader) - INFO - Done attempting. 08:07:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:28 INFO - (blobuploader) - INFO - Done attempting. 08:07:28 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:28 INFO - Return code: 0 08:07:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8dc3a46c6b013ce162d0bae8794ee38a7f939b9b2c4ffff07958ef44ae51a3db0bbebf7e1290258d59babe8588de0e20f7ff85958361ea3db20f62cd8b8852d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c149c617ac3696a6d8e6f53fe7f00df9fddc138e49fdb00ecac590d2e7ccf90779725c0e405d62c9c695d4daa35f053b21569972052e80afaf29eeab73c7d6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9595ca804f860365dea8c1ca5cc152582666272a7a9cae72b848a8bd418db9d153a2d810f026275f5c7ebaaec940d6c0d71358258bee8cdbddeaa983d0239cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e14117e822bf684d35c5be2cffcc1a34eb71778738e163da14b8314e2e6f97ac0fcb3c8117f68bc079739cdfcc271c16d86560acddbcb9eca2b8bdbe715f7c1"} 08:07:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:28 INFO - Contents: 08:07:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8dc3a46c6b013ce162d0bae8794ee38a7f939b9b2c4ffff07958ef44ae51a3db0bbebf7e1290258d59babe8588de0e20f7ff85958361ea3db20f62cd8b8852d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c149c617ac3696a6d8e6f53fe7f00df9fddc138e49fdb00ecac590d2e7ccf90779725c0e405d62c9c695d4daa35f053b21569972052e80afaf29eeab73c7d6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9595ca804f860365dea8c1ca5cc152582666272a7a9cae72b848a8bd418db9d153a2d810f026275f5c7ebaaec940d6c0d71358258bee8cdbddeaa983d0239cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e14117e822bf684d35c5be2cffcc1a34eb71778738e163da14b8314e2e6f97ac0fcb3c8117f68bc079739cdfcc271c16d86560acddbcb9eca2b8bdbe715f7c1"} 08:07:28 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:28 INFO - Copying logs to upload dir... 08:07:28 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.055281 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-24 08:07:29.000032) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:29.003574) ========= 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.EHkk1ldwch/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.DQuBA5bfxm/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8dc3a46c6b013ce162d0bae8794ee38a7f939b9b2c4ffff07958ef44ae51a3db0bbebf7e1290258d59babe8588de0e20f7ff85958361ea3db20f62cd8b8852d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c149c617ac3696a6d8e6f53fe7f00df9fddc138e49fdb00ecac590d2e7ccf90779725c0e405d62c9c695d4daa35f053b21569972052e80afaf29eeab73c7d6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9595ca804f860365dea8c1ca5cc152582666272a7a9cae72b848a8bd418db9d153a2d810f026275f5c7ebaaec940d6c0d71358258bee8cdbddeaa983d0239cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e14117e822bf684d35c5be2cffcc1a34eb71778738e163da14b8314e2e6f97ac0fcb3c8117f68bc079739cdfcc271c16d86560acddbcb9eca2b8bdbe715f7c1"} build_url:https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.013521 build_url: 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8dc3a46c6b013ce162d0bae8794ee38a7f939b9b2c4ffff07958ef44ae51a3db0bbebf7e1290258d59babe8588de0e20f7ff85958361ea3db20f62cd8b8852d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c149c617ac3696a6d8e6f53fe7f00df9fddc138e49fdb00ecac590d2e7ccf90779725c0e405d62c9c695d4daa35f053b21569972052e80afaf29eeab73c7d6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9595ca804f860365dea8c1ca5cc152582666272a7a9cae72b848a8bd418db9d153a2d810f026275f5c7ebaaec940d6c0d71358258bee8cdbddeaa983d0239cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e14117e822bf684d35c5be2cffcc1a34eb71778738e163da14b8314e2e6f97ac0fcb3c8117f68bc079739cdfcc271c16d86560acddbcb9eca2b8bdbe715f7c1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:29.043438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:29.043760) ========= 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.EHkk1ldwch/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.DQuBA5bfxm/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005525 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:29.092088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 08:07:29.092413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 08:07:29.092743) ========= ========= Total master_lag: 0.38 =========