builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0033 starttime: 1487785471.89 results: success (0) buildid: 20170222080928 builduid: b3a5c38c4763487e98d67fcc066aa45b revision: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.887701) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.888124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.888394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.914655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.915275) ========= 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.kFmUePx8vf/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.HuNfLX1U87/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-02-22 09:44:31-- 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% 15.3M=0.001s 2017-02-22 09:44:32 (15.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125137 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:32.065517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:32.066223) ========= 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.kFmUePx8vf/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.HuNfLX1U87/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.038802 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:32.127862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-22 09:44:32.128692) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7abeac2f2d668554f0093fc0bdb1488f9a77d16e --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 7abeac2f2d668554f0093fc0bdb1488f9a77d16e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kFmUePx8vf/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.HuNfLX1U87/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-02-22 09:44:32,237 truncating revision to first 12 chars 2017-02-22 09:44:32,237 Setting DEBUG logging. 2017-02-22 09:44:32,237 attempt 1/10 2017-02-22 09:44:32,237 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7abeac2f2d66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 09:44:34,106 unpacking tar archive at: mozilla-central-7abeac2f2d66/testing/mozharness/ program finished with exit code 0 elapsedTime=2.142970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-22 09:44:34.294102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:34.294503) ========= script_repo_revision: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:34.294909) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:34.295173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:34.312822) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-22 09:44:34.313229) ========= /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.kFmUePx8vf/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.HuNfLX1U87/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:44:34 INFO - MultiFileLogger online at 20170222 09:44:34 in /builds/slave/test 09:44:34 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 09:44:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:34 INFO - {'append_to_log': False, 09:44:34 INFO - 'base_work_dir': '/builds/slave/test', 09:44:34 INFO - 'blob_upload_branch': 'Firefox', 09:44:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:34 INFO - 'branch': 'Firefox', 09:44:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:34 INFO - 'config_files': ('talos/mac_config.py',), 09:44:34 INFO - 'default_actions': ('clobber', 09:44:34 INFO - 'read-buildbot-config', 09:44:34 INFO - 'download-and-extract', 09:44:34 INFO - 'populate-webroot', 09:44:34 INFO - 'create-virtualenv', 09:44:34 INFO - 'install', 09:44:34 INFO - 'run-tests'), 09:44:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:34 INFO - 'download_minidump_stackwalk': True, 09:44:34 INFO - 'download_symbols': 'ondemand', 09:44:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:34 INFO - 'gecko_profile': False, 09:44:34 INFO - 'gecko_profile_interval': 0, 09:44:34 INFO - 'installer_path': 'installer.exe', 09:44:34 INFO - 'log_level': 'info', 09:44:34 INFO - 'log_name': 'talos', 09:44:34 INFO - 'log_to_console': True, 09:44:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:44:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:44:34 INFO - 'opt_config_files': (), 09:44:34 INFO - 'pip_index': False, 09:44:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:34 INFO - 'cmd': ('bash', 09:44:34 INFO - '-c', 09:44:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:34 INFO - 'enabled': True, 09:44:34 INFO - 'halt_on_failure': False, 09:44:34 INFO - 'name': 'check_screen_resolution'},), 09:44:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:34 INFO - 'cmd': ('bash', 09:44:34 INFO - '-c', 09:44:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:34 INFO - 'enabled': True, 09:44:34 INFO - 'halt_on_failure': False, 09:44:34 INFO - 'name': 'check_screen_resolution'},), 09:44:34 INFO - 'run_cmd_checks_enabled': True, 09:44:34 INFO - 'suite': 'dromaeojs', 09:44:34 INFO - 'system_bits': '32', 09:44:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:34 INFO - 'title': 't-yosemite-r7-0033', 09:44:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:34 INFO - 'use_talos_json': True, 09:44:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:34 INFO - 'work_dir': 'build'} 09:44:34 INFO - [mozharness: 2017-02-22 17:44:34.534499Z] Running clobber step. 09:44:34 INFO - Running pre-action listener: _resource_record_pre_action 09:44:34 INFO - Running main action method: clobber 09:44:34 INFO - rmtree: /builds/slave/test/build 09:44:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:36 INFO - Running post-action listener: _resource_record_post_action 09:44:36 INFO - [mozharness: 2017-02-22 17:44:36.989741Z] Finished clobber step (success) 09:44:36 INFO - [mozharness: 2017-02-22 17:44:36.989981Z] Running read-buildbot-config step. 09:44:36 INFO - Running pre-action listener: _resource_record_pre_action 09:44:36 INFO - Running main action method: read_buildbot_config 09:44:36 INFO - Using buildbot properties: 09:44:36 INFO - { 09:44:36 INFO - "project": "", 09:44:36 INFO - "product": "firefox", 09:44:36 INFO - "script_repo_revision": "production", 09:44:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:44:36 INFO - "repository": "", 09:44:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:44:36 INFO - "buildid": "20170222080928", 09:44:36 INFO - "pgo_build": "False", 09:44:36 INFO - "basedir": "/builds/slave/test", 09:44:36 INFO - "buildnumber": 52, 09:44:36 INFO - "slavename": "t-yosemite-r7-0033", 09:44:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:44:36 INFO - "platform": "yosemite_r7", 09:44:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:44:36 INFO - "branch": "mozilla-central", 09:44:36 INFO - "repo_path": "mozilla-central", 09:44:36 INFO - "revision": "7abeac2f2d668554f0093fc0bdb1488f9a77d16e", 09:44:36 INFO - "stage_platform": "macosx64", 09:44:36 INFO - "builduid": "b3a5c38c4763487e98d67fcc066aa45b", 09:44:36 INFO - "slavebuilddir": "test" 09:44:36 INFO - } 09:44:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 09:44:36 INFO - Running post-action listener: _resource_record_post_action 09:44:36 INFO - [mozharness: 2017-02-22 17:44:36.995692Z] Finished read-buildbot-config step (success) 09:44:36 INFO - [mozharness: 2017-02-22 17:44:36.995902Z] Running download-and-extract step. 09:44:36 INFO - Running pre-action listener: _resource_record_pre_action 09:44:36 INFO - Running main action method: download_and_extract 09:44:36 INFO - mkdir: /builds/slave/test/build/tests 09:44:36 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')]} 09:44:36 INFO - trying https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 09:44:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 09:44:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 09:44:38 INFO - Downloaded 1199 bytes. 09:44:38 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 09:44:38 INFO - Using the following test package requirements: 09:44:38 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:44:38 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 09:44:38 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 09:44:38 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'jsshell-mac.zip'], 09:44:38 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 09:44:38 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:44:38 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 09:44:38 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 09:44:38 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 09:44:38 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:38 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 09:44:38 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:44:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:44:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:44:39 INFO - Expected file size: 51467815 09:44:39 INFO - Obtained file size: 51467815 09:44:55 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:44:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:44:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:44:58 INFO - Expected file size: 51467815 09:44:58 INFO - Obtained file size: 51467815 09:45:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 09:45:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:45:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 09:45:14 INFO - Expected file size: 14404319 09:45:14 INFO - Obtained file size: 14404319 09:45:14 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')]} 09:45:14 INFO - trying https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:45:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 09:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 09:45:16 INFO - Downloaded 74796646 bytes. 09:45:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:45:16 INFO - mkdir: /builds/slave/test/properties 09:45:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:16 INFO - Contents: 09:45:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:45:17 INFO - Running post-action listener: _resource_record_post_action 09:45:17 INFO - Running post-action listener: set_extra_try_arguments 09:45:17 INFO - [mozharness: 2017-02-22 17:45:17.460871Z] Finished download-and-extract step (success) 09:45:17 INFO - [mozharness: 2017-02-22 17:45:17.461000Z] Running populate-webroot step. 09:45:17 INFO - Running pre-action listener: _resource_record_pre_action 09:45:17 INFO - Running main action method: populate_webroot 09:45:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:17 INFO - '--tppagecycles', 09:45:17 INFO - '7'], 09:45:17 INFO - 'tests': ['tsvgm']}}, 09:45:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:45:17 INFO - 'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:45:17 INFO - 'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['damp', 'tps']}, 09:45:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:45:17 INFO - 'tests': ['damp', 'tps']}, 09:45:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['dromaeo_dom']}, 09:45:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['basic_compositor_video']}, 09:45:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['a11yr', 09:45:17 INFO - 'ts_paint', 09:45:17 INFO - 'tpaint', 09:45:17 INFO - 'sessionrestore', 09:45:17 INFO - 'sessionrestore_no_auto_restore', 09:45:17 INFO - 'tabpaint']}, 09:45:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:17 INFO - 'ts_paint', 09:45:17 INFO - 'tpaint', 09:45:17 INFO - 'sessionrestore', 09:45:17 INFO - 'sessionrestore_no_auto_restore', 09:45:17 INFO - 'tabpaint']}, 09:45:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:17 INFO - 'ts_paint', 09:45:17 INFO - 'tpaint', 09:45:17 INFO - 'sessionrestore', 09:45:17 INFO - 'sessionrestore_no_auto_restore', 09:45:17 INFO - 'tabpaint']}, 09:45:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:17 INFO - 'ts_paint', 09:45:17 INFO - 'tpaint', 09:45:17 INFO - 'sessionrestore', 09:45:17 INFO - 'sessionrestore_no_auto_restore', 09:45:17 INFO - 'tabpaint']}, 09:45:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['a11yr', 09:45:17 INFO - 'ts_paint', 09:45:17 INFO - 'tpaint', 09:45:17 INFO - 'sessionrestore', 09:45:17 INFO - 'sessionrestore_no_auto_restore', 09:45:17 INFO - 'tabpaint']}, 09:45:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['a11yr', 09:45:17 INFO - 'ts_paint', 09:45:17 INFO - 'tpaint', 09:45:17 INFO - 'sessionrestore', 09:45:17 INFO - 'sessionrestore_no_auto_restore', 09:45:17 INFO - 'tabpaint']}, 09:45:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['tsvgx', 09:45:17 INFO - 'tsvgr_opacity', 09:45:17 INFO - 'tart', 09:45:17 INFO - 'tscrollx', 09:45:17 INFO - 'cart', 09:45:17 INFO - 'tsvg_static']}, 09:45:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:17 INFO - 'tsvgr_opacity', 09:45:17 INFO - 'tart', 09:45:17 INFO - 'tscrollx', 09:45:17 INFO - 'cart', 09:45:17 INFO - 'tsvg_static']}, 09:45:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:45:17 INFO - 'talos_options': ['--disable-e10s'], 09:45:17 INFO - 'tests': ['tp5o']}, 09:45:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:45:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:45:17 INFO - 'talos_options': ['--disable-e10s', 09:45:17 INFO - '--xperf_path', 09:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:17 INFO - 'tests': ['tp5n']}, 09:45:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:45:17 INFO - 'talos_options': ['--xperf_path', 09:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:17 INFO - 'tests': ['tp5n']}}, 09:45:17 INFO - 'talos.zip': {'path': '', 09:45:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:17 INFO - Running post-action listener: _resource_record_post_action 09:45:17 INFO - [mozharness: 2017-02-22 17:45:17.479327Z] Finished populate-webroot step (success) 09:45:17 INFO - [mozharness: 2017-02-22 17:45:17.479434Z] Running create-virtualenv step. 09:45:17 INFO - Running pre-action listener: _resource_record_pre_action 09:45:17 INFO - Running main action method: create_virtualenv 09:45:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:17 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 09:45:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:17 INFO - Using real prefix '/tools/python27' 09:45:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:21 INFO - Installing pip.................done. 09:45:21 INFO - Return code: 0 09:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:45:21 INFO - Reading from file tmpfile_stdout 09:45:21 INFO - Output received: 09:45:21 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) 09:45:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:21 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:21 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 09:45:21 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 09:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:21 INFO - 'HOME': '/Users/cltbld', 09:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:21 INFO - 'LOGNAME': 'cltbld', 09:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:21 INFO - 'MOZ_NO_REMOTE': '1', 09:45:21 INFO - 'NO_EM_RESTART': '1', 09:45:21 INFO - 'PAGER': '/bin/cat', 09:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:21 INFO - 'PWD': '/builds/slave/test', 09:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:21 INFO - 'SHELL': '/bin/bash', 09:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:21 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:21 INFO - 'USER': 'cltbld', 09:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:21 INFO - 'XPC_FLAGS': '0x0', 09:45:21 INFO - 'XPC_SERVICE_NAME': '0', 09:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:21 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 09:45:21 INFO - Cleaning up... 09:45:21 INFO - Return code: 0 09:45:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:21 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:21 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 09:45:21 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 09:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:21 INFO - 'HOME': '/Users/cltbld', 09:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:21 INFO - 'LOGNAME': 'cltbld', 09:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:21 INFO - 'MOZ_NO_REMOTE': '1', 09:45:21 INFO - 'NO_EM_RESTART': '1', 09:45:21 INFO - 'PAGER': '/bin/cat', 09:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:21 INFO - 'PWD': '/builds/slave/test', 09:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:21 INFO - 'SHELL': '/bin/bash', 09:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:21 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:21 INFO - 'USER': 'cltbld', 09:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:21 INFO - 'XPC_FLAGS': '0x0', 09:45:21 INFO - 'XPC_SERVICE_NAME': '0', 09:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:21 INFO - Downloading/unpacking psutil>=3.1.1 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:21 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 09:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:25 INFO - Installing collected packages: psutil 09:45:25 INFO - Running setup.py install for psutil 09:45:25 INFO - building 'psutil._psutil_osx' extension 09:45:25 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 09:45:26 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 09:45:26 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 09:45:26 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 09:45:26 INFO - building 'psutil._psutil_posix' extension 09:45:26 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 09:45:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:45:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:45:26 INFO - ^ 09:45:26 INFO - 1 warning generated. 09:45:26 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 09:45:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:26 INFO - Successfully installed psutil 09:45:26 INFO - Cleaning up... 09:45:26 INFO - Return code: 0 09:45:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:26 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')]} 09:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:26 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')]} 09:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:26 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:26 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 09:45:26 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 09:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:26 INFO - 'HOME': '/Users/cltbld', 09:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:26 INFO - 'LOGNAME': 'cltbld', 09:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:26 INFO - 'MOZ_NO_REMOTE': '1', 09:45:26 INFO - 'NO_EM_RESTART': '1', 09:45:26 INFO - 'PAGER': '/bin/cat', 09:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:26 INFO - 'PWD': '/builds/slave/test', 09:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:26 INFO - 'SHELL': '/bin/bash', 09:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:26 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:26 INFO - 'USER': 'cltbld', 09:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:26 INFO - 'XPC_FLAGS': '0x0', 09:45:26 INFO - 'XPC_SERVICE_NAME': '0', 09:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:29 INFO - Installing collected packages: mozsystemmonitor 09:45:29 INFO - Running setup.py install for mozsystemmonitor 09:45:29 INFO - Successfully installed mozsystemmonitor 09:45:29 INFO - Cleaning up... 09:45:30 INFO - Return code: 0 09:45:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:30 INFO - 'HOME': '/Users/cltbld', 09:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:30 INFO - 'LOGNAME': 'cltbld', 09:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:30 INFO - 'MOZ_NO_REMOTE': '1', 09:45:30 INFO - 'NO_EM_RESTART': '1', 09:45:30 INFO - 'PAGER': '/bin/cat', 09:45:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:30 INFO - 'PWD': '/builds/slave/test', 09:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:30 INFO - 'SHELL': '/bin/bash', 09:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:30 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:30 INFO - 'USER': 'cltbld', 09:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:30 INFO - 'XPC_FLAGS': '0x0', 09:45:30 INFO - 'XPC_SERVICE_NAME': '0', 09:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:34 INFO - warning: no files found matching '*.txt' 09:45:34 INFO - no previously-included directories found matching 'build' 09:45:34 INFO - no previously-included directories found matching 'dist' 09:45:34 INFO - no previously-included directories found matching '.git*' 09:45:34 INFO - Installing collected packages: jsonschema, functools32 09:45:34 INFO - Running setup.py install for functools32 09:45:34 INFO - warning: no files found matching '*.txt' 09:45:34 INFO - no previously-included directories found matching 'build' 09:45:34 INFO - no previously-included directories found matching 'dist' 09:45:34 INFO - no previously-included directories found matching '.git*' 09:45:34 INFO - Successfully installed jsonschema functools32 09:45:34 INFO - Cleaning up... 09:45:34 INFO - Return code: 0 09:45:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:45:34 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')]} 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:34 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')]} 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:34 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:34 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 09:45:34 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 09:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:34 INFO - 'HOME': '/Users/cltbld', 09:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:34 INFO - 'LOGNAME': 'cltbld', 09:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:34 INFO - 'MOZ_NO_REMOTE': '1', 09:45:34 INFO - 'NO_EM_RESTART': '1', 09:45:34 INFO - 'PAGER': '/bin/cat', 09:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:34 INFO - 'PWD': '/builds/slave/test', 09:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:34 INFO - 'SHELL': '/bin/bash', 09:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:34 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:34 INFO - 'USER': 'cltbld', 09:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:34 INFO - 'XPC_FLAGS': '0x0', 09:45:35 INFO - 'XPC_SERVICE_NAME': '0', 09:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:35 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')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:35 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 09:45:35 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 09:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:35 INFO - 'HOME': '/Users/cltbld', 09:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PAGER': '/bin/cat', 09:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test', 09:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:35 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - 'XPC_FLAGS': '0x0', 09:45:35 INFO - 'XPC_SERVICE_NAME': '0', 09:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:39 INFO - Downloading docopt-0.6.1.tar.gz 09:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:39 INFO - Running setup.py install for blobuploader 09:45:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:39 INFO - Running setup.py install for requests 09:45:40 INFO - Running setup.py install for docopt 09:45:40 INFO - Successfully installed blobuploader requests docopt 09:45:40 INFO - Cleaning up... 09:45:40 INFO - Return code: 0 09:45:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:40 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:40 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 09:45:40 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 09:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:40 INFO - 'HOME': '/Users/cltbld', 09:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:40 INFO - 'LOGNAME': 'cltbld', 09:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:40 INFO - 'MOZ_NO_REMOTE': '1', 09:45:40 INFO - 'NO_EM_RESTART': '1', 09:45:40 INFO - 'PAGER': '/bin/cat', 09:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:40 INFO - 'PWD': '/builds/slave/test', 09:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:40 INFO - 'SHELL': '/bin/bash', 09:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:40 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:40 INFO - 'USER': 'cltbld', 09:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:40 INFO - 'XPC_FLAGS': '0x0', 09:45:40 INFO - 'XPC_SERVICE_NAME': '0', 09:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-FCmWgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-UHqBlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qf554W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-wREv81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-BMRwBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-KWtrFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-1vt0AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Cpbtek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-3ZwfKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-zxqQBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-kz0k59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-TWKi4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:41 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-3oBtHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-s85L8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-uaSIXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Xxf_yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:42 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Jl9IB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:42 INFO - Running setup.py install for manifestparser 09:45:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:42 INFO - Running setup.py install for mozcrash 09:45:42 INFO - Running setup.py install for mozdebug 09:45:42 INFO - Running setup.py install for mozdevice 09:45:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Running setup.py install for mozfile 09:45:43 INFO - Running setup.py install for mozhttpd 09:45:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Running setup.py install for mozinfo 09:45:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Running setup.py install for mozInstall 09:45:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Running setup.py install for mozleak 09:45:43 INFO - Running setup.py install for mozlog 09:45:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Running setup.py install for moznetwork 09:45:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:44 INFO - Running setup.py install for mozprocess 09:45:44 INFO - Running setup.py install for mozprofile 09:45:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:44 INFO - Running setup.py install for mozrunner 09:45:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:44 INFO - Running setup.py install for mozscreenshot 09:45:44 INFO - Running setup.py install for moztest 09:45:44 INFO - Running setup.py install for mozversion 09:45:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:44 INFO - Cleaning up... 09:45:44 INFO - Return code: 0 09:45:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:44 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')]} 09:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:44 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')]} 09:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:44 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:44 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 09:45:44 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 09:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:44 INFO - 'HOME': '/Users/cltbld', 09:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:44 INFO - 'LOGNAME': 'cltbld', 09:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:44 INFO - 'MOZ_NO_REMOTE': '1', 09:45:44 INFO - 'NO_EM_RESTART': '1', 09:45:44 INFO - 'PAGER': '/bin/cat', 09:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:44 INFO - 'PWD': '/builds/slave/test', 09:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:44 INFO - 'SHELL': '/bin/bash', 09:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:44 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:44 INFO - 'USER': 'cltbld', 09:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:44 INFO - 'XPC_FLAGS': '0x0', 09:45:44 INFO - 'XPC_SERVICE_NAME': '0', 09:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-EatFEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:45 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)) 09:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-8cOWIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:45 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)) 09:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-R71ZXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:45 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)) 09:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-CZUmZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-eDVS8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:45 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)) 09:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qfd55z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:45 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)) 09:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-iT8Tb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WXTOHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-jrArVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-32Qxh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-bq_I7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-y9qL8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-U3DV79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-cW5Dx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-JXkE_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:46 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)) 09:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:46 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WOG1AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:47 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)) 09:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:47 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-LMqIHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:49 INFO - Downloading blessings-1.6.tar.gz 09:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:49 INFO - Installing collected packages: blessings 09:45:49 INFO - Running setup.py install for blessings 09:45:50 INFO - Successfully installed blessings 09:45:50 INFO - Cleaning up... 09:45:50 INFO - Return code: 0 09:45:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:50 INFO - Reading from file tmpfile_stdout 09:45:50 INFO - Current package versions: 09:45:50 INFO - blessings == 1.6 09:45:50 INFO - blobuploader == 1.2.4 09:45:50 INFO - docopt == 0.6.1 09:45:50 INFO - functools32 == 3.2.3-2 09:45:50 INFO - jsonschema == 2.5.1 09:45:50 INFO - manifestparser == 1.1 09:45:50 INFO - mozInstall == 1.12 09:45:50 INFO - mozcrash == 1.0 09:45:50 INFO - mozdebug == 0.1 09:45:50 INFO - mozdevice == 0.49 09:45:50 INFO - mozfile == 1.2 09:45:50 INFO - mozhttpd == 0.7 09:45:50 INFO - mozinfo == 0.9 09:45:50 INFO - mozleak == 0.1 09:45:50 INFO - mozlog == 3.4 09:45:50 INFO - moznetwork == 0.27 09:45:50 INFO - mozprocess == 0.25 09:45:50 INFO - mozprofile == 0.28 09:45:50 INFO - mozrunner == 6.13 09:45:50 INFO - mozscreenshot == 0.1 09:45:50 INFO - mozsystemmonitor == 0.3 09:45:50 INFO - moztest == 0.8 09:45:50 INFO - mozversion == 1.4 09:45:50 INFO - psutil == 3.1.1 09:45:50 INFO - requests == 1.2.3 09:45:50 INFO - wsgiref == 0.1.2 09:45:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:50 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:50 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 09:45:50 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 09:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:50 INFO - 'HOME': '/Users/cltbld', 09:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:50 INFO - 'LOGNAME': 'cltbld', 09:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:50 INFO - 'MOZ_NO_REMOTE': '1', 09:45:50 INFO - 'NO_EM_RESTART': '1', 09:45:50 INFO - 'PAGER': '/bin/cat', 09:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:50 INFO - 'PWD': '/builds/slave/test', 09:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:50 INFO - 'SHELL': '/bin/bash', 09:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:50 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:50 INFO - 'USER': 'cltbld', 09:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:50 INFO - 'XPC_FLAGS': '0x0', 09:45:50 INFO - 'XPC_SERVICE_NAME': '0', 09:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 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)) 09:45:50 INFO - Cleaning up... 09:45:50 INFO - Return code: 0 09:45:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:50 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 0x107075b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107078768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930256e0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, '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.kFmUePx8vf/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.HuNfLX1U87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 09:45:50 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 09:45:50 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 09:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:50 INFO - 'HOME': '/Users/cltbld', 09:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:50 INFO - 'LOGNAME': 'cltbld', 09:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:50 INFO - 'MOZ_NO_REMOTE': '1', 09:45:50 INFO - 'NO_EM_RESTART': '1', 09:45:50 INFO - 'PAGER': '/bin/cat', 09:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:50 INFO - 'PWD': '/builds/slave/test', 09:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:50 INFO - 'SHELL': '/bin/bash', 09:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:45:50 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:50 INFO - 'USER': 'cltbld', 09:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:50 INFO - 'XPC_FLAGS': '0x0', 09:45:50 INFO - 'XPC_SERVICE_NAME': '0', 09:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:50 INFO - Cleaning up... 09:45:51 INFO - Return code: 0 09:45:51 INFO - Running post-action listener: _resource_record_post_action 09:45:51 INFO - Running post-action listener: _start_resource_monitoring 09:45:51 INFO - Starting resource monitoring. 09:45:51 INFO - [mozharness: 2017-02-22 17:45:51.040117Z] Finished create-virtualenv step (success) 09:45:51 INFO - [mozharness: 2017-02-22 17:45:51.041067Z] Running install step. 09:45:51 INFO - Running pre-action listener: _resource_record_pre_action 09:45:51 INFO - Running main action method: install 09:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:51 INFO - Reading from file tmpfile_stdout 09:45:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:51 INFO - Reading from file tmpfile_stdout 09:45:51 INFO - Output received: 09:45:51 INFO - Usage: mozinstall [options] installer 09:45:51 INFO - Options: 09:45:51 INFO - -h, --help show this help message and exit 09:45:51 INFO - -d DEST, --destination=DEST 09:45:51 INFO - Directory to install application into. [default: 09:45:51 INFO - "/builds/slave/test"] 09:45:51 INFO - --app=APP Application being installed. [default: firefox] 09:45:51 INFO - mkdir: /builds/slave/test/build/application 09:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:46:11 INFO - Reading from file tmpfile_stdout 09:46:11 INFO - Output received: 09:46:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:46:11 INFO - Running post-action listener: _resource_record_post_action 09:46:11 INFO - [mozharness: 2017-02-22 17:46:11.504321Z] Finished install step (success) 09:46:11 INFO - [mozharness: 2017-02-22 17:46:11.504475Z] Running run-tests step. 09:46:11 INFO - Running pre-action listener: _resource_record_pre_action 09:46:11 INFO - Running main action method: run_tests 09:46:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:11 INFO - 2017-02-22 09:46:11.519 screenresolution[1627:7351] starting screenresolution argv=screenresolution get 09:46:11 INFO - 2017-02-22 09:46:11.522 screenresolution[1627:7351] Display 0: 1600x1200x32@60 09:46:11 INFO - 2017-02-22 09:46:11.527 screenresolution[1628:7353] starting screenresolution argv=screenresolution list 09:46:11 INFO - Available Modes on Display 0 09:46:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:11 INFO - Intel Iris: 09:46:11 INFO - Chipset Model: Intel Iris 09:46:11 INFO - Type: GPU 09:46:11 INFO - Bus: Built-In 09:46:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:46:11 INFO - Vendor: Intel (0x8086) 09:46:11 INFO - Device ID: 0x0a2e 09:46:11 INFO - Revision ID: 0x0009 09:46:11 INFO - Displays: 09:46:11 INFO - Display: 09:46:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:11 INFO - Display Serial Number: 1600x1200 60 09:46:11 INFO - Main Display: Yes 09:46:11 INFO - Mirror: Off 09:46:11 INFO - Online: Yes 09:46:11 INFO - Rotation: Supported 09:46:11 INFO - Return code: 0 09:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:11 INFO - Python 2.7.3 09:46:11 INFO - Return code: 0 09:46:11 INFO - grabbing minidump binary from tooltool 09:46:11 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')]} 09:46:11 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 0x106e53d30>, '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 0x106d7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e48be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:11 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 09:46:11 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 09:46:11 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 09:46:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:11 INFO - Return code: 0 09:46:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:46:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:11 INFO - ENV: RUST_BACKTRACE is now 1 09:46:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:46:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:11 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/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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 09:46:11 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/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0033 --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 09:46:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kFmUePx8vf/Render', 09:46:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:11 INFO - 'HOME': '/Users/cltbld', 09:46:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:11 INFO - 'LOGNAME': 'cltbld', 09:46:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:11 INFO - 'MOZ_NO_REMOTE': '1', 09:46:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:11 INFO - 'NO_EM_RESTART': '1', 09:46:11 INFO - 'PAGER': '/bin/cat', 09:46:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:11 INFO - 'PWD': '/builds/slave/test', 09:46:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:11 INFO - 'RUST_BACKTRACE': '1', 09:46:11 INFO - 'SHELL': '/bin/bash', 09:46:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HuNfLX1U87/Listeners', 09:46:11 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 09:46:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:11 INFO - 'USER': 'cltbld', 09:46:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:11 INFO - 'XPC_FLAGS': '0x0', 09:46:11 INFO - 'XPC_SERVICE_NAME': '0', 09:46:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:11 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/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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 09:46:12 INFO - mozversion application_buildid: 20170222080928 09:46:12 INFO - mozversion application_changeset: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e 09:46:12 INFO - mozversion application_display_name: Nightly 09:46:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:12 INFO - mozversion application_name: Firefox 09:46:12 INFO - mozversion application_remotingname: firefox 09:46:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:46:12 INFO - mozversion application_vendor: Mozilla 09:46:12 INFO - mozversion application_version: 54.0a1 09:46:12 INFO - mozversion platform_buildid: 20170222080928 09:46:12 INFO - mozversion platform_changeset: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e 09:46:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:46:12 INFO - mozversion platform_version: 54.0a1 09:46:12 INFO - using testdate: 1487785572 09:46:12 INFO - actual date: 1487785572 09:46:12 INFO - starting webserver on 'localhost:49240' 09:46:12 INFO - SUITE-START | Running 2 tests 09:46:12 INFO - TEST-START | dromaeo_css 09:46:12 INFO - operating with platform_type : mac_ 09:46:12 INFO - Initialising browser for dromaeo_css test... 09:46:12 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpVADa3X/profile http://localhost:49240/getInfo.html) 09:46:14 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 09:46:14 INFO - PROCESS | 1638 | colorDepth:24 09:46:14 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 09:46:14 INFO - PROCESS | 1638 | __metrics 09:46:14 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:46:14 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:15 INFO - TEST-INFO | 1638: exit 0 09:46:15 INFO - Browser initialized. 09:46:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:15 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpVADa3X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:27 INFO - PROCESS | 1640 | RSS: Main: 230764544 09:46:27 INFO - PROCESS | 1640 | 09:49:31 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 09:49:35 INFO - PROCESS | 1640 | RSS: Main: 556920832 09:49:35 INFO - PROCESS | 1640 | 09:51:17 INFO - PROCESS | 1640 | ************************* 09:51:17 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 09:51:17 INFO - PROCESS | 1640 | 09:51:17 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:17 INFO - PROCESS | 1640 | Full stack: 09:51:17 INFO - PROCESS | 1640 | ************************* 09:52:38 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 09:52:38 INFO - PROCESS | 1640 | RSS: Main: 369410048 09:52:38 INFO - PROCESS | 1640 | 09:55:41 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 09:55:41 INFO - PROCESS | 1640 | RSS: Main: 343191552 09:55:41 INFO - PROCESS | 1640 | 09:58:44 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 09:58:45 INFO - PROCESS | 1640 | RSS: Main: 342245376 09:58:45 INFO - PROCESS | 1640 | 10:01:48 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 10:01:49 INFO - PROCESS | 1640 | RSS: Main: 344850432 10:01:49 INFO - PROCESS | 1640 | 10:04:52 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 10:04:52 INFO - PROCESS | 1640 | RSS: Main: 523538432 10:04:52 INFO - PROCESS | 1640 | 10:04:52 INFO - PROCESS | 1640 | __start_tp_report 10:04:52 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 10:04:52 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 10:04:52 INFO - PROCESS | 1640 | |i|pagename|runs| 10:04:52 INFO - PROCESS | 1640 | |0;dojo.html;3248.6913743194395;3280.9343813123724;3300.323433696092;3331.666833316667;3354.731621470283;5458.399576046631;5540.473655002778;5581.6930068846195;5638.182463542789;5669.0646043402785;5545.667259964395;5612.522935550483;5643.322801263844;5668.093105103184;5674.290713660793;5046.596272298208;5073.264376665381;5134.1528647773075;5140.434552199274;5153.215149475158;5203.947960520403;5250.816221432251;5252.947470525303;5264.236685680574;5265.65773224741;4960.280759289919;5000.3249561309485;5033.144365457844;5084.694918304914;5124.103281925667;5058.140116180258;5072.467390923936;5081.59347252219;5082.898342033176;5089.465606111379;4985.451600323961;5009.474005229471;5033.446320904697;5040.193569028975;5041.319421878036;5475.014497390468;5491.478309560585;5503.6147469677135;5509.834704958857;5514.200440936042;6016.007358785795;6021;6021.819345419601;6027.306859711145;6028.969855150696;6124.173236613089;6130.356312587159;6140.210635704113;6151.9234134026365;6178.505719542426;5622.690752008597;5660.207570940031;5677.687727175045;5685.090385538336;5688.402717714663;6283.8114856554375;6286.717097730613;6293.779717709858;6308.116863639094;6308.495320374359;5807.709614519257;5879.500242479352;5881.882362352729;6086.421789929949;6097.786577469856;6109.75560977556;6133.172021777003;6134.754609815557;6141.048137538689;6143.385661433821;6025.638461692312;6026.54800889935;6038.486728628028;6042.939570604326;6050.6672133032225;5900.616459930091;5991.340952495222;6045;6045.304789949212;6055.788047418319;4334.934975975363;4343.500497442771;4730.195866702668;4847.491013443609;4873.366462359871;4203.810828512725;4325.351197320364;4325.740455572675;4333.414988976511;4335.479742430928;5497.312835895513;5594.1888426177975;5705.4579814917515;5707.486326230659;5736.627119237236;6260.906086408708;6265.843353916098;6267.341929097471;6273.498120150377;6285.811425657146;5448.863778405572;5477.260569823103;5700.686462244534;5705.600607957404;5710;5298.417174110845;5301.655392399482;5303.602229832778;5304.840854774363;5305.230741542455;6211.440970312694;6215.875682486416;6227.532935029982;6231.40801623845;6249.718762655601;5074.695518268915;6094.75620975156;6156.353582873734;6204.5967012144065;6222.315545289924;6225.31521532622;6234.096056071753;6247.781327653511;6251.9687401562705;6255.843603909757;5761;6129.632222066691;6136.6011209271255;6156.907646385397;6167.814965551041;5903.734331955158;5985.700714964321;5986.970065149646;5997.100434934795;6004.159417681615;5580.2745643067765;5728.484436400744;5754.280714910637;5763.711814409179;5764.740586673526;5750.597458177887;5755.3093628763145;5756.30924289088;5763.740631671669;5764.510016648632;5653.575981801464;5671.291088613923;5675.205471234113;5679.801206957736;5681.971590142023;5739.167820666064;5895.528357731286;5904.675242861684;5946;5956.672383018976;4262.893427664333;5745.396733343106;5788.218590490398;5800.042992906123;5805.187273781758 10:04:53 INFO - PROCESS | 1640 | |1;ext.html;457.32772823948784;460.813370584913;468.5478513234729;475.2562240094251;541.9783208671653;24758;38205.04487387816;38280.808595957016;38351.80824095876;38362.80818595907;38785;39343.80328098363;39399.80300098495;39481;39491;9079.364444488872;9316.58075386606;9333.719988400358;9345;9359.812803743922;9206.355555111146;9304.72085837426;9322.533873306342;9327.440353578773;9329;9308.34841561091;9335.95332023339;9344.392614480072;9359.859602105973;9361.20429763471;9244.630214791401;9342.832145981753;9346.626134954593;9348.345615806897;9356.95321523388;9172.403793753452;9263.444193348354;9267.351285410025;9268.21220196284;9286.396384235071;36807.63192368069;37153.44269835955;37174;37184.44223336652;37184.81407592972;3411.9488207676904;3737.103095257146;3760.849566017356;3773.2453509298252;3801.885943421702;26151.476970460484;26730.331741706417;26736.59895101575;29170.562441563394;29465.705342946512;3113.2683819302447;3113.377324535102;3135.1691801672573;3206;3229.3864165808423;426672;430000.849995748;430191;430738;433330;51486.74256628693;51520.711982199995;51678;51980.740096299276;52064.21903671448;54146.72926635342;54256;54285.45714542804;54343;54516.18225726617;13976.650583735285;14058.297085145907;14347.354369053417;14364.712705745827;14632.048916820373;10994.890051099386;11120.721981950515;11209.047230985294;11211.66365009051;11222.775544489064;13034.674133146558;16358.754618680729;16413.917930410273;16458.588535286715;16483;7593.076665483829;7615.4669173157345;7718.151003389623;7748.845023099507;7755.30202281786;772.5017363800317;819.6065888373614;863.0721973878107;864.5936409887343;870.9129087091367;28239.43521129566;28367;29028.983985560826;29067;29079.85460072686;1014.2697257974247;1015.4668798880647;1048.9318194317345;1052.1162223732101;1187.9961432589448;14095.929520352538;14428.206448645426;14499.420023198954;14873;14940.850591494163;598142;603403;603598.7480876384;603824;605056;45511.089778204914;54402.45597544053;54875.72562137164;54884.35346939598;54925;1330.6141219046367;1372.9107608005447;1396.0227840511682;1398.3357904995046;1398.6783039901084;23766;26994;29701.702982969895;29969.100926972227;30616.387672245986;49851.002979940924;50531.74734126306;50598;50638.7340316495;50713;512223;514913;518141;518203;518568;24027.51944961056;24686.876565617058;24744.752552474965;25118.623220651338;25161.622575661015;38720.80639596784;38810;38974;39186.216275674895;40373.798131009156;32538.34923301568;32741;33140.83429582837;34351.62593496332;34376.14059648529;26554;32638.83680581582;33529.32941341208;33781.81763638359;33803.4929476063;32739.836300818344;33206.66793332036;33278.66721332756;33381.33237335288;33388.666113339525;26211.868940655175;27158.555729984397;29433;29467.85266073656;29515.40969180647;22037.669434958167;22249.332520024425;22413.887930560242;22475.550488990455;22621 10:04:53 INFO - PROCESS | 1640 | |2;jquery.html;362.25014220563446;389.9220155968805;393.8090026337227;402.24779662031995;422.41284614386007;13932.831276086921;16572.585685357855;20258.39224823254;20933.685994710053;21357.359279221648;20409;21544.56910861782;21690.566188676217;21978.560428791414;22030.228941987032;5560.110382338827;5914.438128377818;5921.822345329647;5923.837799203281;5931.673757943311;4180.5610410906875;5790.189373487715;5844.678542680151;5861.7948371807;5875.471207591316;5572;5823.883522329551;5824.893270278655;5835.883282334351;5839.182514447981;5744.080947048473;5782;5809.099589563624;5826.300843898759;5832.125181222808;4921.335619691332;5065.265536497224;5092.770825312869;5142.691438513663;5142.794288228466;21095.156193752384;25725.742742572522;26006.73993260062;26085.217443476726;26161.607575886377;2579.3809485723477;2582.264054744389;2585.0952166741677;2592.0798116668498;2614.2810727050214;12681.23912565249;14784.334704938303;14793.852061479354;14859.554213373616;14937.775933361008;1782.9821701783076;1800.0819582013137;1824.2794096331875;1847.9907600462045;1877.3906546125722;106249.46875265651;117085;121999.78000219972;125169.37415312865;125212;10160.441175735405;10927.453627318602;11530.135239857043;11584.073274138049;11692.824607630891;13095.738085238241;13440.193588384729;13448.865511344957;13451.394687239097;13486.730265394637;6993.6503174841055;7664.961675191588;7680.886271490603;7689.653965571562;8504.744857654281;7073.681684324218;7621.780515117554;7673.386129109658;8345.332373410112;8439.493630382196;6888.931110688929;7037.331453512011;7059.2234854166;7071.434285257167;7073.151221853308;1640.8769342299136;1866.3374502051847;1949.2495389274948;1961.9411417657493;1962.7840937496865;929.5538141692026;1032.4992378696327;1052.5684469367675;1055.2244100586063;1056.3450660590483;20016.49958751043;21812.563748724937;22124.22565210242;22596.548069038527;22702.545949080926;1022.6369638778127;1071.7320669832543;1072.769354588767;1110.7056629993058;1111.111111111108;10902.945485272523;11549.6535103947;11672.182947193785;11833.230839995373;11924.284542927453;569712;665975;684763.1331613578;694371;696484;119463;121898.78101218875;122154;123069;125641;979.637534112383;997.3018886779283;1027.0705011964185;1028.5525796278644;1028.6142696488816;19337.323193688153;19402.8059719401;19405.611887762447;19462.513437164183;19541.413757587296;48293.275600865316;48305;49204.26193607171;49528;51115;72996;78828.60585697035;80704.59647701724;81932.59033705032;82303;6870.31296870309;7337.499001836646;8317.085120636846;8606.053334133365;8902.510361930155;9368.484733339732;12496.625101246977;13198.20810751358;13583.456661733815;13613.727725445633;10947.83578246343;10955.397453139834;11223.775524489301;11385;11439.885601143882;10749.946250268698;10772.899284639734;10904.890951090387;11161.832572511581;11211.439428028729;11179.161562882653;11271.380074096003;11427.257228280136;11856.110791690486;11858.40707964581;7110.5022648414115;7605.733799316998;7627.275408836374;8598.957005214934;8841.911580884365;8414.116517765546;10631.149508039183;11404.94297528507;11703.941480292544;11805.701372849151 10:04:53 INFO - PROCESS | 1640 | |3;mootools.html;1279.353926267235;1354.884834789043;1481.7925490431335;1492.142018339455;1495.9476418325357;8140.557832650204;8445;8567.314614830813;8570.957145214265;8572.614232359543;7033.472489563291;8304.21109994551;8397.202265784741;8510.361722870779;8517.914820851789;2250.6849041134215;2285.31440567829;2288.702468679069;2293.747687754346;2299.72403311602;1935.5741736817877;2266.05958527211;2310.722713274401;2323.256557901472;2326.081197926818;1993.252530301137;2019.1317733374642;2021;2023.079498828037;2024.9696254556193;1995.8802471851664;2173.869567825928;2271.488914994113;2273.9317820465412;2281.9657705134437;2228.810551103158;2256.5486902619377;2292.289390289016;2300.9654855177187;2306.400335912658;8393.916060839374;8474.279686226679;8479.152084791533;8486.490810551386;8489.108643592457;5082.186850104003;5245.501677340647;5245.711485868275;5262.315898933114;5264.8683782905355;3496.063306822256;3511.5610548681416;3519.1729943463265;3551.0057183988524;3600.5499312585926;1194.2893978083027;1208.8851559101872;1237.5111830826863;1242.1553343726262;1251.124213050868;8864.645414183426;10901.890981090168;10909.509072091774;10917.508712107974;10954.452277386179;4333.739975601474;4652.371929789503;4711.623070154379;4746.43042834862;4748.881277968078;9620.90379096214;9628.133467987915;9630.374025688308;9640.951795240979;9654.75863103428;5259.105951988171;5265.815696450606;5267.420583735786;5270.92093618596;5281.102212623863;3742.8502859885843;4614.3309220163555;4632.305154226826;4804.543568361;4809.78355973982;3774.8678796241998;3813.256414999104;3853.2678791029616;3867.43922131295;3932.2528719543197;1268.346801397281;1285.2352850054203;1285.8205341945313;1309.6791286134958;1310.5675127207999;841.6128580852754;864.8789169516273;873.9431936924079;914.3142643017736;920.8296465153968;5387.353517577837;5537.833864984057;5568.276124103841;5846.210761547137;5933.1396947443245;971.6259240192577;978.3885071830106;984.3847595252967;986.1420564109271;1033.0857191385678;3454.136465883529;3608.1340478285024;3797.4430483502183;3800.657940785343;3815.923681526354;9640.71077867665;9922;9924.206063514901;9928.851067233998;9956.303058785961;9315.20820730232;9779.902200978042;9791.755206119762;9920.107190352903;9946.154576860903;7613.162552119263;7810.648520816463;7821.491603045783;7834.216578342121;7844.294013538694;5414.891702166014;5522.66863988162;5534.7786088556;5631.324241091095;5876.853078673067;9053.68312109073;9316.813663726824;9329.300302477206;9342.112499312554;9354.672586459441;8834.514101724468;9220.216281616138;9229.35394522377;9333.066693330613;9438.811223775623;7013.421980054447;7181.317774811385;7183.389411899838;7184.856302874018;7186.029885965328;7665.88501172494;7777.02787151606;7837.020372453443;7839.33365663925;7845.097813751491;6673.099131617169;6987.196472405739;7085.2560481150795;7171;7285.7449989252245;6877;6958.617276049866;6987.825304367431;7016.1580610325045;7023.824404389931;5785.884282314414;6265.96867015662;6375.585586936834;6398.776042838478;6403.6157830528455;4502.4371953505815;4671.972166123447;4755.5006724294835;4758.547937945889;4884.413870335582;4669.41632295963;4701.506341834195;4804.447488538863;4880.389951256093;5014.0974624567925 10:04:53 INFO - PROCESS | 1640 | |4;prototype.html;290.783366392038;350.2067816395862;355.08565443981746;365.0690738616528;371.9330520506308;4780.354652121962;4819.927701084483;4824.493428190038;4947.604191664667;4969.0807200667905;4633.884152896179;4897.436794768594;4931.284963680264;4951.727654978975;4965.3296804931415;3412.133807601614;3582.408902531086;3794.2221844521946;3819.541655001404;3834.539855217378;3577.9642203578023;3697.7829288519024;3722.003786951503;3810.428435734634;3810.4284357346482;3602.7297952653525;3673.94489082664;3696.207339440369;3704.5369328833895;3785.0537365658583;3402.506636537713;3613.403788374915;3761.943570846453;3930.7248492605245;3939.665128464084;3279.3277378137664;3510.403231450634;3519.982400088009;3522.4716292556063;3525.612182659931;3944.6055394460614;4511.255642818964;4805.255185446226;4926.433460152092;4934.284528743312;4187.727797693171;4261.190373828994;4516.88707782308;4530.229860923618;4546.340585686201;4970.2793095001025;5117.590592752608;5313.9734301328635;5324.334458192726;5336.4129945705945;3762.1535154590274;3846.423036544513;3867.091233560111;3918.6277303656107;3973.642372186488;5371;5453.64551304164;5497.8075767347955;5548.4174161713245;5554.944450555524;3382.9492557611657;3396.337714145767;3539.50446937429;3977.7016723745833;4015.859444919414;3735.290294844025;4027;4036.495438070241;4072.837086516506;4090.8568200112854;3788.6590206881515;4160.604742549453;4223.68322375823;4555.954440455553;4617.884552886205;4915.582175515121;4939.580135688507;5078.898422031539;5353.866153346197;5404.864878378072;1263.368315842079;1300.343326620051;1308.1562392256942;1309.718410541719;1319.769040417923;809.7570229697386;811.5455345006815;866.1079088538816;869.1829680100685;885.7387070814125;3884.825182866721;4574.438314543866;4599.678022538457;4665.410697063163;4665.4634717007975;4418.513963464016;4785;4785.449673287617;4809.965857340619;5083.669561478492;3961.6230261842666;4378.5183629800695;4562.703424277412;4606.479861645649;4623.398958135421;2288.3592594073684;2530.860802655872;2676.1168814291236;2689.9058532951644;2726.495598314318;4583.6310311920715;4653.371794807726;4702.647301452336;4989.301497790239;5375.1511698799695;4453.904536347208;4812.470628230892;4823.906935426746;4843.24929635907;5025.070361983045;5338.626296159232;5368.355797304271;5379.8655033625255;5385.461453854583;5430;4408.58118478744;4518.069279726527;4935.210366341368;5107.38711354625;5116.846494605168;4609.562091601292;4621.052684199663;4699.17764391237;5042.672226305279;5147.613928955268;5525.696086715269;5525.917111243415;5552.47251511122;5553.16702494629;5579.8884022320135;3632.7285450092254;3649.7627654202392;3824.2160357126168;3884.4755957946445;3964.266610677034;4475.776211189493;5027.346444962278;5028.472010438997;5344.946550534445;5382.542483888913;5214.618126196485;5224.399194092576;5237.921431178459;5242.842714718565;5261.263782951693;4844.709317440965;5217.139172036572;5228.294180285613;5234.371875374827;5241.528262456397;4442.6890117691455;4483.260262056724;4949.109160351171;5107.974460127824;5133.358330208724;5250.789968401221;5251.343582052244;5299.205119232146;5301.655392399482;5303.968983572589;4200.718780771772;4342.956570434255;4858.46556878736;5123.205903085028;5167.3570133055355 10:04:53 INFO - PROCESS | 1640 | |5;yui.html;727.4653129949489;745.7464462082894;780.4497829030535;786.2334224131471;792.1009654042662;14755.852441475581;15072.39710411585;15371.231438428076;15572.221388930537;15623.609409764762;14184.36170372333;14310.21293828839;14325.641858953531;14349.995500314983;14378.712425751504;902.5261737587754;905.7509184974152;916.5234078279291;920.8020275640736;922.0134456131941;911.7994041310901;914.0950459045564;915.007217169372;915.3958387464274;915.9816803663923;914.2548822709504;945.5792172483248;960.5341409416427;963.5423173992367;966.8984756600561;949.1599934058339;949.791045969889;950.6672664567416;951.224751827262;951.4529145741158;702.8910518869584;703.9507234493587;704.5842952657956;704.7956092733101;705.2348202200618;15114.39542418302;15361;15519.844801552066;15557;15616.063036217749;13817.502236124812;14019.509317173952;14215.857841421557;14262.215578143197;14325.928370358186;9423.670171543963;11507.424628768611;11591.420428978518;11745.29528228309;11993.880061199363;3625.2205775758075;3641.362761516724;3660.7071434285194;3667.2665466906724;3798.8480460781534;93419.53290233573;101405;103709;103883.96116038818;104118;10501.212409069198;10525.842112368167;10535.315204511682;10561.471926403803;10887.83668244977;18360.357387491375;21845.563088738138;22154.335369938926;22322.55354892893;22427.99074041672;7389.3349598535315;7457.776266712007;7489.700411983568;7568.735094271674;7707.190744971809;4130.277201489787;4192.056787222911;4218.894527636834;4234.407182994383;4238.343056826136;3573.6247693991754;3674.1365779041903;3674.6876515495946;3683.4106542953;3687.446882967576;654.175738569406;658.4765111736182;665.7603262825379;687.1925487552106;690.7409721354492;641.3874749614107;666.6400143922325;670.5339788846802;691.1878542712293;699.9160100787938;9365;9642.468040021178;9972.202223822076;10011.24915631316;10156.441395723159;628.7547856336032;652.3997921911757;686.6223577032612;690.7513295213719;691.4192078653955;4294.420253265832;4829.879253018703;4833.4199896012;4838.346823178897;4862.78117484714;99141;104188;104819.95180048102;105073;106278.46860765647;48943.75528122336;82693.21147519736;89901.55049224712;90036;94666;66775;68403.97394039093;68510.65744671345;69066;70060;9665.985071567384;9760.951195243979;10473.738156546147;10550.683479495627;10643.680689579325;48055.79860503376;48315.75842120767;48991.51008489869;49081.50918490769;50783.492165079355;64305.356946429936;65849.67075164593;66432.66783666244;67209.65580688261;67715.66142169455;11987.64037078889;12261.14172007951;12287.324197169242;12541.310227937187;13171.670708231988;13709.821517202978;13947.442102315794;14005.18083092582;14044.719105618035;14046.438142474186;12581.559645412366;12713.87286127127;12718.872811272138;12779.552715654907;13213.735725285633;12900.870991290343;13103.475860965455;13118.344082796013;13271.810151324924;13548.390322435711;12672.429740661877;12746.745065098832;12764.808527872276;12935.417906194056;13020.934895325463;10605.098566621924;10849.891501084889;10957.342559446459;11368.715782105182;11415.942920285677;8558.880400513663;9096.363254572116;9600.279979001463;10527.526261318106;10569.682909512727 10:04:53 INFO - PROCESS | 1640 | __end_tp_report 10:04:53 INFO - PROCESS | 1640 | __start_cc_report 10:04:53 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,3755 10:04:53 INFO - PROCESS | 1640 | __end_cc_report 10:04:53 INFO - PROCESS | 1640 | __startTimestamp1487786692995__endTimestamp 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - PROCESS | 1640 | ------- Summary: start ------- 10:04:53 INFO - PROCESS | 1640 | Number of tests: 6 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5591.17 Median:5728.48 stddev:644.32 (11.2%) stddev-sans-first:619.54 10:04:53 INFO - PROCESS | 1640 | Values: 3248.7 3280.9 3300.3 3331.7 3354.7 5458.4 5540.5 5581.7 5638.2 5669.1 5545.7 5612.5 5643.3 5668.1 5674.3 5046.6 5073.3 5134.2 5140.4 5153.2 5203.9 5250.8 5252.9 5264.2 5265.7 4960.3 5000.3 5033.1 5084.7 5124.1 5058.1 5072.5 5081.6 5082.9 5089.5 4985.5 5009.5 5033.4 5040.2 5041.3 5475.0 5491.5 5503.6 5509.8 5514.2 6016.0 6021.0 6021.8 6027.3 6029.0 6124.2 6130.4 6140.2 6151.9 6178.5 5622.7 5660.2 5677.7 5685.1 5688.4 6283.8 6286.7 6293.8 6308.1 6308.5 5807.7 5879.5 5881.9 6086.4 6097.8 6109.8 6133.2 6134.8 6141.0 6143.4 6025.6 6026.5 6038.5 6042.9 6050.7 5900.6 5991.3 6045.0 6045.3 6055.8 4334.9 4343.5 4730.2 4847.5 4873.4 4203.8 4325.4 4325.7 4333.4 4335.5 5497.3 5594.2 5705.5 5707.5 5736.6 6260.9 6265.8 6267.3 6273.5 6285.8 5448.9 5477.3 5700.7 5705.6 5710.0 5298.4 5301.7 5303.6 5304.8 5305.2 6211.4 6215.9 6227.5 6231.4 6249.7 5074.7 6094.8 6156.4 6204.6 6222.3 6225.3 6234.1 6247.8 6252.0 6255.8 5761.0 6129.6 6136.6 6156.9 6167.8 5903.7 5985.7 5987.0 5997.1 6004.2 5580.3 5728.5 5754.3 5763.7 5764.7 5750.6 5755.3 5756.3 5763.7 5764.5 5653.6 5671.3 5675.2 5679.8 5682.0 5739.2 5895.5 5904.7 5946.0 5956.7 4262.9 5745.4 5788.2 5800.0 5805.2 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:63593.77 Median:21003.47 stddev:139348.36 (663.5%) stddev-sans-first:139658.64 10:04:53 INFO - PROCESS | 1640 | Values: 457.3 460.8 468.5 475.3 542.0 24758.0 38205.0 38280.8 38351.8 38362.8 38785.0 39343.8 39399.8 39481.0 39491.0 9079.4 9316.6 9333.7 9345.0 9359.8 9206.4 9304.7 9322.5 9327.4 9329.0 9308.3 9336.0 9344.4 9359.9 9361.2 9244.6 9342.8 9346.6 9348.3 9357.0 9172.4 9263.4 9267.4 9268.2 9286.4 36807.6 37153.4 37174.0 37184.4 37184.8 3411.9 3737.1 3760.8 3773.2 3801.9 26151.5 26730.3 26736.6 29170.6 29465.7 3113.3 3113.4 3135.2 3206.0 3229.4 426672.0 430000.8 430191.0 430738.0 433330.0 51486.7 51520.7 51678.0 51980.7 52064.2 54146.7 54256.0 54285.5 54343.0 54516.2 13976.7 14058.3 14347.4 14364.7 14632.0 10994.9 11120.7 11209.0 11211.7 11222.8 13034.7 16358.8 16413.9 16458.6 16483.0 7593.1 7615.5 7718.2 7748.8 7755.3 772.5 819.6 863.1 864.6 870.9 28239.4 28367.0 29029.0 29067.0 29079.9 1014.3 1015.5 1048.9 1052.1 1188.0 14095.9 14428.2 14499.4 14873.0 14940.9 598142.0 603403.0 603598.7 603824.0 605056.0 45511.1 54402.5 54875.7 54884.4 54925.0 1330.6 1372.9 1396.0 1398.3 1398.7 23766.0 26994.0 29701.7 29969.1 30616.4 49851.0 50531.7 50598.0 50638.7 50713.0 512223.0 514913.0 518141.0 518203.0 518568.0 24027.5 24686.9 24744.8 25118.6 25161.6 38720.8 38810.0 38974.0 39186.2 40373.8 32538.3 32741.0 33140.8 34351.6 34376.1 26554.0 32638.8 33529.3 33781.8 33803.5 32739.8 33206.7 33278.7 33381.3 33388.7 26211.9 27158.6 29433.0 29467.9 29515.4 22037.7 22249.3 22413.9 22475.6 22621.0 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:36742.62 Median:21895.56 stddev:110142.94 (503.0%) stddev-sans-first:110418.04 10:04:53 INFO - PROCESS | 1640 | Values: 362.3 389.9 393.8 402.2 422.4 13932.8 16572.6 20258.4 20933.7 21357.4 20409.0 21544.6 21690.6 21978.6 22030.2 5560.1 5914.4 5921.8 5923.8 5931.7 4180.6 5790.2 5844.7 5861.8 5875.5 5572.0 5823.9 5824.9 5835.9 5839.2 5744.1 5782.0 5809.1 5826.3 5832.1 4921.3 5065.3 5092.8 5142.7 5142.8 21095.2 25725.7 26006.7 26085.2 26161.6 2579.4 2582.3 2585.1 2592.1 2614.3 12681.2 14784.3 14793.9 14859.6 14937.8 1783.0 1800.1 1824.3 1848.0 1877.4 106249.5 117085.0 121999.8 125169.4 125212.0 10160.4 10927.5 11530.1 11584.1 11692.8 13095.7 13440.2 13448.9 13451.4 13486.7 6993.7 7665.0 7680.9 7689.7 8504.7 7073.7 7621.8 7673.4 8345.3 8439.5 6888.9 7037.3 7059.2 7071.4 7073.2 1640.9 1866.3 1949.2 1961.9 1962.8 929.6 1032.5 1052.6 1055.2 1056.3 20016.5 21812.6 22124.2 22596.5 22702.5 1022.6 1071.7 1072.8 1110.7 1111.1 10902.9 11549.7 11672.2 11833.2 11924.3 569712.0 665975.0 684763.1 694371.0 696484.0 119463.0 121898.8 122154.0 123069.0 125641.0 979.6 997.3 1027.1 1028.6 1028.6 19337.3 19402.8 19405.6 19462.5 19541.4 48293.3 48305.0 49204.3 49528.0 51115.0 72996.0 78828.6 80704.6 81932.6 82303.0 6870.3 7337.5 8317.1 8606.1 8902.5 9368.5 12496.6 13198.2 13583.5 13613.7 10947.8 10955.4 11223.8 11385.0 11439.9 10749.9 10772.9 10904.9 11161.8 11211.4 11179.2 11271.4 11427.3 11856.1 11858.4 7110.5 7605.7 7627.3 8599.0 8841.9 8414.1 10631.1 11404.9 11703.9 11805.7 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5407.00 Median:5401.12 stddev:2957.50 (54.8%) stddev-sans-first:2949.53 10:04:53 INFO - PROCESS | 1640 | Values: 1279.4 1354.9 1481.8 1492.1 1495.9 8140.6 8445.0 8567.3 8571.0 8572.6 7033.5 8304.2 8397.2 8510.4 8517.9 2250.7 2285.3 2288.7 2293.7 2299.7 1935.6 2266.1 2310.7 2323.3 2326.1 1993.3 2019.1 2021.0 2023.1 2025.0 1995.9 2173.9 2271.5 2273.9 2282.0 2228.8 2256.5 2292.3 2301.0 2306.4 8393.9 8474.3 8479.2 8486.5 8489.1 5082.2 5245.5 5245.7 5262.3 5264.9 3496.1 3511.6 3519.2 3551.0 3600.5 1194.3 1208.9 1237.5 1242.2 1251.1 8864.6 10901.9 10909.5 10917.5 10954.5 4333.7 4652.4 4711.6 4746.4 4748.9 9620.9 9628.1 9630.4 9641.0 9654.8 5259.1 5265.8 5267.4 5270.9 5281.1 3742.9 4614.3 4632.3 4804.5 4809.8 3774.9 3813.3 3853.3 3867.4 3932.3 1268.3 1285.2 1285.8 1309.7 1310.6 841.6 864.9 873.9 914.3 920.8 5387.4 5537.8 5568.3 5846.2 5933.1 971.6 978.4 984.4 986.1 1033.1 3454.1 3608.1 3797.4 3800.7 3815.9 9640.7 9922.0 9924.2 9928.9 9956.3 9315.2 9779.9 9791.8 9920.1 9946.2 7613.2 7810.6 7821.5 7834.2 7844.3 5414.9 5522.7 5534.8 5631.3 5876.9 9053.7 9316.8 9329.3 9342.1 9354.7 8834.5 9220.2 9229.4 9333.1 9438.8 7013.4 7181.3 7183.4 7184.9 7186.0 7665.9 7777.0 7837.0 7839.3 7845.1 6673.1 6987.2 7085.3 7171.0 7285.7 6877.0 6958.6 6987.8 7016.2 7023.8 5785.9 6266.0 6375.6 6398.8 6403.6 4502.4 4672.0 4755.5 4758.5 4884.4 4669.4 4701.5 4804.4 4880.4 5014.1 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4215.92 Median:4622.23 stddev:1240.43 (26.8%) stddev-sans-first:1208.41 10:04:53 INFO - PROCESS | 1640 | Values: 290.8 350.2 355.1 365.1 371.9 4780.4 4819.9 4824.5 4947.6 4969.1 4633.9 4897.4 4931.3 4951.7 4965.3 3412.1 3582.4 3794.2 3819.5 3834.5 3578.0 3697.8 3722.0 3810.4 3810.4 3602.7 3673.9 3696.2 3704.5 3785.1 3402.5 3613.4 3761.9 3930.7 3939.7 3279.3 3510.4 3520.0 3522.5 3525.6 3944.6 4511.3 4805.3 4926.4 4934.3 4187.7 4261.2 4516.9 4530.2 4546.3 4970.3 5117.6 5314.0 5324.3 5336.4 3762.2 3846.4 3867.1 3918.6 3973.6 5371.0 5453.6 5497.8 5548.4 5554.9 3382.9 3396.3 3539.5 3977.7 4015.9 3735.3 4027.0 4036.5 4072.8 4090.9 3788.7 4160.6 4223.7 4556.0 4617.9 4915.6 4939.6 5078.9 5353.9 5404.9 1263.4 1300.3 1308.2 1309.7 1319.8 809.8 811.5 866.1 869.2 885.7 3884.8 4574.4 4599.7 4665.4 4665.5 4418.5 4785.0 4785.4 4810.0 5083.7 3961.6 4378.5 4562.7 4606.5 4623.4 2288.4 2530.9 2676.1 2689.9 2726.5 4583.6 4653.4 4702.6 4989.3 5375.2 4453.9 4812.5 4823.9 4843.2 5025.1 5338.6 5368.4 5379.9 5385.5 5430.0 4408.6 4518.1 4935.2 5107.4 5116.8 4609.6 4621.1 4699.2 5042.7 5147.6 5525.7 5525.9 5552.5 5553.2 5579.9 3632.7 3649.8 3824.2 3884.5 3964.3 4475.8 5027.3 5028.5 5344.9 5382.5 5214.6 5224.4 5237.9 5242.8 5261.3 4844.7 5217.1 5228.3 5234.4 5241.5 4442.7 4483.3 4949.1 5108.0 5133.4 5250.8 5251.3 5299.2 5301.7 5304.0 4200.7 4343.0 4858.5 5123.2 5167.4 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19716.12 Median:4205.48 stddev:28188.41 (670.3%) stddev-sans-first:28231.43 10:04:53 INFO - PROCESS | 1640 | Values: 727.5 745.7 780.4 786.2 792.1 14755.9 15072.4 15371.2 15572.2 15623.6 14184.4 14310.2 14325.6 14350.0 14378.7 902.5 905.8 916.5 920.8 922.0 911.8 914.1 915.0 915.4 916.0 914.3 945.6 960.5 963.5 966.9 949.2 949.8 950.7 951.2 951.5 702.9 704.0 704.6 704.8 705.2 15114.4 15361.0 15519.8 15557.0 15616.1 13817.5 14019.5 14215.9 14262.2 14325.9 9423.7 11507.4 11591.4 11745.3 11993.9 3625.2 3641.4 3660.7 3667.3 3798.8 93419.5 101405.0 103709.0 103884.0 104118.0 10501.2 10525.8 10535.3 10561.5 10887.8 18360.4 21845.6 22154.3 22322.6 22428.0 7389.3 7457.8 7489.7 7568.7 7707.2 4130.3 4192.1 4218.9 4234.4 4238.3 3573.6 3674.1 3674.7 3683.4 3687.4 654.2 658.5 665.8 687.2 690.7 641.4 666.6 670.5 691.2 699.9 9365.0 9642.5 9972.2 10011.2 10156.4 628.8 652.4 686.6 690.8 691.4 4294.4 4829.9 4833.4 4838.3 4862.8 99141.0 104188.0 104820.0 105073.0 106278.5 48943.8 82693.2 89901.6 90036.0 94666.0 66775.0 68404.0 68510.7 69066.0 70060.0 9666.0 9761.0 10473.7 10550.7 10643.7 48055.8 48315.8 48991.5 49081.5 50783.5 64305.4 65849.7 66432.7 67209.7 67715.7 11987.6 12261.1 12287.3 12541.3 13171.7 13709.8 13947.4 14005.2 14044.7 14046.4 12581.6 12713.9 12718.9 12779.6 13213.7 12900.9 13103.5 13118.3 13271.8 13548.4 12672.4 12746.7 12764.8 12935.4 13020.9 10605.1 10849.9 10957.3 11368.7 11415.9 8558.9 9096.4 9600.3 10527.5 10569.7 10:04:53 INFO - PROCESS | 1640 | -------- Summary: end -------- 10:04:53 INFO - PROCESS | 1640 | 10:04:53 INFO - TEST-INFO | 1640: exit 0 10:04:53 INFO - TEST-OK | dromaeo_css | took 1121619ms 10:04:53 INFO - TEST-START | kraken 10:04:53 INFO - operating with platform_type : mac_ 10:04:53 INFO - Initialising browser for kraken test... 10:04:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpUagHJ_/profile http://localhost:49240/getInfo.html) 10:04:56 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 10:04:56 INFO - PROCESS | 1650 | colorDepth:24 10:04:56 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 10:04:56 INFO - PROCESS | 1650 | __metrics 10:04:56 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:04:56 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:57 INFO - TEST-INFO | 1650: exit 0 10:04:57 INFO - Browser initialized. 10:04:57 INFO - Running cycle 1/1 for kraken test... 10:04:57 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpUagHJ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:09 INFO - PROCESS | 1651 | RSS: Main: 231211008 10:05:09 INFO - PROCESS | 1651 | 10:05:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:12 INFO - PROCESS | 1651 | RSS: Main: 283467776 10:05:12 INFO - PROCESS | 1651 | 10:05:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 10:05:16 INFO - PROCESS | 1651 | RSS: Main: 285515776 10:05:16 INFO - PROCESS | 1651 | 10:05:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 10:05:20 INFO - PROCESS | 1651 | RSS: Main: 377868288 10:05:20 INFO - PROCESS | 1651 | 10:05:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 10:05:22 INFO - PROCESS | 1651 | RSS: Main: 280772608 10:05:22 INFO - PROCESS | 1651 | 10:05:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:25 INFO - PROCESS | 1651 | RSS: Main: 282296320 10:05:25 INFO - PROCESS | 1651 | 10:05:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:28 INFO - PROCESS | 1651 | RSS: Main: 326557696 10:05:28 INFO - PROCESS | 1651 | 10:05:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:32 INFO - PROCESS | 1651 | RSS: Main: 328937472 10:05:32 INFO - PROCESS | 1651 | 10:05:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 10:05:36 INFO - PROCESS | 1651 | RSS: Main: 326426624 10:05:36 INFO - PROCESS | 1651 | 10:05:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:38 INFO - PROCESS | 1651 | RSS: Main: 299548672 10:05:38 INFO - PROCESS | 1651 | 10:05:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:41 INFO - PROCESS | 1651 | RSS: Main: 305192960 10:05:41 INFO - PROCESS | 1651 | 10:05:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:43 INFO - PROCESS | 1651 | RSS: Main: 307179520 10:05:43 INFO - PROCESS | 1651 | 10:05:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:47 INFO - PROCESS | 1651 | RSS: Main: 324194304 10:05:47 INFO - PROCESS | 1651 | 10:05:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:51 INFO - PROCESS | 1651 | RSS: Main: 318083072 10:05:51 INFO - PROCESS | 1651 | 10:05:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 10:05:53 INFO - PROCESS | 1651 | RSS: Main: 363139072 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | __start_tp_report 10:05:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 10:05:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 10:05:53 INFO - PROCESS | 1651 | |i|pagename|runs| 10:05:53 INFO - PROCESS | 1651 | |0;ai-astar;111;113;111;112;113;112;112;113;111;112 10:05:53 INFO - PROCESS | 1651 | |1;audio-beat-detection;145;113;109;149;110;113;131;138;124;131 10:05:53 INFO - PROCESS | 1651 | |2;audio-dft;186;189;185;188;180;181;185;183;184;186 10:05:53 INFO - PROCESS | 1651 | |3;audio-fft;82;62;78;115;87;60;60;61;75;61 10:05:53 INFO - PROCESS | 1651 | |4;audio-oscillator;87;72;87;68;69;68;85;67;68;84 10:05:53 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;86;86;86;85;86;85;87;86;90;85 10:05:53 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;93;97;92;132;149;93;100;143;101 10:05:53 INFO - PROCESS | 1651 | |7;imaging-desaturate;88;88;88;87;84;86;89;88;85;85 10:05:53 INFO - PROCESS | 1651 | |8;json-parse-financial;61;58;58;57;56;58;60;59;58;57 10:05:53 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;73;76;72;69;68;71;72;99;101 10:05:53 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;93;90;88;88;88;87;89;89;89;88 10:05:53 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;142;144;136;153;129;142;143;153;216;158 10:05:53 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;172;168;173;171;169;172;172;172;171;173 10:05:53 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;66;68;67;66;67;68;64;66;67 10:05:53 INFO - PROCESS | 1651 | __end_tp_report 10:05:53 INFO - PROCESS | 1651 | __start_cc_report 10:05:53 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2135 10:05:53 INFO - PROCESS | 1651 | __end_cc_report 10:05:53 INFO - PROCESS | 1651 | __startTimestamp1487786753152__endTimestamp 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | ------- Summary: start ------- 10:05:53 INFO - PROCESS | 1651 | Number of tests: 14 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 10:05:53 INFO - PROCESS | 1651 | Values: 111.0 113.0 111.0 112.0 113.0 112.0 112.0 113.0 111.0 112.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:131.00 stddev:14.80 (11.3%) stddev-sans-first:14.06 10:05:53 INFO - PROCESS | 1651 | Values: 145.0 113.0 109.0 149.0 110.0 113.0 131.0 138.0 124.0 131.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:2.83 (1.5%) stddev-sans-first:2.96 10:05:53 INFO - PROCESS | 1651 | Values: 186.0 189.0 185.0 188.0 180.0 181.0 185.0 183.0 184.0 186.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:74.10 Median:68.50 stddev:17.65 (25.8%) stddev-sans-first:18.49 10:05:53 INFO - PROCESS | 1651 | Values: 82.0 62.0 78.0 115.0 87.0 60.0 60.0 61.0 75.0 61.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:78.00 stddev:8.96 (11.5%) stddev-sans-first:8.48 10:05:53 INFO - PROCESS | 1651 | Values: 87.0 72.0 87.0 68.0 69.0 68.0 85.0 67.0 68.0 84.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.00 stddev:1.48 (1.7%) stddev-sans-first:1.56 10:05:53 INFO - PROCESS | 1651 | Values: 86.0 86.0 86.0 85.0 86.0 85.0 87.0 86.0 90.0 85.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:109.40 Median:92.50 stddev:22.60 (24.4%) stddev-sans-first:23.28 10:05:53 INFO - PROCESS | 1651 | Values: 94.0 93.0 97.0 92.0 132.0 149.0 93.0 100.0 143.0 101.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:88.00 stddev:1.69 (1.9%) stddev-sans-first:1.73 10:05:53 INFO - PROCESS | 1651 | Values: 88.0 88.0 88.0 87.0 84.0 86.0 89.0 88.0 85.0 85.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:1.48 (2.5%) stddev-sans-first:1.17 10:05:53 INFO - PROCESS | 1651 | Values: 61.0 58.0 58.0 57.0 56.0 58.0 60.0 59.0 58.0 57.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:76.50 Median:72.00 stddev:12.80 (17.8%) stddev-sans-first:12.75 10:05:53 INFO - PROCESS | 1651 | Values: 64.0 73.0 76.0 72.0 69.0 68.0 71.0 72.0 99.0 101.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:89.00 stddev:1.66 (1.9%) stddev-sans-first:0.88 10:05:53 INFO - PROCESS | 1651 | Values: 93.0 90.0 88.0 88.0 88.0 87.0 89.0 89.0 89.0 88.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:148.50 stddev:24.18 (16.3%) stddev-sans-first:25.40 10:05:53 INFO - PROCESS | 1651 | Values: 142.0 144.0 136.0 153.0 129.0 142.0 143.0 153.0 216.0 158.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:172.00 stddev:1.64 (1.0%) stddev-sans-first:1.72 10:05:53 INFO - PROCESS | 1651 | Values: 172.0 168.0 173.0 171.0 169.0 172.0 172.0 172.0 171.0 173.0 10:05:53 INFO - PROCESS | 1651 | 10:05:53 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 10:05:53 INFO - PROCESS | 1651 | Values: 66.0 66.0 68.0 67.0 66.0 67.0 68.0 64.0 66.0 67.0 10:05:53 INFO - PROCESS | 1651 | -------- Summary: end -------- 10:05:53 INFO - PROCESS | 1651 | 10:05:54 INFO - TEST-INFO | 1651: exit 0 10:05:54 INFO - TEST-OK | kraken | took 60438ms 10:05:54 INFO - SUITE-END | took 1182s 10:05:54 INFO - Completed test suite (00:19:42) 10:05:54 INFO - javascript benchmark 10:05:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7073.470633253309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.6913743194395, 3280.9343813123724, 3300.323433696092, 3331.666833316667, 3354.731621470283, 5458.399576046631, 5540.473655002778, 5581.6930068846195, 5638.182463542789, 5669.0646043402785, 5545.667259964395, 5612.522935550483, 5643.322801263844, 5668.093105103184, 5674.290713660793, 5046.596272298208, 5073.264376665381, 5134.1528647773075, 5140.434552199274, 5153.215149475158, 5203.947960520403, 5250.816221432251, 5252.947470525303, 5264.236685680574, 5265.65773224741, 4960.280759289919, 5000.3249561309485, 5033.144365457844, 5084.694918304914, 5124.103281925667, 5058.140116180258, 5072.467390923936, 5081.59347252219, 5082.898342033176, 5089.465606111379, 4985.451600323961, 5009.474005229471, 5033.446320904697, 5040.193569028975, 5041.319421878036, 5475.014497390468, 5491.478309560585, 5503.6147469677135, 5509.834704958857, 5514.200440936042, 6016.007358785795, 6021.0, 6021.819345419601, 6027.306859711145, 6028.969855150696, 6124.173236613089, 6130.356312587159, 6140.210635704113, 6151.9234134026365, 6178.505719542426, 5622.690752008597, 5660.207570940031, 5677.687727175045, 5685.090385538336, 5688.402717714663, 6283.8114856554375, 6286.717097730613, 6293.779717709858, 6308.116863639094, 6308.495320374359, 5807.709614519257, 5879.500242479352, 5881.882362352729, 6086.421789929949, 6097.786577469856, 6109.75560977556, 6133.172021777003, 6134.754609815557, 6141.048137538689, 6143.385661433821, 6025.638461692312, 6026.54800889935, 6038.486728628028, 6042.939570604326, 6050.6672133032225, 5900.616459930091, 5991.340952495222, 6045.0, 6045.304789949212, 6055.788047418319, 4334.934975975363, 4343.500497442771, 4730.195866702668, 4847.491013443609, 4873.366462359871, 4203.810828512725, 4325.351197320364, 4325.740455572675, 4333.414988976511, 4335.479742430928, 5497.312835895513, 5594.1888426177975, 5705.4579814917515, 5707.486326230659, 5736.627119237236, 6260.906086408708, 6265.843353916098, 6267.341929097471, 6273.498120150377, 6285.811425657146, 5448.863778405572, 5477.260569823103, 5700.686462244534, 5705.600607957404, 5710.0, 5298.417174110845, 5301.655392399482, 5303.602229832778, 5304.840854774363, 5305.230741542455, 6211.440970312694, 6215.875682486416, 6227.532935029982, 6231.40801623845, 6249.718762655601, 5074.695518268915, 6094.75620975156, 6156.353582873734, 6204.5967012144065, 6222.315545289924, 6225.31521532622, 6234.096056071753, 6247.781327653511, 6251.9687401562705, 6255.843603909757, 5761.0, 6129.632222066691, 6136.6011209271255, 6156.907646385397, 6167.814965551041, 5903.734331955158, 5985.700714964321, 5986.970065149646, 5997.100434934795, 6004.159417681615, 5580.2745643067765, 5728.484436400744, 5754.280714910637, 5763.711814409179, 5764.740586673526, 5750.597458177887, 5755.3093628763145, 5756.30924289088, 5763.740631671669, 5764.510016648632, 5653.575981801464, 5671.291088613923, 5675.205471234113, 5679.801206957736, 5681.971590142023, 5739.167820666064, 5895.528357731286, 5904.675242861684, 5946.0, 5956.672383018976, 4262.893427664333, 5745.396733343106, 5788.218590490398, 5800.042992906123, 5805.187273781758], "value": 5549.940366848961, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.32772823948784, 460.813370584913, 468.5478513234729, 475.2562240094251, 541.9783208671653, 24758.0, 38205.04487387816, 38280.808595957016, 38351.80824095876, 38362.80818595907, 38785.0, 39343.80328098363, 39399.80300098495, 39481.0, 39491.0, 9079.364444488872, 9316.58075386606, 9333.719988400358, 9345.0, 9359.812803743922, 9206.355555111146, 9304.72085837426, 9322.533873306342, 9327.440353578773, 9329.0, 9308.34841561091, 9335.95332023339, 9344.392614480072, 9359.859602105973, 9361.20429763471, 9244.630214791401, 9342.832145981753, 9346.626134954593, 9348.345615806897, 9356.95321523388, 9172.403793753452, 9263.444193348354, 9267.351285410025, 9268.21220196284, 9286.396384235071, 36807.63192368069, 37153.44269835955, 37174.0, 37184.44223336652, 37184.81407592972, 3411.9488207676904, 3737.103095257146, 3760.849566017356, 3773.2453509298252, 3801.885943421702, 26151.476970460484, 26730.331741706417, 26736.59895101575, 29170.562441563394, 29465.705342946512, 3113.2683819302447, 3113.377324535102, 3135.1691801672573, 3206.0, 3229.3864165808423, 426672.0, 430000.849995748, 430191.0, 430738.0, 433330.0, 51486.74256628693, 51520.711982199995, 51678.0, 51980.740096299276, 52064.21903671448, 54146.72926635342, 54256.0, 54285.45714542804, 54343.0, 54516.18225726617, 13976.650583735285, 14058.297085145907, 14347.354369053417, 14364.712705745827, 14632.048916820373, 10994.890051099386, 11120.721981950515, 11209.047230985294, 11211.66365009051, 11222.775544489064, 13034.674133146558, 16358.754618680729, 16413.917930410273, 16458.588535286715, 16483.0, 7593.076665483829, 7615.4669173157345, 7718.151003389623, 7748.845023099507, 7755.30202281786, 772.5017363800317, 819.6065888373614, 863.0721973878107, 864.5936409887343, 870.9129087091367, 28239.43521129566, 28367.0, 29028.983985560826, 29067.0, 29079.85460072686, 1014.2697257974247, 1015.4668798880647, 1048.9318194317345, 1052.1162223732101, 1187.9961432589448, 14095.929520352538, 14428.206448645426, 14499.420023198954, 14873.0, 14940.850591494163, 598142.0, 603403.0, 603598.7480876384, 603824.0, 605056.0, 45511.089778204914, 54402.45597544053, 54875.72562137164, 54884.35346939598, 54925.0, 1330.6141219046367, 1372.9107608005447, 1396.0227840511682, 1398.3357904995046, 1398.6783039901084, 23766.0, 26994.0, 29701.702982969895, 29969.100926972227, 30616.387672245986, 49851.002979940924, 50531.74734126306, 50598.0, 50638.7340316495, 50713.0, 512223.0, 514913.0, 518141.0, 518203.0, 518568.0, 24027.51944961056, 24686.876565617058, 24744.752552474965, 25118.623220651338, 25161.622575661015, 38720.80639596784, 38810.0, 38974.0, 39186.216275674895, 40373.798131009156, 32538.34923301568, 32741.0, 33140.83429582837, 34351.62593496332, 34376.14059648529, 26554.0, 32638.83680581582, 33529.32941341208, 33781.81763638359, 33803.4929476063, 32739.836300818344, 33206.66793332036, 33278.66721332756, 33381.33237335288, 33388.666113339525, 26211.868940655175, 27158.555729984397, 29433.0, 29467.85266073656, 29515.40969180647, 22037.669434958167, 22249.332520024425, 22413.887930560242, 22475.550488990455, 22621.0], "value": 18408.81592293211, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.25014220563446, 389.9220155968805, 393.8090026337227, 402.24779662031995, 422.41284614386007, 13932.831276086921, 16572.585685357855, 20258.39224823254, 20933.685994710053, 21357.359279221648, 20409.0, 21544.56910861782, 21690.566188676217, 21978.560428791414, 22030.228941987032, 5560.110382338827, 5914.438128377818, 5921.822345329647, 5923.837799203281, 5931.673757943311, 4180.5610410906875, 5790.189373487715, 5844.678542680151, 5861.7948371807, 5875.471207591316, 5572.0, 5823.883522329551, 5824.893270278655, 5835.883282334351, 5839.182514447981, 5744.080947048473, 5782.0, 5809.099589563624, 5826.300843898759, 5832.125181222808, 4921.335619691332, 5065.265536497224, 5092.770825312869, 5142.691438513663, 5142.794288228466, 21095.156193752384, 25725.742742572522, 26006.73993260062, 26085.217443476726, 26161.607575886377, 2579.3809485723477, 2582.264054744389, 2585.0952166741677, 2592.0798116668498, 2614.2810727050214, 12681.23912565249, 14784.334704938303, 14793.852061479354, 14859.554213373616, 14937.775933361008, 1782.9821701783076, 1800.0819582013137, 1824.2794096331875, 1847.9907600462045, 1877.3906546125722, 106249.46875265651, 117085.0, 121999.78000219972, 125169.37415312865, 125212.0, 10160.441175735405, 10927.453627318602, 11530.135239857043, 11584.073274138049, 11692.824607630891, 13095.738085238241, 13440.193588384729, 13448.865511344957, 13451.394687239097, 13486.730265394637, 6993.6503174841055, 7664.961675191588, 7680.886271490603, 7689.653965571562, 8504.744857654281, 7073.681684324218, 7621.780515117554, 7673.386129109658, 8345.332373410112, 8439.493630382196, 6888.931110688929, 7037.331453512011, 7059.2234854166, 7071.434285257167, 7073.151221853308, 1640.8769342299136, 1866.3374502051847, 1949.2495389274948, 1961.9411417657493, 1962.7840937496865, 929.5538141692026, 1032.4992378696327, 1052.5684469367675, 1055.2244100586063, 1056.3450660590483, 20016.49958751043, 21812.563748724937, 22124.22565210242, 22596.548069038527, 22702.545949080926, 1022.6369638778127, 1071.7320669832543, 1072.769354588767, 1110.7056629993058, 1111.111111111108, 10902.945485272523, 11549.6535103947, 11672.182947193785, 11833.230839995373, 11924.284542927453, 569712.0, 665975.0, 684763.1331613578, 694371.0, 696484.0, 119463.0, 121898.78101218875, 122154.0, 123069.0, 125641.0, 979.637534112383, 997.3018886779283, 1027.0705011964185, 1028.5525796278644, 1028.6142696488816, 19337.323193688153, 19402.8059719401, 19405.611887762447, 19462.513437164183, 19541.413757587296, 48293.275600865316, 48305.0, 49204.26193607171, 49528.0, 51115.0, 72996.0, 78828.60585697035, 80704.59647701724, 81932.59033705032, 82303.0, 6870.31296870309, 7337.499001836646, 8317.085120636846, 8606.053334133365, 8902.510361930155, 9368.484733339732, 12496.625101246977, 13198.20810751358, 13583.456661733815, 13613.727725445633, 10947.83578246343, 10955.397453139834, 11223.775524489301, 11385.0, 11439.885601143882, 10749.946250268698, 10772.899284639734, 10904.890951090387, 11161.832572511581, 11211.439428028729, 11179.161562882653, 11271.380074096003, 11427.257228280136, 11856.110791690486, 11858.40707964581, 7110.5022648414115, 7605.733799316998, 7627.275408836374, 8598.957005214934, 8841.911580884365, 8414.116517765546, 10631.149508039183, 11404.94297528507, 11703.941480292544, 11805.701372849151], "value": 9777.084310597571, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.353926267235, 1354.884834789043, 1481.7925490431335, 1492.142018339455, 1495.9476418325357, 8140.557832650204, 8445.0, 8567.314614830813, 8570.957145214265, 8572.614232359543, 7033.472489563291, 8304.21109994551, 8397.202265784741, 8510.361722870779, 8517.914820851789, 2250.6849041134215, 2285.31440567829, 2288.702468679069, 2293.747687754346, 2299.72403311602, 1935.5741736817877, 2266.05958527211, 2310.722713274401, 2323.256557901472, 2326.081197926818, 1993.252530301137, 2019.1317733374642, 2021.0, 2023.079498828037, 2024.9696254556193, 1995.8802471851664, 2173.869567825928, 2271.488914994113, 2273.9317820465412, 2281.9657705134437, 2228.810551103158, 2256.5486902619377, 2292.289390289016, 2300.9654855177187, 2306.400335912658, 8393.916060839374, 8474.279686226679, 8479.152084791533, 8486.490810551386, 8489.108643592457, 5082.186850104003, 5245.501677340647, 5245.711485868275, 5262.315898933114, 5264.8683782905355, 3496.063306822256, 3511.5610548681416, 3519.1729943463265, 3551.0057183988524, 3600.5499312585926, 1194.2893978083027, 1208.8851559101872, 1237.5111830826863, 1242.1553343726262, 1251.124213050868, 8864.645414183426, 10901.890981090168, 10909.509072091774, 10917.508712107974, 10954.452277386179, 4333.739975601474, 4652.371929789503, 4711.623070154379, 4746.43042834862, 4748.881277968078, 9620.90379096214, 9628.133467987915, 9630.374025688308, 9640.951795240979, 9654.75863103428, 5259.105951988171, 5265.815696450606, 5267.420583735786, 5270.92093618596, 5281.102212623863, 3742.8502859885843, 4614.3309220163555, 4632.305154226826, 4804.543568361, 4809.78355973982, 3774.8678796241998, 3813.256414999104, 3853.2678791029616, 3867.43922131295, 3932.2528719543197, 1268.346801397281, 1285.2352850054203, 1285.8205341945313, 1309.6791286134958, 1310.5675127207999, 841.6128580852754, 864.8789169516273, 873.9431936924079, 914.3142643017736, 920.8296465153968, 5387.353517577837, 5537.833864984057, 5568.276124103841, 5846.210761547137, 5933.1396947443245, 971.6259240192577, 978.3885071830106, 984.3847595252967, 986.1420564109271, 1033.0857191385678, 3454.136465883529, 3608.1340478285024, 3797.4430483502183, 3800.657940785343, 3815.923681526354, 9640.71077867665, 9922.0, 9924.206063514901, 9928.851067233998, 9956.303058785961, 9315.20820730232, 9779.902200978042, 9791.755206119762, 9920.107190352903, 9946.154576860903, 7613.162552119263, 7810.648520816463, 7821.491603045783, 7834.216578342121, 7844.294013538694, 5414.891702166014, 5522.66863988162, 5534.7786088556, 5631.324241091095, 5876.853078673067, 9053.68312109073, 9316.813663726824, 9329.300302477206, 9342.112499312554, 9354.672586459441, 8834.514101724468, 9220.216281616138, 9229.35394522377, 9333.066693330613, 9438.811223775623, 7013.421980054447, 7181.317774811385, 7183.389411899838, 7184.856302874018, 7186.029885965328, 7665.88501172494, 7777.02787151606, 7837.020372453443, 7839.33365663925, 7845.097813751491, 6673.099131617169, 6987.196472405739, 7085.2560481150795, 7171.0, 7285.7449989252245, 6877.0, 6958.617276049866, 6987.825304367431, 7016.1580610325045, 7023.824404389931, 5785.884282314414, 6265.96867015662, 6375.585586936834, 6398.776042838478, 6403.6157830528455, 4502.4371953505815, 4671.972166123447, 4755.5006724294835, 4758.547937945889, 4884.413870335582, 4669.41632295963, 4701.506341834195, 4804.447488538863, 4880.389951256093, 5014.0974624567925], "value": 4392.273609109062, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.783366392038, 350.2067816395862, 355.08565443981746, 365.0690738616528, 371.9330520506308, 4780.354652121962, 4819.927701084483, 4824.493428190038, 4947.604191664667, 4969.0807200667905, 4633.884152896179, 4897.436794768594, 4931.284963680264, 4951.727654978975, 4965.3296804931415, 3412.133807601614, 3582.408902531086, 3794.2221844521946, 3819.541655001404, 3834.539855217378, 3577.9642203578023, 3697.7829288519024, 3722.003786951503, 3810.428435734634, 3810.4284357346482, 3602.7297952653525, 3673.94489082664, 3696.207339440369, 3704.5369328833895, 3785.0537365658583, 3402.506636537713, 3613.403788374915, 3761.943570846453, 3930.7248492605245, 3939.665128464084, 3279.3277378137664, 3510.403231450634, 3519.982400088009, 3522.4716292556063, 3525.612182659931, 3944.6055394460614, 4511.255642818964, 4805.255185446226, 4926.433460152092, 4934.284528743312, 4187.727797693171, 4261.190373828994, 4516.88707782308, 4530.229860923618, 4546.340585686201, 4970.2793095001025, 5117.590592752608, 5313.9734301328635, 5324.334458192726, 5336.4129945705945, 3762.1535154590274, 3846.423036544513, 3867.091233560111, 3918.6277303656107, 3973.642372186488, 5371.0, 5453.64551304164, 5497.8075767347955, 5548.4174161713245, 5554.944450555524, 3382.9492557611657, 3396.337714145767, 3539.50446937429, 3977.7016723745833, 4015.859444919414, 3735.290294844025, 4027.0, 4036.495438070241, 4072.837086516506, 4090.8568200112854, 3788.6590206881515, 4160.604742549453, 4223.68322375823, 4555.954440455553, 4617.884552886205, 4915.582175515121, 4939.580135688507, 5078.898422031539, 5353.866153346197, 5404.864878378072, 1263.368315842079, 1300.343326620051, 1308.1562392256942, 1309.718410541719, 1319.769040417923, 809.7570229697386, 811.5455345006815, 866.1079088538816, 869.1829680100685, 885.7387070814125, 3884.825182866721, 4574.438314543866, 4599.678022538457, 4665.410697063163, 4665.4634717007975, 4418.513963464016, 4785.0, 4785.449673287617, 4809.965857340619, 5083.669561478492, 3961.6230261842666, 4378.5183629800695, 4562.703424277412, 4606.479861645649, 4623.398958135421, 2288.3592594073684, 2530.860802655872, 2676.1168814291236, 2689.9058532951644, 2726.495598314318, 4583.6310311920715, 4653.371794807726, 4702.647301452336, 4989.301497790239, 5375.1511698799695, 4453.904536347208, 4812.470628230892, 4823.906935426746, 4843.24929635907, 5025.070361983045, 5338.626296159232, 5368.355797304271, 5379.8655033625255, 5385.461453854583, 5430.0, 4408.58118478744, 4518.069279726527, 4935.210366341368, 5107.38711354625, 5116.846494605168, 4609.562091601292, 4621.052684199663, 4699.17764391237, 5042.672226305279, 5147.613928955268, 5525.696086715269, 5525.917111243415, 5552.47251511122, 5553.16702494629, 5579.8884022320135, 3632.7285450092254, 3649.7627654202392, 3824.2160357126168, 3884.4755957946445, 3964.266610677034, 4475.776211189493, 5027.346444962278, 5028.472010438997, 5344.946550534445, 5382.542483888913, 5214.618126196485, 5224.399194092576, 5237.921431178459, 5242.842714718565, 5261.263782951693, 4844.709317440965, 5217.139172036572, 5228.294180285613, 5234.371875374827, 5241.528262456397, 4442.6890117691455, 4483.260262056724, 4949.109160351171, 5107.974460127824, 5133.358330208724, 5250.789968401221, 5251.343582052244, 5299.205119232146, 5301.655392399482, 5303.968983572589, 4200.718780771772, 4342.956570434255, 4858.46556878736, 5123.205903085028, 5167.3570133055355], "value": 3838.0846073558782, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.4653129949489, 745.7464462082894, 780.4497829030535, 786.2334224131471, 792.1009654042662, 14755.852441475581, 15072.39710411585, 15371.231438428076, 15572.221388930537, 15623.609409764762, 14184.36170372333, 14310.21293828839, 14325.641858953531, 14349.995500314983, 14378.712425751504, 902.5261737587754, 905.7509184974152, 916.5234078279291, 920.8020275640736, 922.0134456131941, 911.7994041310901, 914.0950459045564, 915.007217169372, 915.3958387464274, 915.9816803663923, 914.2548822709504, 945.5792172483248, 960.5341409416427, 963.5423173992367, 966.8984756600561, 949.1599934058339, 949.791045969889, 950.6672664567416, 951.224751827262, 951.4529145741158, 702.8910518869584, 703.9507234493587, 704.5842952657956, 704.7956092733101, 705.2348202200618, 15114.39542418302, 15361.0, 15519.844801552066, 15557.0, 15616.063036217749, 13817.502236124812, 14019.509317173952, 14215.857841421557, 14262.215578143197, 14325.928370358186, 9423.670171543963, 11507.424628768611, 11591.420428978518, 11745.29528228309, 11993.880061199363, 3625.2205775758075, 3641.362761516724, 3660.7071434285194, 3667.2665466906724, 3798.8480460781534, 93419.53290233573, 101405.0, 103709.0, 103883.96116038818, 104118.0, 10501.212409069198, 10525.842112368167, 10535.315204511682, 10561.471926403803, 10887.83668244977, 18360.357387491375, 21845.563088738138, 22154.335369938926, 22322.55354892893, 22427.99074041672, 7389.3349598535315, 7457.776266712007, 7489.700411983568, 7568.735094271674, 7707.190744971809, 4130.277201489787, 4192.056787222911, 4218.894527636834, 4234.407182994383, 4238.343056826136, 3573.6247693991754, 3674.1365779041903, 3674.6876515495946, 3683.4106542953, 3687.446882967576, 654.175738569406, 658.4765111736182, 665.7603262825379, 687.1925487552106, 690.7409721354492, 641.3874749614107, 666.6400143922325, 670.5339788846802, 691.1878542712293, 699.9160100787938, 9365.0, 9642.468040021178, 9972.202223822076, 10011.24915631316, 10156.441395723159, 628.7547856336032, 652.3997921911757, 686.6223577032612, 690.7513295213719, 691.4192078653955, 4294.420253265832, 4829.879253018703, 4833.4199896012, 4838.346823178897, 4862.78117484714, 99141.0, 104188.0, 104819.95180048102, 105073.0, 106278.46860765647, 48943.75528122336, 82693.21147519736, 89901.55049224712, 90036.0, 94666.0, 66775.0, 68403.97394039093, 68510.65744671345, 69066.0, 70060.0, 9665.985071567384, 9760.951195243979, 10473.738156546147, 10550.683479495627, 10643.680689579325, 48055.79860503376, 48315.75842120767, 48991.51008489869, 49081.50918490769, 50783.492165079355, 64305.356946429936, 65849.67075164593, 66432.66783666244, 67209.65580688261, 67715.66142169455, 11987.64037078889, 12261.14172007951, 12287.324197169242, 12541.310227937187, 13171.670708231988, 13709.821517202978, 13947.442102315794, 14005.18083092582, 14044.719105618035, 14046.438142474186, 12581.559645412366, 12713.87286127127, 12718.872811272138, 12779.552715654907, 13213.735725285633, 12900.870991290343, 13103.475860965455, 13118.344082796013, 13271.810151324924, 13548.390322435711, 12672.429740661877, 12746.745065098832, 12764.808527872276, 12935.417906194056, 13020.934895325463, 10605.098566621924, 10849.891501084889, 10957.342559446459, 11368.715782105182, 11415.942920285677, 8558.880400513663, 9096.363254572116, 9600.279979001463, 10527.526261318106, 10569.682909512727], "value": 7437.373272932811, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 111.0, 112.0, 113.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 109.0, 149.0, 110.0, 113.0, 131.0, 138.0, 124.0, 131.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 189.0, 185.0, 188.0, 180.0, 181.0, 185.0, 183.0, 184.0, 186.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 78.0, 115.0, 87.0, 60.0, 60.0, 61.0, 75.0, 61.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 87.0, 68.0, 69.0, 68.0, 85.0, 67.0, 68.0, 84.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 86.0, 85.0, 87.0, 86.0, 90.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 97.0, 92.0, 132.0, 149.0, 93.0, 100.0, 143.0, 101.0], "value": 109.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 87.0, 84.0, 86.0, 89.0, 88.0, 85.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 58.0, 57.0, 56.0, 58.0, 60.0, 59.0, 58.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 76.0, 72.0, 69.0, 68.0, 71.0, 72.0, 99.0, 101.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 88.0, 88.0, 88.0, 87.0, 89.0, 89.0, 89.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 136.0, 153.0, 129.0, 142.0, 143.0, 153.0, 216.0, 158.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 173.0, 171.0, 169.0, 172.0, 172.0, 172.0, 171.0, 173.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 66.0, 67.0, 68.0, 64.0, 66.0, 67.0], "value": 66.5, "unit": "score"}]}]} 10:05:54 INFO - Return code: 0 10:05:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:54 ERROR - # TBPL SUCCESS # 10:05:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:54 INFO - 2017-02-22 10:05:54.467 screenresolution[1655:10086] starting screenresolution argv=screenresolution get 10:05:54 INFO - 2017-02-22 10:05:54.470 screenresolution[1655:10086] Display 0: 1600x1200x32@60 10:05:54 INFO - 2017-02-22 10:05:54.476 screenresolution[1656:10089] starting screenresolution argv=screenresolution list 10:05:54 INFO - Available Modes on Display 0 10:05:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:54 INFO - Intel Iris: 10:05:54 INFO - Chipset Model: Intel Iris 10:05:54 INFO - Type: GPU 10:05:54 INFO - Bus: Built-In 10:05:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:05:54 INFO - Vendor: Intel (0x8086) 10:05:54 INFO - Device ID: 0x0a2e 10:05:54 INFO - Revision ID: 0x0009 10:05:54 INFO - Displays: 10:05:54 INFO - Display: 10:05:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:54 INFO - Display Serial Number: 1600x1200 60 10:05:54 INFO - Main Display: Yes 10:05:54 INFO - Mirror: Off 10:05:54 INFO - Online: Yes 10:05:54 INFO - Rotation: Supported 10:05:54 INFO - Return code: 0 10:05:54 INFO - Running post-action listener: _resource_record_post_action 10:05:54 INFO - [mozharness: 2017-02-22 18:05:54.725573Z] Finished run-tests step (success) 10:05:54 INFO - Running post-run listener: _resource_record_post_run 10:05:54 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 39302144; Write bytes: 513254912; Read time: 381; Write time: 1719 10:05:54 INFO - TinderboxPrint: CPU usage
53.8% 10:05:54 INFO - TinderboxPrint: I/O read bytes / time
39,302,144 / 381 10:05:54 INFO - TinderboxPrint: I/O write bytes / time
513,254,912 / 1,719 10:05:54 INFO - TinderboxPrint: CPU idle
2,222.4 (46.2%) 10:05:54 INFO - TinderboxPrint: CPU system
965.0 (20.0%) 10:05:54 INFO - TinderboxPrint: CPU user
1,626.3 (33.8%) 10:05:54 INFO - TinderboxPrint: Swap in / out
249,401,344 / 0 10:05:54 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206232064; Write bytes: 204740608; Read time: 15367; Write time: 450 10:05:54 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 37237760; Write bytes: 297819648; Read time: 351; Write time: 1230 10:05:55 INFO - Running post-run listener: _upload_blobber_files 10:05:55 INFO - Blob upload gear active. 10:05:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:55 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 10:05:55 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'] 10:05:55 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 10:05:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:05:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:56 INFO - (blobuploader) - INFO - Done attempting. 10:05:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:05:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:58 INFO - (blobuploader) - INFO - Done attempting. 10:05:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:05:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:58 INFO - (blobuploader) - INFO - Done attempting. 10:05:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:01 INFO - (blobuploader) - INFO - Done attempting. 10:06:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:06:01 INFO - Return code: 0 10:06:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:06:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:06:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f76c4e6bff5581b8ec000a07b86265a26575b317d0b3a400c294febd3a3ad7d26c3bdfe1497d6a9f6038afd274742485e70696f7040c5222454375d0ec8abcb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42b95a5276d8a3d3b4b5e4e740c10c1e5fd1abf8a9b4f0b61680dafa0703c2b027e8114c36f8a0258df8a74dea1c2bde1a523371079656528cf773fdc66d99f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b931a9c3991f6155c27d87e954ce922e819152b0a4295c8cd86dd1d5cbfe948ae32e8ef0e7b7c9b8c3d7c883a15753cc9284bc54b0df71efccba8151fb6600b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32bdbdc146775f50a48dd5fe02ba8b0807ddbf8683d3a86ac980957d18b107abf9501318c33ab9c10c69d1dd75a5a6821a9ca2b77cd1a4480a88803b34cdf9f1"} 10:06:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:06:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:06:01 INFO - Contents: 10:06:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f76c4e6bff5581b8ec000a07b86265a26575b317d0b3a400c294febd3a3ad7d26c3bdfe1497d6a9f6038afd274742485e70696f7040c5222454375d0ec8abcb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42b95a5276d8a3d3b4b5e4e740c10c1e5fd1abf8a9b4f0b61680dafa0703c2b027e8114c36f8a0258df8a74dea1c2bde1a523371079656528cf773fdc66d99f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b931a9c3991f6155c27d87e954ce922e819152b0a4295c8cd86dd1d5cbfe948ae32e8ef0e7b7c9b8c3d7c883a15753cc9284bc54b0df71efccba8151fb6600b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32bdbdc146775f50a48dd5fe02ba8b0807ddbf8683d3a86ac980957d18b107abf9501318c33ab9c10c69d1dd75a5a6821a9ca2b77cd1a4480a88803b34cdf9f1"} 10:06:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:06:01 INFO - Copying logs to upload dir... 10:06:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:06:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.985963 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-22 10:06:01.338225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 10:06:01.342059) ========= 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.kFmUePx8vf/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.HuNfLX1U87/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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/f76c4e6bff5581b8ec000a07b86265a26575b317d0b3a400c294febd3a3ad7d26c3bdfe1497d6a9f6038afd274742485e70696f7040c5222454375d0ec8abcb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42b95a5276d8a3d3b4b5e4e740c10c1e5fd1abf8a9b4f0b61680dafa0703c2b027e8114c36f8a0258df8a74dea1c2bde1a523371079656528cf773fdc66d99f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b931a9c3991f6155c27d87e954ce922e819152b0a4295c8cd86dd1d5cbfe948ae32e8ef0e7b7c9b8c3d7c883a15753cc9284bc54b0df71efccba8151fb6600b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32bdbdc146775f50a48dd5fe02ba8b0807ddbf8683d3a86ac980957d18b107abf9501318c33ab9c10c69d1dd75a5a6821a9ca2b77cd1a4480a88803b34cdf9f1"} build_url:https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011611 build_url: 'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f76c4e6bff5581b8ec000a07b86265a26575b317d0b3a400c294febd3a3ad7d26c3bdfe1497d6a9f6038afd274742485e70696f7040c5222454375d0ec8abcb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42b95a5276d8a3d3b4b5e4e740c10c1e5fd1abf8a9b4f0b61680dafa0703c2b027e8114c36f8a0258df8a74dea1c2bde1a523371079656528cf773fdc66d99f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b931a9c3991f6155c27d87e954ce922e819152b0a4295c8cd86dd1d5cbfe948ae32e8ef0e7b7c9b8c3d7c883a15753cc9284bc54b0df71efccba8151fb6600b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32bdbdc146775f50a48dd5fe02ba8b0807ddbf8683d3a86ac980957d18b107abf9501318c33ab9c10c69d1dd75a5a6821a9ca2b77cd1a4480a88803b34cdf9f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 10:06:01.374926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 10:06:01.375271) ========= 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.kFmUePx8vf/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.HuNfLX1U87/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005306 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 10:06:01.424482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 10:06:01.424836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 10:06:01.425223) ========= ========= Total master_lag: 0.17 =========