builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0085 starttime: 1482082369.95 results: success (0) buildid: 20161218064735 builduid: a5e8dea1a2b441338cc8342447aab87f revision: 2f7c683f7d481c00b9f2664956c559235cdbb96a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:49.949936) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:49.950469) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:49.950778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:49.976670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:49.977086) ========= 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.8oUrVizGbS/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.iM88Sr9vOA/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 --2016-12-18 09:32:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.71M=0.002s 2016-12-18 09:32:50 (7.71 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171377 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:50.175277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:50.175692) ========= 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.8oUrVizGbS/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.iM88Sr9vOA/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.020282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:50.225531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 09:32:50.225919) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2f7c683f7d481c00b9f2664956c559235cdbb96a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2f7c683f7d481c00b9f2664956c559235cdbb96a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8oUrVizGbS/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.iM88Sr9vOA/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 2016-12-18 09:32:50,304 truncating revision to first 12 chars 2016-12-18 09:32:50,304 Setting DEBUG logging. 2016-12-18 09:32:50,304 attempt 1/10 2016-12-18 09:32:50,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2f7c683f7d48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-18 09:32:51,265 unpacking tar archive at: mozilla-aurora-2f7c683f7d48/testing/mozharness/ program finished with exit code 0 elapsedTime=1.218496 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 09:32:51.469836) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:51.470179) ========= script_repo_revision: 2f7c683f7d481c00b9f2664956c559235cdbb96a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:51.470582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:51.470881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 09:32:51.491300) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-18 09:32:51.491705) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8oUrVizGbS/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.iM88Sr9vOA/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:32:51 INFO - MultiFileLogger online at 20161218 09:32:51 in /builds/slave/test 09:32:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:32:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:51 INFO - {'append_to_log': False, 09:32:51 INFO - 'base_work_dir': '/builds/slave/test', 09:32:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:32:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:51 INFO - 'branch': 'Mozilla-Aurora', 09:32:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:51 INFO - 'config_files': ('talos/mac_config.py',), 09:32:51 INFO - 'default_actions': ('clobber', 09:32:51 INFO - 'read-buildbot-config', 09:32:51 INFO - 'download-and-extract', 09:32:51 INFO - 'populate-webroot', 09:32:51 INFO - 'create-virtualenv', 09:32:51 INFO - 'install', 09:32:51 INFO - 'run-tests'), 09:32:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:51 INFO - 'download_minidump_stackwalk': True, 09:32:51 INFO - 'download_symbols': 'ondemand', 09:32:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:51 INFO - 'installer_path': 'installer.exe', 09:32:51 INFO - 'log_level': 'info', 09:32:51 INFO - 'log_name': 'talos', 09:32:51 INFO - 'log_to_console': True, 09:32:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:32:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:32:51 INFO - 'opt_config_files': (), 09:32:51 INFO - 'pip_index': False, 09:32:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:32:51 INFO - 'cmd': ('bash', 09:32:51 INFO - '-c', 09:32:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:32:51 INFO - 'enabled': True, 09:32:51 INFO - 'halt_on_failure': False, 09:32:51 INFO - 'name': 'check_screen_resolution'},), 09:32:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:32:51 INFO - 'cmd': ('bash', 09:32:51 INFO - '-c', 09:32:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:32:51 INFO - 'enabled': True, 09:32:51 INFO - 'halt_on_failure': False, 09:32:51 INFO - 'name': 'check_screen_resolution'},), 09:32:51 INFO - 'run_cmd_checks_enabled': True, 09:32:51 INFO - 'sps_profile': False, 09:32:51 INFO - 'sps_profile_interval': 0, 09:32:51 INFO - 'suite': 'dromaeojs', 09:32:51 INFO - 'system_bits': '32', 09:32:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:51 INFO - 'title': 't-yosemite-r7-0085', 09:32:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:51 INFO - 'use_talos_json': True, 09:32:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:51 INFO - 'work_dir': 'build'} 09:32:51 INFO - [mozharness: 2016-12-18 17:32:51.697730Z] Running clobber step. 09:32:51 INFO - Running pre-action listener: _resource_record_pre_action 09:32:51 INFO - Running main action method: clobber 09:32:51 INFO - rmtree: /builds/slave/test/build 09:32:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:53 INFO - Running post-action listener: _resource_record_post_action 09:32:53 INFO - [mozharness: 2016-12-18 17:32:53.334900Z] Finished clobber step (success) 09:32:53 INFO - [mozharness: 2016-12-18 17:32:53.335027Z] Running read-buildbot-config step. 09:32:53 INFO - Running pre-action listener: _resource_record_pre_action 09:32:53 INFO - Running main action method: read_buildbot_config 09:32:53 INFO - Using buildbot properties: 09:32:53 INFO - { 09:32:53 INFO - "project": "", 09:32:53 INFO - "product": "firefox", 09:32:53 INFO - "script_repo_revision": "production", 09:32:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:32:53 INFO - "repository": "", 09:32:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:32:53 INFO - "buildid": "20161218064735", 09:32:53 INFO - "pgo_build": "False", 09:32:53 INFO - "basedir": "/builds/slave/test", 09:32:53 INFO - "buildnumber": 13, 09:32:53 INFO - "slavename": "t-yosemite-r7-0085", 09:32:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:32:53 INFO - "platform": "yosemite_r7", 09:32:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:32:53 INFO - "branch": "mozilla-aurora", 09:32:53 INFO - "repo_path": "releases/mozilla-aurora", 09:32:53 INFO - "revision": "2f7c683f7d481c00b9f2664956c559235cdbb96a", 09:32:53 INFO - "stage_platform": "macosx64", 09:32:53 INFO - "builduid": "a5e8dea1a2b441338cc8342447aab87f", 09:32:53 INFO - "slavebuilddir": "test" 09:32:53 INFO - } 09:32:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 09:32:53 INFO - Running post-action listener: _resource_record_post_action 09:32:53 INFO - [mozharness: 2016-12-18 17:32:53.338281Z] Finished read-buildbot-config step (success) 09:32:53 INFO - [mozharness: 2016-12-18 17:32:53.338391Z] Running download-and-extract step. 09:32:53 INFO - Running pre-action listener: _resource_record_pre_action 09:32:53 INFO - Running main action method: download_and_extract 09:32:53 INFO - mkdir: /builds/slave/test/build/tests 09:32:53 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:32:53 INFO - trying https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 09:32:53 INFO - Downloading https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:32:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 09:32:54 INFO - Downloaded 1199 bytes. 09:32:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 09:32:54 INFO - Using the following test package requirements: 09:32:54 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:32:54 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 09:32:54 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 09:32:54 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'jsshell-mac.zip'], 09:32:54 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 09:32:54 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 09:32:54 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 09:32:54 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 09:32:54 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 09:32:54 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 09:32:54 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 09:32:54 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:32:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:32:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:32:54 INFO - Fetch https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:32:54 INFO - Http code: 200 09:32:54 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 09:32:54 INFO - x-amz-cf-id: PDC7McENlLNfxgFdejEHggclEuwBqsA7bIymEtvI6e7WjHJHi_BYUQ== 09:32:54 INFO - x-amz-version-id: xMHE4E68KHPqv2dvDMuq8YHiAZUWQsp7 09:32:55 INFO - Expected file size: 16280471 09:32:55 INFO - Obtained file size: 16280471 09:33:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:33:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 09:33:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:33:01 INFO - Fetch https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 09:33:02 INFO - Http code: 200 09:33:02 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 09:33:02 INFO - x-amz-cf-id: rex7wLtP3OETgGFmx5BI_TivT0dLf0YwWQvod8oaIRH58ejtQxa7JA== 09:33:02 INFO - x-amz-version-id: xMHE4E68KHPqv2dvDMuq8YHiAZUWQsp7 09:33:02 INFO - Expected file size: 16280471 09:33:02 INFO - Obtained file size: 16280471 09:33:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 09:33:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:33:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 09:33:09 INFO - Http code: 200 09:33:09 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 09:33:09 INFO - x-amz-cf-id: A3LBZ5lVeAQTJh0Q5Fk2rJlco5OkS8l9GaU7YLDH16rKFZfj7pQg6w== 09:33:09 INFO - x-amz-version-id: L40Ck5kmQWBxUWAoG1B0IEnbiLXBDx8n 09:33:09 INFO - Expected file size: 14409038 09:33:09 INFO - Obtained file size: 14409038 09:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:10 INFO - trying https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:33:10 INFO - Downloading https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 09:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 09:33:13 INFO - Downloaded 109665183 bytes. 09:33:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:33:13 INFO - mkdir: /builds/slave/test/properties 09:33:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:13 INFO - Contents: 09:33:13 INFO - build_url:https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 09:33:13 INFO - Running post-action listener: _resource_record_post_action 09:33:13 INFO - Running post-action listener: set_extra_try_arguments 09:33:13 INFO - [mozharness: 2016-12-18 17:33:13.974967Z] Finished download-and-extract step (success) 09:33:13 INFO - [mozharness: 2016-12-18 17:33:13.975085Z] Running populate-webroot step. 09:33:13 INFO - Running pre-action listener: _resource_record_pre_action 09:33:13 INFO - Running main action method: populate_webroot 09:33:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:13 INFO - '--tppagecycles', 09:33:13 INFO - '7'], 09:33:13 INFO - 'tests': ['tsvgm']}}, 09:33:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['damp', 'tps']}, 09:33:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'tests': ['damp', 'tps']}, 09:33:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['dromaeo_dom']}, 09:33:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['basic_compositor_video']}, 09:33:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:33:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['a11yr', 09:33:13 INFO - 'ts_paint', 09:33:13 INFO - 'tpaint', 09:33:13 INFO - 'sessionrestore', 09:33:13 INFO - 'sessionrestore_no_auto_restore', 09:33:13 INFO - 'tabpaint']}, 09:33:13 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:13 INFO - 'ts_paint', 09:33:13 INFO - 'tpaint', 09:33:13 INFO - 'sessionrestore', 09:33:13 INFO - 'sessionrestore_no_auto_restore', 09:33:13 INFO - 'tabpaint']}, 09:33:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:13 INFO - 'ts_paint', 09:33:13 INFO - 'tpaint', 09:33:13 INFO - 'sessionrestore', 09:33:13 INFO - 'sessionrestore_no_auto_restore', 09:33:13 INFO - 'tabpaint']}, 09:33:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:13 INFO - 'ts_paint', 09:33:13 INFO - 'tpaint', 09:33:13 INFO - 'sessionrestore', 09:33:13 INFO - 'sessionrestore_no_auto_restore', 09:33:13 INFO - 'tabpaint']}, 09:33:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['a11yr', 09:33:13 INFO - 'ts_paint', 09:33:13 INFO - 'tpaint', 09:33:13 INFO - 'sessionrestore', 09:33:13 INFO - 'sessionrestore_no_auto_restore', 09:33:13 INFO - 'tabpaint']}, 09:33:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['a11yr', 09:33:13 INFO - 'ts_paint', 09:33:13 INFO - 'tpaint', 09:33:13 INFO - 'sessionrestore', 09:33:13 INFO - 'sessionrestore_no_auto_restore', 09:33:13 INFO - 'tabpaint']}, 09:33:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['tsvgx', 09:33:13 INFO - 'tsvgr_opacity', 09:33:13 INFO - 'tart', 09:33:13 INFO - 'tscrollx', 09:33:13 INFO - 'cart']}, 09:33:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:13 INFO - 'tsvgr_opacity', 09:33:13 INFO - 'tart', 09:33:13 INFO - 'tscrollx', 09:33:13 INFO - 'cart']}, 09:33:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'talos_options': ['--disable-e10s'], 09:33:13 INFO - 'tests': ['tp5o']}, 09:33:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'tests': ['tp5o']}, 09:33:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'talos_options': ['--disable-e10s', 09:33:13 INFO - '--xperf_path', 09:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:13 INFO - 'tests': ['tp5n']}, 09:33:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:13 INFO - 'talos_options': ['--xperf_path', 09:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:13 INFO - 'tests': ['tp5n']}}, 09:33:13 INFO - 'talos.zip': {'path': '', 09:33:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:13 INFO - Running post-action listener: _resource_record_post_action 09:33:13 INFO - [mozharness: 2016-12-18 17:33:13.994374Z] Finished populate-webroot step (success) 09:33:13 INFO - [mozharness: 2016-12-18 17:33:13.994511Z] Running create-virtualenv step. 09:33:13 INFO - Running pre-action listener: _resource_record_pre_action 09:33:13 INFO - Running main action method: create_virtualenv 09:33:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:13 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:33:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:14 INFO - Using real prefix '/tools/python27' 09:33:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:14 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:17 INFO - Installing pip.................done. 09:33:17 INFO - Return code: 0 09:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:17 INFO - Reading from file tmpfile_stdout 09:33:17 INFO - Output received: 09:33:17 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:33:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:17 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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:17 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:33:17 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:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:17 INFO - 'HOME': '/Users/cltbld', 09:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:17 INFO - 'LOGNAME': 'cltbld', 09:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:17 INFO - 'MOZ_NO_REMOTE': '1', 09:33:17 INFO - 'NO_EM_RESTART': '1', 09:33:17 INFO - 'PAGER': '/bin/cat', 09:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:17 INFO - 'PWD': '/builds/slave/test', 09:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:17 INFO - 'SHELL': '/bin/bash', 09:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:17 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:17 INFO - 'USER': 'cltbld', 09:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:17 INFO - 'XPC_FLAGS': '0x0', 09:33:17 INFO - 'XPC_SERVICE_NAME': '0', 09:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:18 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:33:18 INFO - Cleaning up... 09:33:18 INFO - Return code: 0 09:33:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:18 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:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 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:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:18 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:33:18 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:33:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:18 INFO - 'HOME': '/Users/cltbld', 09:33:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:18 INFO - 'LOGNAME': 'cltbld', 09:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:18 INFO - 'MOZ_NO_REMOTE': '1', 09:33:18 INFO - 'NO_EM_RESTART': '1', 09:33:18 INFO - 'PAGER': '/bin/cat', 09:33:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:18 INFO - 'PWD': '/builds/slave/test', 09:33:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:18 INFO - 'SHELL': '/bin/bash', 09:33:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:18 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:18 INFO - 'USER': 'cltbld', 09:33:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:18 INFO - 'XPC_FLAGS': '0x0', 09:33:18 INFO - 'XPC_SERVICE_NAME': '0', 09:33:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:18 INFO - Downloading/unpacking psutil>=3.1.1 09:33:18 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:33:18 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:33:18 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:33:18 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:33:18 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:33:18 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:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:22 INFO - Installing collected packages: psutil 09:33:22 INFO - Running setup.py install for psutil 09:33:22 INFO - building 'psutil._psutil_osx' extension 09:33:22 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:33:22 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:33:22 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:33:22 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:33:22 INFO - building 'psutil._psutil_posix' extension 09:33:22 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:33:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:33:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:33:22 INFO - ^ 09:33:22 INFO - 1 warning generated. 09:33:22 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:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:22 INFO - Successfully installed psutil 09:33:22 INFO - Cleaning up... 09:33:23 INFO - Return code: 0 09:33:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:23 INFO - 'HOME': '/Users/cltbld', 09:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:23 INFO - 'LOGNAME': 'cltbld', 09:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:23 INFO - 'MOZ_NO_REMOTE': '1', 09:33:23 INFO - 'NO_EM_RESTART': '1', 09:33:23 INFO - 'PAGER': '/bin/cat', 09:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:23 INFO - 'PWD': '/builds/slave/test', 09:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:23 INFO - 'SHELL': '/bin/bash', 09:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:23 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:23 INFO - 'USER': 'cltbld', 09:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:23 INFO - 'XPC_FLAGS': '0x0', 09:33:23 INFO - 'XPC_SERVICE_NAME': '0', 09:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33:23 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:33:23 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:33:23 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:33:23 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:33:23 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:33:23 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:33:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:26 INFO - Installing collected packages: mozsystemmonitor 09:33:26 INFO - Running setup.py install for mozsystemmonitor 09:33:26 INFO - Successfully installed mozsystemmonitor 09:33:26 INFO - Cleaning up... 09:33:26 INFO - Return code: 0 09:33:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33: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:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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', '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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:33: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 jsonschema==2.5.1 09:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:26 INFO - 'HOME': '/Users/cltbld', 09:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:26 INFO - 'LOGNAME': 'cltbld', 09:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:26 INFO - 'MOZ_NO_REMOTE': '1', 09:33:26 INFO - 'NO_EM_RESTART': '1', 09:33:26 INFO - 'PAGER': '/bin/cat', 09:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:26 INFO - 'PWD': '/builds/slave/test', 09:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:26 INFO - 'SHELL': '/bin/bash', 09:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:26 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:26 INFO - 'USER': 'cltbld', 09:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:26 INFO - 'XPC_FLAGS': '0x0', 09:33:26 INFO - 'XPC_SERVICE_NAME': '0', 09:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:26 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:26 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:33:26 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:33:26 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:33:26 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:33:26 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:33:26 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:33:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:29 INFO - warning: no files found matching '*.txt' 09:33:29 INFO - no previously-included directories found matching 'build' 09:33:29 INFO - no previously-included directories found matching 'dist' 09:33:29 INFO - no previously-included directories found matching '.git*' 09:33:29 INFO - Installing collected packages: jsonschema, functools32 09:33:29 INFO - Running setup.py install for functools32 09:33:29 INFO - warning: no files found matching '*.txt' 09:33:29 INFO - no previously-included directories found matching 'build' 09:33:29 INFO - no previously-included directories found matching 'dist' 09:33:29 INFO - no previously-included directories found matching '.git*' 09:33:29 INFO - Successfully installed jsonschema functools32 09:33:29 INFO - Cleaning up... 09:33:29 INFO - Return code: 0 09:33:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:29 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:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:29 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:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:29 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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:29 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:33:29 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:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:29 INFO - 'HOME': '/Users/cltbld', 09:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:29 INFO - 'LOGNAME': 'cltbld', 09:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:29 INFO - 'MOZ_NO_REMOTE': '1', 09:33:29 INFO - 'NO_EM_RESTART': '1', 09:33:29 INFO - 'PAGER': '/bin/cat', 09:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:29 INFO - 'PWD': '/builds/slave/test', 09:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:29 INFO - 'SHELL': '/bin/bash', 09:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:29 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:29 INFO - 'USER': 'cltbld', 09:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:29 INFO - 'XPC_FLAGS': '0x0', 09:33:29 INFO - 'XPC_SERVICE_NAME': '0', 09:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:30 INFO - Cleaning up... 09:33:30 INFO - Return code: 0 09:33:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33: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:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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', '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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:33: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 blobuploader==1.2.4 09:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:30 INFO - 'HOME': '/Users/cltbld', 09:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:30 INFO - 'LOGNAME': 'cltbld', 09:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:30 INFO - 'MOZ_NO_REMOTE': '1', 09:33:30 INFO - 'NO_EM_RESTART': '1', 09:33:30 INFO - 'PAGER': '/bin/cat', 09:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:30 INFO - 'PWD': '/builds/slave/test', 09:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:30 INFO - 'SHELL': '/bin/bash', 09:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:30 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:30 INFO - 'USER': 'cltbld', 09:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:30 INFO - 'XPC_FLAGS': '0x0', 09:33:30 INFO - 'XPC_SERVICE_NAME': '0', 09:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:30 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:33:30 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:33:30 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:33:30 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:33:30 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:33:30 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:33:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:33 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:33:33 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:33:33 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:33:33 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:33:33 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:33:33 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:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:33 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:33:33 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:33:33 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:33:33 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:33:33 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:33:33 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:33:34 INFO - Downloading docopt-0.6.1.tar.gz 09:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:34 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:34 INFO - Running setup.py install for blobuploader 09:33:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:34 INFO - Running setup.py install for requests 09:33:34 INFO - Running setup.py install for docopt 09:33:35 INFO - Successfully installed blobuploader requests docopt 09:33:35 INFO - Cleaning up... 09:33:35 INFO - Return code: 0 09:33:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:35 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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:35 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:33:35 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:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:35 INFO - 'HOME': '/Users/cltbld', 09:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:35 INFO - 'LOGNAME': 'cltbld', 09:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:35 INFO - 'MOZ_NO_REMOTE': '1', 09:33:35 INFO - 'NO_EM_RESTART': '1', 09:33:35 INFO - 'PAGER': '/bin/cat', 09:33:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:35 INFO - 'PWD': '/builds/slave/test', 09:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:35 INFO - 'SHELL': '/bin/bash', 09:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:35 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:35 INFO - 'USER': 'cltbld', 09:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:35 INFO - 'XPC_FLAGS': '0x0', 09:33:35 INFO - 'XPC_SERVICE_NAME': '0', 09:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-yKknSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-UgpbS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-NezXUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-8s2Psq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-0QtD_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-kE80yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-WFfABg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-dteu5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-WhO8ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-n3ljQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-5WSNWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-HWN671-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-c5Ynsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_jZGqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:36 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xjSKB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:37 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xaQKKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:37 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-YNEVpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:37 INFO - Running setup.py install for manifestparser 09:33:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:37 INFO - Running setup.py install for mozcrash 09:33:37 INFO - Running setup.py install for mozdebug 09:33:37 INFO - Running setup.py install for mozdevice 09:33:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:37 INFO - Running setup.py install for mozfile 09:33:38 INFO - Running setup.py install for mozhttpd 09:33:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozinfo 09:33:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozInstall 09:33:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozleak 09:33:38 INFO - Running setup.py install for mozlog 09:33:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for moznetwork 09:33:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozprocess 09:33:39 INFO - Running setup.py install for mozprofile 09:33:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Running setup.py install for mozrunner 09:33:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Running setup.py install for mozscreenshot 09:33:39 INFO - Running setup.py install for moztest 09:33:39 INFO - Running setup.py install for mozversion 09:33:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:39 INFO - Cleaning up... 09:33:39 INFO - Return code: 0 09:33:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:39 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:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:39 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:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:39 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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:39 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:33:39 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:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:39 INFO - 'HOME': '/Users/cltbld', 09:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:39 INFO - 'LOGNAME': 'cltbld', 09:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:39 INFO - 'MOZ_NO_REMOTE': '1', 09:33:39 INFO - 'NO_EM_RESTART': '1', 09:33:39 INFO - 'PAGER': '/bin/cat', 09:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:39 INFO - 'PWD': '/builds/slave/test', 09:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:39 INFO - 'SHELL': '/bin/bash', 09:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:39 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:39 INFO - 'USER': 'cltbld', 09:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:39 INFO - 'XPC_FLAGS': '0x0', 09:33:39 INFO - 'XPC_SERVICE_NAME': '0', 09:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-kCru2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:40 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-7y3ZQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:40 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-BPn_kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:40 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-BNeEeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-C1WH0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:40 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Xc5WHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:40 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Pc_OtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:40 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:40 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-s09305-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:40 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:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-59aMH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:41 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-iwObY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:41 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xm1eyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:41 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-jxkkHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-DyExnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:41 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Dl2aCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:41 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-9yaFON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:41 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-IaZco3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:41 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-NZb83p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:41 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:33:41 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:33:41 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:33:41 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:33:41 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:41 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:44 INFO - Downloading blessings-1.6.tar.gz 09:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:44 INFO - Installing collected packages: blessings 09:33:44 INFO - Running setup.py install for blessings 09:33:44 INFO - Successfully installed blessings 09:33:44 INFO - Cleaning up... 09:33:44 INFO - Return code: 0 09:33:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:45 INFO - Reading from file tmpfile_stdout 09:33:45 INFO - Current package versions: 09:33:45 INFO - blessings == 1.6 09:33:45 INFO - blobuploader == 1.2.4 09:33:45 INFO - docopt == 0.6.1 09:33:45 INFO - functools32 == 3.2.3-2 09:33:45 INFO - jsonschema == 2.5.1 09:33:45 INFO - manifestparser == 1.1 09:33:45 INFO - mozInstall == 1.12 09:33:45 INFO - mozcrash == 1.0 09:33:45 INFO - mozdebug == 0.1 09:33:45 INFO - mozdevice == 0.48 09:33:45 INFO - mozfile == 1.2 09:33:45 INFO - mozhttpd == 0.7 09:33:45 INFO - mozinfo == 0.9 09:33:45 INFO - mozleak == 0.1 09:33:45 INFO - mozlog == 3.4 09:33:45 INFO - moznetwork == 0.27 09:33:45 INFO - mozprocess == 0.23 09:33:45 INFO - mozprofile == 0.28 09:33:45 INFO - mozrunner == 6.13 09:33:45 INFO - mozscreenshot == 0.1 09:33:45 INFO - mozsystemmonitor == 0.3 09:33:45 INFO - moztest == 0.7 09:33:45 INFO - mozversion == 1.4 09:33:45 INFO - psutil == 3.1.1 09:33:45 INFO - requests == 1.2.3 09:33:45 INFO - wsgiref == 0.1.2 09:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:45 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:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:45 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:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:45 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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:45 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:33:45 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:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:45 INFO - 'HOME': '/Users/cltbld', 09:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:45 INFO - 'LOGNAME': 'cltbld', 09:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:45 INFO - 'MOZ_NO_REMOTE': '1', 09:33:45 INFO - 'NO_EM_RESTART': '1', 09:33:45 INFO - 'PAGER': '/bin/cat', 09:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:45 INFO - 'PWD': '/builds/slave/test', 09:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:45 INFO - 'SHELL': '/bin/bash', 09:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:45 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:45 INFO - 'USER': 'cltbld', 09:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:45 INFO - 'XPC_FLAGS': '0x0', 09:33:45 INFO - 'XPC_SERVICE_NAME': '0', 09:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 INFO - Cleaning up... 09:33:45 INFO - Return code: 0 09:33:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:45 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:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:45 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:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:45 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 0x10c39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f1159c100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, '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.8oUrVizGbS/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.iM88Sr9vOA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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:33:45 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:33:45 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:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:45 INFO - 'HOME': '/Users/cltbld', 09:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:45 INFO - 'LOGNAME': 'cltbld', 09:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:45 INFO - 'MOZ_NO_REMOTE': '1', 09:33:45 INFO - 'NO_EM_RESTART': '1', 09:33:45 INFO - 'PAGER': '/bin/cat', 09:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:45 INFO - 'PWD': '/builds/slave/test', 09:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:45 INFO - 'SHELL': '/bin/bash', 09:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:33:45 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:45 INFO - 'USER': 'cltbld', 09:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:45 INFO - 'XPC_FLAGS': '0x0', 09:33:45 INFO - 'XPC_SERVICE_NAME': '0', 09:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:45 INFO - Cleaning up... 09:33:45 INFO - Return code: 0 09:33:45 INFO - Running post-action listener: _resource_record_post_action 09:33:45 INFO - Running post-action listener: _start_resource_monitoring 09:33:45 INFO - Starting resource monitoring. 09:33:45 INFO - [mozharness: 2016-12-18 17:33:45.773127Z] Finished create-virtualenv step (success) 09:33:45 INFO - [mozharness: 2016-12-18 17:33:45.774130Z] Running install step. 09:33:45 INFO - Running pre-action listener: _resource_record_pre_action 09:33:45 INFO - Running main action method: install 09:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:46 INFO - Reading from file tmpfile_stdout 09:33:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:46 INFO - Reading from file tmpfile_stdout 09:33:46 INFO - Output received: 09:33:46 INFO - Usage: mozinstall [options] installer 09:33:46 INFO - Options: 09:33:46 INFO - -h, --help show this help message and exit 09:33:46 INFO - -d DEST, --destination=DEST 09:33:46 INFO - Directory to install application into. [default: 09:33:46 INFO - "/builds/slave/test"] 09:33:46 INFO - --app=APP Application being installed. [default: firefox] 09:33:46 INFO - mkdir: /builds/slave/test/build/application 09:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:34:17 INFO - Reading from file tmpfile_stdout 09:34:17 INFO - Output received: 09:34:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:34:17 INFO - Running post-action listener: _resource_record_post_action 09:34:17 INFO - [mozharness: 2016-12-18 17:34:17.232341Z] Finished install step (success) 09:34:17 INFO - [mozharness: 2016-12-18 17:34:17.232517Z] Running run-tests step. 09:34:17 INFO - Running pre-action listener: _resource_record_pre_action 09:34:17 INFO - Running main action method: run_tests 09:34:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:34:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:34:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:34:17 INFO - 2016-12-18 09:34:17.246 screenresolution[1913:21646] starting screenresolution argv=screenresolution get 09:34:17 INFO - 2016-12-18 09:34:17.249 screenresolution[1913:21646] Display 0: 1600x1200x32@60 09:34:17 INFO - 2016-12-18 09:34:17.255 screenresolution[1914:21648] starting screenresolution argv=screenresolution list 09:34:17 INFO - Available Modes on Display 0 09:34:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:34:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:34:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:34:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:34:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:34:17 INFO - Intel Iris: 09:34:17 INFO - Chipset Model: Intel Iris 09:34:17 INFO - Type: GPU 09:34:17 INFO - Bus: Built-In 09:34:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:34:17 INFO - Vendor: Intel (0x8086) 09:34:17 INFO - Device ID: 0x0a2e 09:34:17 INFO - Revision ID: 0x0009 09:34:17 INFO - Displays: 09:34:17 INFO - Display: 09:34:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:34:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:34:17 INFO - Display Serial Number: 1600x1200 60 09:34:17 INFO - Main Display: Yes 09:34:17 INFO - Mirror: Off 09:34:17 INFO - Online: Yes 09:34:17 INFO - Rotation: Supported 09:34:17 INFO - Return code: 0 09:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:17 INFO - Python 2.7.3 09:34:17 INFO - Return code: 0 09:34:17 INFO - grabbing minidump binary from tooltool 09:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:17 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 0x10c1b1d30>, '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 0x10c017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1a9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:17 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:34:17 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:34:17 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:34:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:17 INFO - Return code: 0 09:34:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:34:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:34:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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:34:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8oUrVizGbS/Render', 09:34:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:17 INFO - 'HOME': '/Users/cltbld', 09:34:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:17 INFO - 'LOGNAME': 'cltbld', 09:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:17 INFO - 'MOZ_NO_REMOTE': '1', 09:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:17 INFO - 'NO_EM_RESTART': '1', 09:34:17 INFO - 'PAGER': '/bin/cat', 09:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:17 INFO - 'PWD': '/builds/slave/test', 09:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:17 INFO - 'SHELL': '/bin/bash', 09:34:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iM88Sr9vOA/Listeners', 09:34:17 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 09:34:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:17 INFO - 'USER': 'cltbld', 09:34:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:17 INFO - 'XPC_FLAGS': '0x0', 09:34:17 INFO - 'XPC_SERVICE_NAME': '0', 09:34:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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:34:17 INFO - mozversion application_buildid: 20161218064735 09:34:17 INFO - mozversion application_changeset: 2f7c683f7d481c00b9f2664956c559235cdbb96a 09:34:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:34:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:17 INFO - mozversion application_name: Firefox 09:34:17 INFO - mozversion application_remotingname: firefox-dev 09:34:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:34:17 INFO - mozversion application_vendor: Mozilla 09:34:17 INFO - mozversion application_version: 52.0a2 09:34:17 INFO - mozversion platform_buildid: 20161218064735 09:34:17 INFO - mozversion platform_changeset: 2f7c683f7d481c00b9f2664956c559235cdbb96a 09:34:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:34:17 INFO - mozversion platform_version: 52.0a2 09:34:17 INFO - using testdate: 1482082457 09:34:17 INFO - actual date: 1482082457 09:34:17 INFO - starting webserver on 'localhost:55658' 09:34:17 INFO - SUITE-START | Running 2 tests 09:34:17 INFO - TEST-START | dromaeo_css 09:34:17 INFO - operating with platform_type : mac_ 09:34:17 INFO - Initialising browser for dromaeo_css test... 09:34:17 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpaaOCvT/profile http://localhost:55658/getInfo.html) 09:34:20 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 09:34:20 INFO - PROCESS | 1924 | colorDepth:24 09:34:20 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 09:34:20 INFO - PROCESS | 1924 | __metrics 09:34:20 INFO - PROCESS | 1924 | 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:34:20 INFO - PROCESS | 1924 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:21 INFO - TEST-INFO | 1924: exit 0 09:34:21 INFO - Browser initialized. 09:34:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:21 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpaaOCvT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:33 INFO - PROCESS | 1926 | RSS: Main: 222728192 09:34:33 INFO - PROCESS | 1926 | 09:35:24 INFO - PROCESS | 1926 | 1482082524374 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:37:39 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:55658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55658/tests/dromaeo/cssquery-ext.html) 09:37:41 INFO - PROCESS | 1926 | RSS: Main: 397467648 09:37:41 INFO - PROCESS | 1926 | 09:40:44 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:55658/tests/dromaeo/cssquery-ext.html (next: http://localhost:55658/tests/dromaeo/cssquery-jquery.html) 09:40:45 INFO - PROCESS | 1926 | RSS: Main: 348667904 09:40:45 INFO - PROCESS | 1926 | 09:43:47 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:55658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55658/tests/dromaeo/cssquery-mootools.html) 09:43:48 INFO - PROCESS | 1926 | RSS: Main: 315060224 09:43:48 INFO - PROCESS | 1926 | 09:46:50 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:55658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55658/tests/dromaeo/cssquery-prototype.html) 09:46:51 INFO - PROCESS | 1926 | RSS: Main: 325160960 09:46:51 INFO - PROCESS | 1926 | 09:49:54 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:55658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55658/tests/dromaeo/cssquery-yui.html) 09:49:54 INFO - PROCESS | 1926 | RSS: Main: 310300672 09:49:54 INFO - PROCESS | 1926 | 09:52:57 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:55658/tests/dromaeo/cssquery-yui.html (next: http://localhost:55658/tests/dromaeo/cssquery-dojo.html) 09:52:58 INFO - PROCESS | 1926 | RSS: Main: 498176000 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | __start_tp_report 09:52:58 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 09:52:58 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 09:52:58 INFO - PROCESS | 1926 | |i|pagename|runs| 09:52:58 INFO - PROCESS | 1926 | |0;dojo.html;3324.052644996175;3330.8501117449714;3337.7329813614915;3338.7329013678905;3375.746818988575;5666.716664166791;5715.914261286084;5737.397573254801;5746.252987111675;5778.971105144474;5648.378678345379;5733.397993210705;5735.1970724098655;5745.195672605839;5745.339285982113;5192.6624769390055;5204.531592156705;5221.008008478387;5241.711705856176;5262.2632831403635;4880.585150262232;5159.7678104485385;5307.867303317429;5311.49540793624;5343.412224655285;5161.329027226455;5252.52727254547;5252.921206181911;5254.159334506479;5263.657862238962;5236.3978142513715;5243.842684719464;5249.081410753141;5251.501107394792;5253.60597955153;5080.542751152377;5184.118699821001;5188;5195.428502864682;5224.059669259532;5752.712364381806;5755.625884317506;5755.9424405756245;5766.336871259817;5774.2782152230975;6105.10315090879;6125.327021303102;6127.556056270613;6128.789352163547;6138.431877890659;5453.918191227135;6237.532185086091;6250.187475628185;6257.967435373203;6259.78090766821;5707.857303567403;5768.769249230026;5783.681897495636;5789;5792.942070579283;6311.368863113697;6317.210348706411;6320.936790632127;6329;6330.588511746768;5360.785568577291;5854.326752423441;5981.730822113015;6118.877622447526;6124.295705993868;5490.780368785284;5900.1739756434135;6178.814635560941;6239.282482514478;6305.495560355161;6148.862460444832;6223.937760622426;6224.128621992924;6270.874582508415;6285.277193122849;6108.877822443526;6284.465820405226;6286.874262514815;6298.7480500780375;6303.905441418382;4198.727082739612;4855.247436647325;4867.172580661296;4867.3915760529935;4909.901801963941;4421;4422.137683151755;4426.579474949939;4434.002349471408;4456.64346852251;5806.88386232273;5809.506191973645;5828.12578113278;5833.649981001154;5857.7656893724625;6170.197874276315;6224.06639004153;6233.376662333821;6246.969250073687;6311.147995020613;5810.21562089121;5815.5929084963645;5819.709014549256;5827.24245848037;5876.118582212617;5370.194470829407;5387.003404370125;5397.487238712238;5400.972995135077;5402.486763757437;6265.373462653698;6277.591956522811;6328.841778955563;6334.33489483616;6351.587146835441;6241.3134555197985;6271.3415091414745;6304.653244071436;6355.745770169141;6356.491480681442;6306.432421082125;6316.6841657916;6318.988961766096;6328.968355158379;6339.302676705466;6109.694515274307;6213.1922850029205;6240.875182496234;6241.750329986749;6253.843653908689;4651.767411629473;6145.539084568586;6176.969115154396;6236.189295391751;6285.622862628257;6115.057807494094;6115.788007244199;6122.825106970096;6126.884121540644;6135.2326666699655;6082.695865206811;6127.708789263955;6132.38610285184;6155.692215389123;6162.722677479614;4905.362302900743;4905.730184839868;5836;5904.793332233351;5975.701214939322;6036.788712395045;6108.615274519966;6145.569810113249;6155.322914479493;6168.907466387918;5802.1296805479515;5833.533317334518;5839.503642190291;5964.433378829004;5988.341282458839 09:52:58 INFO - PROCESS | 1926 | |1;ext.html;451.97740112994353;461.06173936040165;470.3203870407261;524;559.9552035837133;22938.88530557347;37499;38610;38679.41980870289;40371.394429083586;32406.027819165403;39635;39771.80114099433;40029.19941601166;40064.39903401451;9134.406263592846;9221.492817895012;9300.720978370626;9319.673811416602;9334.113259240361;9148.451092934445;9266.675666351646;9288.7677808055;9325.207357374597;9338.813223735522;9278.536073196346;9313.441193528377;9315.953420232923;9338.813223735522;9347.719568412924;9253.259739220879;9330.066993300683;9333.06669333068;9345.532723363805;9377.531123443801;9184;9240.491772952484;9246.260299176118;9246.445213287225;9265.073492650748;37963.81018094919;38209.426858597144;38224;38294.23411531754;38467.42298865519;3172.714455698975;3330.117518857505;3334.549835772164;3442.0706409269606;3658.304922064826;27582.5862612061;28198.577021344696;28427.147185584465;28658;28957.917830075705;2719.9001871490955;3120.7035331643456;3139.309351942569;3152.8581213845205;3183.283761153722;483917;485853;490041;492038.53980730224;503425;55804;55913.7204313984;56216.718916405975;56269;56299;58807.70596146992;58879.116813247834;58890.11664825031;58940.41059589435;59135.40864591385;15550.45573404948;15699.215039247993;15730.764038539432;15731.528054158394;15761;12314.199577027464;12367.443465044094;12381.75236495265;12407.689807754878;12440.564580239829;13177.407016684272;14527.85472145265;15307.846921530865;15452.922735386475;15636.843631563766;6210.192674952317;6309.652969086653;6389.105525226472;6412.519061070345;6433.292337842833;837.9162083791572;934.3693007220099;1015.898410158993;1021.7905329407454;1053.4837929414532;25566.33818801772;29191.270218244288;30430;30525.38949221003;31064.844675776476;1022.0239671114068;1055.8521806947033;1079.1474734959452;1082.2532452607675;1095.4632230207142;14658.560243192722;14672.486462973959;14698;14907.254637268094;14962.925185374004;649229;657084;658044;658573;658600;51937.961240774974;52298.954020919366;52349.73825130926;52362.73818630959;52448.73775631098;1219.5426714981882;1223.4494477485168;1224.871388504212;1340.7787715027107;1378.689794796183;28125;29279.121626351243;29685;30098.097057088322;30361.24096897595;46676.53323466722;47228.05543889034;47250.29124563066;47265.81835454004;47343;545543;546890;547548;547780.2610987079;548096;24279.635805462578;24303.270901872973;25069.623955640316;25093.372665683502;25806.741932581186;36214.8189259052;43099.13801723885;43384.783076084415;43596.56403435925;44736.77631611821;35962.64037359593;36716.082097947765;36892.446613300286;36985;37476;35682.82158589191;36856.44715329219;37291.81354093212;37551.2489750198;37910;35106;35564.822175888956;36035;36321.091972700895;36353;30791.84604076965;30871.84564077165;32643.510347345284;32874.50688239726;32889.67110328866;23206.419839503473;23965.625883788533;24058.9173487197;24339.783010849034;24700.38249043788 09:52:58 INFO - PROCESS | 1926 | |2;jquery.html;342.277793854966;345.7268757681432;363.95450568678916;369.92971335446265;378.09069188601404;14640.633984150389;14971.47599834006;15378.077315361086;15931.522054338388;19711.5072123197;18682.626347473077;19157.616847663074;19740.407787766355;19881.602367952633;20107.89946050268;5548.639338442998;5850.063989761639;5860.208871802316;5862.472377486026;5868.911966320508;4620.445546534421;5695.903297346034;5746.597738158331;5785.132230165488;5836.649801011931;5775.855603609923;5789.102689083199;5793.855153621172;5795.217645617851;5807;5493.285872836505;5782.3350314713925;5788.392218817005;5835.795747148872;5880.059190529495;5476.561875049986;5692.260006199209;5703.743331550048;5706.514946229576;5707.400722924116;12685;13060.477580896753;13082.542111026163;13093.214407135602;13136.934315328457;1886.699117495742;2262.558801033799;2278.2481781012393;2344.179537161997;2871.344006793728;9858.556364963522;10240.48797560119;10270.89729102707;12798;14100.435982560686;1769.9469015929415;1828.9451316460527;1858.7026075827937;1860.7953125156223;1879.6522643311032;91291.54354228187;124938.12592811116;126962;132062;132146;11276.830847537294;11511.424428778528;11604.187706860608;11658.300501969909;11795.41022948849;14470.927645361706;14471.710565788626;14502.202378869264;14505.492307769178;14539.127652340894;8109.391795615353;8343.499390036495;8373.790655233546;8454.1123182065;8519.318454523624;8251.257386835094;8258.298044666271;8263.710770123138;8434.198751118756;8462.449940753831;4344.847930322424;4418.6023257906945;4424.933625995613;4498.797554110073;4517;1636.6890290844701;1698.6347935193992;1820.2900868661234;1824.5529845187748;1904.1431355889904;776.6486313814036;878.3280790195505;925.8981512033671;955.81361634482;965.1844191658038;18806.341778037702;19719.309824156087;20201.191952321744;20333.983300834898;20524.281650142173;783.7139444102861;887.9378443509022;901.3465237702613;962.6101428921298;970.8834939807268;10260.846087308697;10444.21668374875;10658.200634952409;10693.465326733633;10723;602714;606633;611039;620878;624027;87870;126686;127504;133535.25660249044;139379;947.7109481608176;949.8860136783492;975.4732444480044;982.1749730226501;985.6747273399761;18229.179686914387;18764.906175469034;19074.713879291543;19143.23427062902;19443;44022.33966490441;53713.65715857135;54602.453975459735;55493.7225313887;56203;64554.354456454836;75121.49757004938;76496;82892.58553707434;86955;7690.615469226628;7932.524048557105;8030.759077227693;8057.274845263954;8064.919350806417;11755.941220293844;12245.081618878798;12418.689532761753;12420.130590858553;12686.809697854354;10689;10753.13974881992;10986.450677465935;11114.555417783198;11206.935341142578;10612.681619551426;10661.466926653482;10803.081738052353;10950.616728414467;11056.723581910517;10609.416482093251;10676.412797296223;11079.778404431705;11334.716632083933;11526.07791376671;7935;7936.841263174589;7958.801029974297;8145.348372130097;8211;10512.160371934728;10646.467676616294;10734.570617175537;10745.516451759846;10922 09:52:58 INFO - PROCESS | 1926 | |3;mootools.html;1431.1413152108737;1469.522405218304;1597.6485173261885;1779.057099737138;1805.7020591602386;7892.131865494798;8288.37837162213;8289.295409890166;8307.460015099014;8308.086110527836;7280.854382912338;7581.734639287626;7607.23927607239;7621.275978782007;8090.0291964964135;2066.813986741193;2100.2334148035934;2104.1267873832417;2181.1166477576608;2279.954400911981;2309.4341886237894;2326.336993956723;2326.9650955235684;2327.5461285049423;2333.2183718454253;2250.381145185079;2281.53228588139;2284.3946354216146;2299.666548350488;2307.1117619716447;1995.9401217963484;2077.8129968302774;2081.5108449514505;2204.1183526589493;2273.7385200701883;2308.607536718762;2314.166899916029;2317.073170731704;2318.5594737000083;2319.5476882008015;8267.586620669003;8273.8345233095;8285.42002059856;8288.088310285864;8291.419600627958;4954.925676114861;5111.335526381584;5119.129747942859;5124.385073791132;5126.641135120543;3114.2837147455984;3215.9839200803845;3353.5808023997;3409.301093275897;3441.82790860456;964.8697425847491;1044.7931498082528;1073.0557109743454;1073.8926107389277;1078.5470102556944;10491.160707143486;10673.733156671067;10677.893221067767;10684.465776711133;10688;4481.75350355727;4500.842470513517;4670.229412147026;4736.905261894743;4756.833510827105;8501.319894408556;8593.52735599548;8606.967163940368;8613.741587752378;8614.396992210484;5040.143175660147;5059.822906198266;5063.012712521023;5063.569596584258;5065.493450654905;4514.210013247669;4661.650376221797;4716.29255611661;4744.620430365562;4766.142094423037;3194.984025079906;3244.951325730116;3444.50054742061;3512.5784905810956;3546.4680297954997;1015.5633077776627;1029.934018291065;1103.332483847277;1106.8505751723576;1114.9275297105662;779.6395290218605;787.9172686867911;887.2901678657178;897.2373482539789;912.466207268742;5114.4629813869005;5154.690718556899;5158.793648254103;5537.667739935617;5568.387477377485;421.3826743820318;437.09957487575696;444.220393209921;450.4324551065615;457.40994117588605;3566.179778650873;3599.6580324869096;3623.202895363016;3674.926501469956;3756.718246131551;9588.232941364675;9918.30571859963;9943.651972180938;10154.644587439405;10157.542910569042;8364.916350836414;10043.347182433265;10074.899251007542;10128.03783640553;10171.64399246023;7636.694532218649;7694.576798276036;7702.499337543042;7833.882491762628;7845.764627061198;5060.190369541003;5231.215317702375;5280.155175171954;5297.920531191958;5370.043745578116;9203.309751768511;9215.44707317563;9260.073992600686;9269.44383337002;9415.15263626277;9307.488088154945;9382;9415.57629906642;9452;9519.428834269966;6419.197600299963;6488.935110648833;6503.772367967098;6526.477881769352;6536.281009089092;7308.8538229234055;7321.267873212636;7597.582132982739;7669.34810541088;7673.194314596887;6980.546264492792;7023.508354415142;7025.859482810213;7046.154461464657;7092.9645351772915;6473;6645.6677166140535;6788.66056697173;6915.792526224222;6945.722171113099;6301.054841773771;6419.454346380423;6474.805755827333;6482.319356467503;6488.318726533646;4529.275315949432;4632.837850675211;4652.511486293891;4732.716037037789;4755.358026666356;4187.183499217624;4620.953790462187;4661.603763679989;4713.552212539803;4878 09:52:58 INFO - PROCESS | 1926 | |4;prototype.html;277.91940337302185;295.1190695773117;298.52534470192376;304.963404391473;310.4597999480902;4980.377452818398;5070.214116811891;5083.745812709363;5085.677723791822;5117.398555862942;4531.297648864432;4771.618270538357;4799.60019990005;5002.5247601477895;5214.1582837353635;3971.9205615887663;3988.421678856564;4017.3572228443454;4022;4051.2910240707906;3323.7673362864607;3458.308338332331;3919.8044596398086;3951.530293566521;4035.838566457353;3565.8038807865555;3854.8265328060165;3953.7627742335408;3974.2448934702456;3981.7810020448865;3568.660977207161;3629.1290090378384;3717.9218026772205;3758.32350176968;3973.2450834341385;2762.881033181565;3468.843902024415;3493.5283736695474;3500.457429098494;3501.19472521319;4810;4982.676126051795;5071.906137256271;5075.959428317186;5096.847094587169;3799.5060642116623;3944.5660977292764;4042.4946881639794;4280.190630339001;4499.797509112065;4901.730404827733;5032.6980381177245;5211.869703257411;5228.7581699346265;5417.507946344686;3238.886638967648;3535.5403797506415;3772.924541509182;3777.452269420946;3798.8860334190017;5703.060959273826;5706.944215320179;5707.885842283131;5710.114932185518;5728.79949201776;3122.35991621717;3876.3604005339366;3879.9436298761702;3895.941560876589;3897.376419772823;3055.976247956915;3643.560793486558;3805.219929914361;3931.567527571965;3964.801759911993;3747.8126093695205;4090.8341122779866;4470.658802359279;4491.438570178728;4581.335706322565;4312.69811113219;5069.8732531687;5391.51476367121;5470.452954704498;5483.243977875169;1119.8264269038311;1162.3200427749691;1248.6764030128093;1284.9036322275867;1286.3182513267982;793.8372633610096;859.8864470510704;895.8253140637644;897.546738896853;904.6562306323686;4179.937300940488;4680.485146633868;4871.3193948088565;4873.853784386474;4933.309336692866;4689.343491911135;4765.880852978634;5279.577633789365;5341.023821186186;5359.892802144013;3843.789820852965;4787.247332783593;4837.516248375135;4856.902861942742;4864.635152363516;2506.15797388919;2581.354112035179;2783.3439103733244;2786.3312804926672;2788.316862368692;4752.857414277577;4949;4951.3810773653295;5249.343832020997;5578.972105139448;4451.888702782457;4492.348609451611;4828.07901219764;5209;5368.651037682616;4806.49531799156;5238.947610523922;5467.797084641373;5471.2887324647545;5489.917651235235;4714.882127946828;5284.656497327662;5302.893942121059;5307.761150748149;5319.707416092152;4805.839299443874;5018.573421259088;5211.843644690665;5231.529162375252;5328.547073498796;4478.910421791611;4874.561289483963;5491.28613280271;5501.3948465667945;5506.33923929115;3025.667176610615;3643.708503319781;3670.5778835434267;3682.974364099788;3685.981570092132;5238.030964271622;5294.12646913255;5300.70846103468;5606.439356064361;5714.457126572969;5233;5516.862078448071;5549.195366671891;5556.972215138899;5568.55451563882;4520.954790452185;5521.282233309644;5552.723383412781;5579.860503487283;5582.27430434041;4853.6359773017875;5053.69677819332;5173.560247378864;5383.865403364791;5386.245925570502;4730.351003437948;4857.963772642099;5552.972235138798;5553.722313884209;5604.467575580314;5104.336436263262;5387.353517577916;5401.972990135024;5412.350517937873;5424.663831743528 09:52:58 INFO - PROCESS | 1926 | |5;yui.html;690.5821977703489;746.4177941205861;759.1800855076518;774.6281784743327;811.1482942909943;13811.58565243043;14062.859371406283;14394;14529;14538.27308634568;13008.544700935445;13058.477660893577;13171.604851854436;13183.143095698773;13216.53742119026;796.6693822063836;811.8741595052746;811.8903947967008;812.3217113710059;814.3281792521194;638.0620487882804;659.9142111525495;662.2880403566186;783.3733013589106;804.2038382001805;857.0443954990203;858.433433933604;862.1163307609719;862.1464749897588;862.3230763850379;853.2235665544325;854.6154230596226;855.0124606079987;856.0412338181246;856.3876828067899;498.9716801203134;510.9361329833771;605.4671888737927;625.6683957502531;627.6798832595364;13921.373538190806;13944.093633913762;13950.581482555539;13961.86038139626;13986.93006534971;12926.806097908539;13029.283389413578;13236.272005039718;13338.866611333859;13393.06248562601;11358.26171298863;11892.940535297268;11964.940175299154;11969.222000569935;12355.752884942342;4321.567843215685;4367.213901497729;4478.126765280772;4495.483019452772;4503.932441013388;88044.55977720134;88952.55523722405;89778;90101.54949225277;94357.5282123585;10319.94840025795;10448.68653940383;10485.318454300446;10503.737406564896;10663.093637040784;19812.801871981384;19934;19947.60104797896;19967;20028.198872045246;7179.174394944648;7381.520201186906;7461.030066091374;7563.243675632392;7567.470277080552;4073.1446396256524;4131.132462182915;4133.6693064554765;4181.707280490397;4269.701120921506;3167.572377729023;3266.7223286020953;3273.4598791199187;3278.0493656839726;3283.1792051987004;562.8058319879635;592.3395414113319;608.8995315772847;609.9451049405575;610.3408319015452;516.2545730723576;552.2296396526823;586.2086183652036;591.0867709389005;608.9025755879038;6957.469356741509;7074.575525468385;8677.132286771399;8702.521361325062;8747.737567872973;520.3261776000013;560.5683623609879;604.7369394313399;615.1940957345892;629.222909706512;3969.325214713506;4046.838126474967;4050.9392359114636;4177.91644167121;4371.901487286057;72706.63646681733;100199.99600007958;111308;114426;120269;84463.88840278919;91762;95390.8456865724;96661.5500767489;101620;78517.60741196372;82868;86786.56606716926;90156.19687606342;93022;8975;9314.860277095713;9504.95247523758;9581.904180958101;9599.712008639752;42005.36991945062;51851.481485186174;52500;53103.203451949026;53842.269919215;65867;69877;70607;70805;73009;12221.14451988388;12234;12247.265164090182;12308.199967002116;12601;11495.482703278205;12282.140250182401;12465.750684986431;13606.523771667944;14313.212773297151;12662.430190641628;12803.295818729686;12866.421011054337;12886.420111094836;12955.352232388532;12583.05627077991;12846.743065138831;12859.678508037374;13125.081244312807;13672.93163534176;12073.215241009306;12245.448954797233;12848.100632955604;12919.095663303855;13192.67018324511;10321.896781032094;10360.844587331045;10929.672109836718;11037.448127593749;11228.214025018497;10271.332363396356;10630.468476575985;11030.172737044593;11228.157888158585;11238 09:52:58 INFO - PROCESS | 1926 | __end_tp_report 09:52:58 INFO - PROCESS | 1926 | __start_cc_report 09:52:58 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,2054 09:52:58 INFO - PROCESS | 1926 | __end_cc_report 09:52:58 INFO - PROCESS | 1926 | __startTimestamp1482083578171__endTimestamp 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | ------- Summary: start ------- 09:52:58 INFO - PROCESS | 1926 | Number of tests: 6 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | [#0] dojo.html Cycles:165 Average:5715.73 Median:5839.50 stddev:658.52 (11.3%) stddev-sans-first:633.24 09:52:58 INFO - PROCESS | 1926 | Values: 3324.1 3330.9 3337.7 3338.7 3375.7 5666.7 5715.9 5737.4 5746.3 5779.0 5648.4 5733.4 5735.2 5745.2 5745.3 5192.7 5204.5 5221.0 5241.7 5262.3 4880.6 5159.8 5307.9 5311.5 5343.4 5161.3 5252.5 5252.9 5254.2 5263.7 5236.4 5243.8 5249.1 5251.5 5253.6 5080.5 5184.1 5188.0 5195.4 5224.1 5752.7 5755.6 5755.9 5766.3 5774.3 6105.1 6125.3 6127.6 6128.8 6138.4 5453.9 6237.5 6250.2 6258.0 6259.8 5707.9 5768.8 5783.7 5789.0 5792.9 6311.4 6317.2 6320.9 6329.0 6330.6 5360.8 5854.3 5981.7 6118.9 6124.3 5490.8 5900.2 6178.8 6239.3 6305.5 6148.9 6223.9 6224.1 6270.9 6285.3 6108.9 6284.5 6286.9 6298.7 6303.9 4198.7 4855.2 4867.2 4867.4 4909.9 4421.0 4422.1 4426.6 4434.0 4456.6 5806.9 5809.5 5828.1 5833.6 5857.8 6170.2 6224.1 6233.4 6247.0 6311.1 5810.2 5815.6 5819.7 5827.2 5876.1 5370.2 5387.0 5397.5 5401.0 5402.5 6265.4 6277.6 6328.8 6334.3 6351.6 6241.3 6271.3 6304.7 6355.7 6356.5 6306.4 6316.7 6319.0 6329.0 6339.3 6109.7 6213.2 6240.9 6241.8 6253.8 4651.8 6145.5 6177.0 6236.2 6285.6 6115.1 6115.8 6122.8 6126.9 6135.2 6082.7 6127.7 6132.4 6155.7 6162.7 4905.4 4905.7 5836.0 5904.8 5975.7 6036.8 6108.6 6145.6 6155.3 6168.9 5802.1 5833.5 5839.5 5964.4 5988.3 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | [#1] ext.html Cycles:180 Average:68391.49 Median:37730.62 stddev:152326.70 (403.7%) stddev-sans-first:152668.61 09:52:58 INFO - PROCESS | 1926 | Values: 452.0 461.1 470.3 524.0 560.0 22938.9 37499.0 38610.0 38679.4 40371.4 32406.0 39635.0 39771.8 40029.2 40064.4 9134.4 9221.5 9300.7 9319.7 9334.1 9148.5 9266.7 9288.8 9325.2 9338.8 9278.5 9313.4 9316.0 9338.8 9347.7 9253.3 9330.1 9333.1 9345.5 9377.5 9184.0 9240.5 9246.3 9246.4 9265.1 37963.8 38209.4 38224.0 38294.2 38467.4 3172.7 3330.1 3334.5 3442.1 3658.3 27582.6 28198.6 28427.1 28658.0 28957.9 2719.9 3120.7 3139.3 3152.9 3183.3 483917.0 485853.0 490041.0 492038.5 503425.0 55804.0 55913.7 56216.7 56269.0 56299.0 58807.7 58879.1 58890.1 58940.4 59135.4 15550.5 15699.2 15730.8 15731.5 15761.0 12314.2 12367.4 12381.8 12407.7 12440.6 13177.4 14527.9 15307.8 15452.9 15636.8 6210.2 6309.7 6389.1 6412.5 6433.3 837.9 934.4 1015.9 1021.8 1053.5 25566.3 29191.3 30430.0 30525.4 31064.8 1022.0 1055.9 1079.1 1082.3 1095.5 14658.6 14672.5 14698.0 14907.3 14962.9 649229.0 657084.0 658044.0 658573.0 658600.0 51938.0 52299.0 52349.7 52362.7 52448.7 1219.5 1223.4 1224.9 1340.8 1378.7 28125.0 29279.1 29685.0 30098.1 30361.2 46676.5 47228.1 47250.3 47265.8 47343.0 545543.0 546890.0 547548.0 547780.3 548096.0 24279.6 24303.3 25069.6 25093.4 25806.7 36214.8 43099.1 43384.8 43596.6 44736.8 35962.6 36716.1 36892.4 36985.0 37476.0 35682.8 36856.4 37291.8 37551.2 37910.0 35106.0 35564.8 36035.0 36321.1 36353.0 30791.8 30871.8 32643.5 32874.5 32889.7 23206.4 23965.6 24058.9 24339.8 24700.4 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | [#2] jquery.html Cycles:180 Average:34824.82 Median:2607.76 stddev:102316.02 (3923.5%) stddev-sans-first:102570.29 09:52:58 INFO - PROCESS | 1926 | Values: 342.3 345.7 364.0 369.9 378.1 14640.6 14971.5 15378.1 15931.5 19711.5 18682.6 19157.6 19740.4 19881.6 20107.9 5548.6 5850.1 5860.2 5862.5 5868.9 4620.4 5695.9 5746.6 5785.1 5836.6 5775.9 5789.1 5793.9 5795.2 5807.0 5493.3 5782.3 5788.4 5835.8 5880.1 5476.6 5692.3 5703.7 5706.5 5707.4 12685.0 13060.5 13082.5 13093.2 13136.9 1886.7 2262.6 2278.2 2344.2 2871.3 9858.6 10240.5 10270.9 12798.0 14100.4 1769.9 1828.9 1858.7 1860.8 1879.7 91291.5 124938.1 126962.0 132062.0 132146.0 11276.8 11511.4 11604.2 11658.3 11795.4 14470.9 14471.7 14502.2 14505.5 14539.1 8109.4 8343.5 8373.8 8454.1 8519.3 8251.3 8258.3 8263.7 8434.2 8462.4 4344.8 4418.6 4424.9 4498.8 4517.0 1636.7 1698.6 1820.3 1824.6 1904.1 776.6 878.3 925.9 955.8 965.2 18806.3 19719.3 20201.2 20334.0 20524.3 783.7 887.9 901.3 962.6 970.9 10260.8 10444.2 10658.2 10693.5 10723.0 602714.0 606633.0 611039.0 620878.0 624027.0 87870.0 126686.0 127504.0 133535.3 139379.0 947.7 949.9 975.5 982.2 985.7 18229.2 18764.9 19074.7 19143.2 19443.0 44022.3 53713.7 54602.5 55493.7 56203.0 64554.4 75121.5 76496.0 82892.6 86955.0 7690.6 7932.5 8030.8 8057.3 8064.9 11755.9 12245.1 12418.7 12420.1 12686.8 10689.0 10753.1 10986.5 11114.6 11206.9 10612.7 10661.5 10803.1 10950.6 11056.7 10609.4 10676.4 11079.8 11334.7 11526.1 7935.0 7936.8 7958.8 8145.3 8211.0 10512.2 10646.5 10734.6 10745.5 10922.0 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | [#3] mootools.html Cycles:180 Average:5266.30 Median:4997.53 stddev:2932.99 (58.7%) stddev-sans-first:2927.06 09:52:58 INFO - PROCESS | 1926 | Values: 1431.1 1469.5 1597.6 1779.1 1805.7 7892.1 8288.4 8289.3 8307.5 8308.1 7280.9 7581.7 7607.2 7621.3 8090.0 2066.8 2100.2 2104.1 2181.1 2280.0 2309.4 2326.3 2327.0 2327.5 2333.2 2250.4 2281.5 2284.4 2299.7 2307.1 1995.9 2077.8 2081.5 2204.1 2273.7 2308.6 2314.2 2317.1 2318.6 2319.5 8267.6 8273.8 8285.4 8288.1 8291.4 4954.9 5111.3 5119.1 5124.4 5126.6 3114.3 3216.0 3353.6 3409.3 3441.8 964.9 1044.8 1073.1 1073.9 1078.5 10491.2 10673.7 10677.9 10684.5 10688.0 4481.8 4500.8 4670.2 4736.9 4756.8 8501.3 8593.5 8607.0 8613.7 8614.4 5040.1 5059.8 5063.0 5063.6 5065.5 4514.2 4661.7 4716.3 4744.6 4766.1 3195.0 3245.0 3444.5 3512.6 3546.5 1015.6 1029.9 1103.3 1106.9 1114.9 779.6 787.9 887.3 897.2 912.5 5114.5 5154.7 5158.8 5537.7 5568.4 421.4 437.1 444.2 450.4 457.4 3566.2 3599.7 3623.2 3674.9 3756.7 9588.2 9918.3 9943.7 10154.6 10157.5 8364.9 10043.3 10074.9 10128.0 10171.6 7636.7 7694.6 7702.5 7833.9 7845.8 5060.2 5231.2 5280.2 5297.9 5370.0 9203.3 9215.4 9260.1 9269.4 9415.2 9307.5 9382.0 9415.6 9452.0 9519.4 6419.2 6488.9 6503.8 6526.5 6536.3 7308.9 7321.3 7597.6 7669.3 7673.2 6980.5 7023.5 7025.9 7046.2 7093.0 6473.0 6645.7 6788.7 6915.8 6945.7 6301.1 6419.5 6474.8 6482.3 6488.3 4529.3 4632.8 4652.5 4732.7 4755.4 4187.2 4621.0 4661.6 4713.6 4878.0 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | [#4] prototype.html Cycles:180 Average:4302.90 Median:4832.80 stddev:1318.60 (27.3%) stddev-sans-first:1287.23 09:52:58 INFO - PROCESS | 1926 | Values: 277.9 295.1 298.5 305.0 310.5 4980.4 5070.2 5083.7 5085.7 5117.4 4531.3 4771.6 4799.6 5002.5 5214.2 3971.9 3988.4 4017.4 4022.0 4051.3 3323.8 3458.3 3919.8 3951.5 4035.8 3565.8 3854.8 3953.8 3974.2 3981.8 3568.7 3629.1 3717.9 3758.3 3973.2 2762.9 3468.8 3493.5 3500.5 3501.2 4810.0 4982.7 5071.9 5076.0 5096.8 3799.5 3944.6 4042.5 4280.2 4499.8 4901.7 5032.7 5211.9 5228.8 5417.5 3238.9 3535.5 3772.9 3777.5 3798.9 5703.1 5706.9 5707.9 5710.1 5728.8 3122.4 3876.4 3879.9 3895.9 3897.4 3056.0 3643.6 3805.2 3931.6 3964.8 3747.8 4090.8 4470.7 4491.4 4581.3 4312.7 5069.9 5391.5 5470.5 5483.2 1119.8 1162.3 1248.7 1284.9 1286.3 793.8 859.9 895.8 897.5 904.7 4179.9 4680.5 4871.3 4873.9 4933.3 4689.3 4765.9 5279.6 5341.0 5359.9 3843.8 4787.2 4837.5 4856.9 4864.6 2506.2 2581.4 2783.3 2786.3 2788.3 4752.9 4949.0 4951.4 5249.3 5579.0 4451.9 4492.3 4828.1 5209.0 5368.7 4806.5 5238.9 5467.8 5471.3 5489.9 4714.9 5284.7 5302.9 5307.8 5319.7 4805.8 5018.6 5211.8 5231.5 5328.5 4478.9 4874.6 5491.3 5501.4 5506.3 3025.7 3643.7 3670.6 3683.0 3686.0 5238.0 5294.1 5300.7 5606.4 5714.5 5233.0 5516.9 5549.2 5557.0 5568.6 4521.0 5521.3 5552.7 5579.9 5582.3 4853.6 5053.7 5173.6 5383.9 5386.2 4730.4 4858.0 5553.0 5553.7 5604.5 5104.3 5387.4 5402.0 5412.4 5424.7 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - PROCESS | 1926 | [#5] yui.html Cycles:180 Average:20119.37 Median:4344.39 stddev:29511.79 (679.3%) stddev-sans-first:29558.52 09:52:58 INFO - PROCESS | 1926 | Values: 690.6 746.4 759.2 774.6 811.1 13811.6 14062.9 14394.0 14529.0 14538.3 13008.5 13058.5 13171.6 13183.1 13216.5 796.7 811.9 811.9 812.3 814.3 638.1 659.9 662.3 783.4 804.2 857.0 858.4 862.1 862.1 862.3 853.2 854.6 855.0 856.0 856.4 499.0 510.9 605.5 625.7 627.7 13921.4 13944.1 13950.6 13961.9 13986.9 12926.8 13029.3 13236.3 13338.9 13393.1 11358.3 11892.9 11964.9 11969.2 12355.8 4321.6 4367.2 4478.1 4495.5 4503.9 88044.6 88952.6 89778.0 90101.5 94357.5 10319.9 10448.7 10485.3 10503.7 10663.1 19812.8 19934.0 19947.6 19967.0 20028.2 7179.2 7381.5 7461.0 7563.2 7567.5 4073.1 4131.1 4133.7 4181.7 4269.7 3167.6 3266.7 3273.5 3278.0 3283.2 562.8 592.3 608.9 609.9 610.3 516.3 552.2 586.2 591.1 608.9 6957.5 7074.6 8677.1 8702.5 8747.7 520.3 560.6 604.7 615.2 629.2 3969.3 4046.8 4050.9 4177.9 4371.9 72706.6 100200.0 111308.0 114426.0 120269.0 84463.9 91762.0 95390.8 96661.6 101620.0 78517.6 82868.0 86786.6 90156.2 93022.0 8975.0 9314.9 9505.0 9581.9 9599.7 42005.4 51851.5 52500.0 53103.2 53842.3 65867.0 69877.0 70607.0 70805.0 73009.0 12221.1 12234.0 12247.3 12308.2 12601.0 11495.5 12282.1 12465.8 13606.5 14313.2 12662.4 12803.3 12866.4 12886.4 12955.4 12583.1 12846.7 12859.7 13125.1 13672.9 12073.2 12245.4 12848.1 12919.1 13192.7 10321.9 10360.8 10929.7 11037.4 11228.2 10271.3 10630.5 11030.2 11228.2 11238.0 09:52:58 INFO - PROCESS | 1926 | -------- Summary: end -------- 09:52:58 INFO - PROCESS | 1926 | 09:52:58 INFO - TEST-INFO | 1926: exit 0 09:52:58 INFO - TEST-OK | dromaeo_css | took 1120989ms 09:52:58 INFO - TEST-START | kraken 09:52:58 INFO - operating with platform_type : mac_ 09:52:58 INFO - Initialising browser for kraken test... 09:52:58 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpPf3Tmy/profile http://localhost:55658/getInfo.html) 09:53:01 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 09:53:01 INFO - PROCESS | 1930 | colorDepth:24 09:53:01 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 09:53:01 INFO - PROCESS | 1930 | __metrics 09:53:01 INFO - PROCESS | 1930 | 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:53:01 INFO - PROCESS | 1930 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:02 INFO - TEST-INFO | 1930: exit 0 09:53:02 INFO - Browser initialized. 09:53:02 INFO - Running cycle 1/1 for kraken test... 09:53:02 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpPf3Tmy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:14 INFO - PROCESS | 1931 | RSS: Main: 222957568 09:53:14 INFO - PROCESS | 1931 | 09:53:17 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55658/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:18 INFO - PROCESS | 1931 | RSS: Main: 271994880 09:53:18 INFO - PROCESS | 1931 | 09:53:21 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55658/tests/kraken/driver.html?testName=audio-dft) 09:53:21 INFO - PROCESS | 1931 | RSS: Main: 286289920 09:53:21 INFO - PROCESS | 1931 | 09:53:24 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55658/tests/kraken/driver.html?testName=audio-fft) 09:53:25 INFO - PROCESS | 1931 | RSS: Main: 381734912 09:53:25 INFO - PROCESS | 1931 | 09:53:27 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55658/tests/kraken/driver.html?testName=audio-oscillator) 09:53:28 INFO - PROCESS | 1931 | RSS: Main: 284905472 09:53:28 INFO - PROCESS | 1931 | 09:53:30 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:30 INFO - PROCESS | 1931 | RSS: Main: 286105600 09:53:30 INFO - PROCESS | 1931 | 09:53:33 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55658/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:34 INFO - PROCESS | 1931 | RSS: Main: 326987776 09:53:34 INFO - PROCESS | 1931 | 09:53:37 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55658/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:38 INFO - PROCESS | 1931 | RSS: Main: 328622080 09:53:38 INFO - PROCESS | 1931 | 09:53:40 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55658/tests/kraken/driver.html?testName=json-parse-financial) 09:53:41 INFO - PROCESS | 1931 | RSS: Main: 322981888 09:53:41 INFO - PROCESS | 1931 | 09:53:42 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:43 INFO - PROCESS | 1931 | RSS: Main: 299520000 09:53:43 INFO - PROCESS | 1931 | 09:53:45 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:46 INFO - PROCESS | 1931 | RSS: Main: 303632384 09:53:46 INFO - PROCESS | 1931 | 09:53:48 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:48 INFO - PROCESS | 1931 | RSS: Main: 305840128 09:53:48 INFO - PROCESS | 1931 | 09:53:51 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:52 INFO - PROCESS | 1931 | RSS: Main: 314052608 09:53:52 INFO - PROCESS | 1931 | 09:53:55 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:56 INFO - PROCESS | 1931 | RSS: Main: 314064896 09:53:56 INFO - PROCESS | 1931 | 09:53:57 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:55658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55658/tests/kraken/driver.html?testName=ai-astar) 09:53:58 INFO - PROCESS | 1931 | RSS: Main: 358133760 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | __start_tp_report 09:53:58 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 09:53:58 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 09:53:58 INFO - PROCESS | 1931 | |i|pagename|runs| 09:53:58 INFO - PROCESS | 1931 | |0;ai-astar;115;162;117;116;116;116;115;116;116;116 09:53:58 INFO - PROCESS | 1931 | |1;audio-beat-detection;155;100;130;178;140;139;110;109;143;114 09:53:58 INFO - PROCESS | 1931 | |2;audio-dft;184;182;184;185;185;182;184;186;185;184 09:53:58 INFO - PROCESS | 1931 | |3;audio-fft;81;59;60;91;62;62;60;60;83;60 09:53:58 INFO - PROCESS | 1931 | |4;audio-oscillator;91;73;96;70;69;70;90;92;98;127 09:53:58 INFO - PROCESS | 1931 | |5;imaging-gaussian-blur;88;84;105;86;88;129;132;85;87;86 09:53:58 INFO - PROCESS | 1931 | |6;imaging-darkroom;96;95;96;95;102;95;94;160;95;96 09:53:58 INFO - PROCESS | 1931 | |7;imaging-desaturate;83;81;82;80;79;78;84;84;81;84 09:53:58 INFO - PROCESS | 1931 | |8;json-parse-financial;55;54;53;53;57;59;58;57;57;58 09:53:58 INFO - PROCESS | 1931 | |9;json-stringify-tinderbox;67;73;72;76;74;72;70;74;71;73 09:53:58 INFO - PROCESS | 1931 | |10;stanford-crypto-aes;84;84;83;85;85;83;83;83;82;84 09:53:58 INFO - PROCESS | 1931 | |11;stanford-crypto-ccm;141;142;143;140;138;143;141;145;186;145 09:53:58 INFO - PROCESS | 1931 | |12;stanford-crypto-pbkdf2;212;191;164;167;166;167;166;167;166;167 09:53:58 INFO - PROCESS | 1931 | |13;stanford-crypto-sha256-iterative;69;68;68;68;68;68;65;67;67;67 09:53:58 INFO - PROCESS | 1931 | __end_tp_report 09:53:58 INFO - PROCESS | 1931 | __start_cc_report 09:53:58 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,2013 09:53:58 INFO - PROCESS | 1931 | __end_cc_report 09:53:58 INFO - PROCESS | 1931 | __startTimestamp1482083638114__endTimestamp 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | ------- Summary: start ------- 09:53:58 INFO - PROCESS | 1931 | Number of tests: 14 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#0] ai-astar Cycles:10 Average:120.50 Median:116.00 stddev:14.59 (12.6%) stddev-sans-first:15.34 09:53:58 INFO - PROCESS | 1931 | Values: 115.0 162.0 117.0 116.0 116.0 116.0 115.0 116.0 116.0 116.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:139.50 stddev:24.14 (17.3%) stddev-sans-first:24.10 09:53:58 INFO - PROCESS | 1931 | Values: 155.0 100.0 130.0 178.0 140.0 139.0 110.0 109.0 143.0 114.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.29 (0.7%) stddev-sans-first:1.36 09:53:58 INFO - PROCESS | 1931 | Values: 184.0 182.0 184.0 185.0 185.0 182.0 184.0 186.0 185.0 184.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#3] audio-fft Cycles:10 Average:67.80 Median:62.00 stddev:12.16 (19.6%) stddev-sans-first:11.93 09:53:58 INFO - PROCESS | 1931 | Values: 81.0 59.0 60.0 91.0 62.0 62.0 60.0 60.0 83.0 60.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:90.50 stddev:18.09 (20.0%) stddev-sans-first:19.15 09:53:58 INFO - PROCESS | 1931 | Values: 91.0 73.0 96.0 70.0 69.0 70.0 90.0 92.0 98.0 127.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:86.00 stddev:18.65 (21.7%) stddev-sans-first:19.49 09:53:58 INFO - PROCESS | 1931 | Values: 88.0 84.0 105.0 86.0 88.0 129.0 132.0 85.0 87.0 86.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:95.00 stddev:20.36 (21.4%) stddev-sans-first:21.46 09:53:58 INFO - PROCESS | 1931 | Values: 96.0 95.0 96.0 95.0 102.0 95.0 94.0 160.0 95.0 96.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:82.50 stddev:2.17 (2.6%) stddev-sans-first:2.24 09:53:58 INFO - PROCESS | 1931 | Values: 83.0 81.0 82.0 80.0 79.0 78.0 84.0 84.0 81.0 84.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:2.18 (3.8%) stddev-sans-first:2.28 09:53:58 INFO - PROCESS | 1931 | Values: 55.0 54.0 53.0 53.0 57.0 59.0 58.0 57.0 57.0 58.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:73.00 stddev:2.49 (3.4%) stddev-sans-first:1.79 09:53:58 INFO - PROCESS | 1931 | Values: 67.0 73.0 72.0 76.0 74.0 72.0 70.0 74.0 71.0 73.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 09:53:58 INFO - PROCESS | 1931 | Values: 84.0 84.0 83.0 85.0 85.0 83.0 83.0 83.0 82.0 84.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:143.00 stddev:14.08 (9.8%) stddev-sans-first:14.80 09:53:58 INFO - PROCESS | 1931 | Values: 141.0 142.0 143.0 140.0 138.0 143.0 141.0 145.0 186.0 145.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:167.00 stddev:15.69 (9.4%) stddev-sans-first:8.31 09:53:58 INFO - PROCESS | 1931 | Values: 212.0 191.0 164.0 167.0 166.0 167.0 166.0 167.0 166.0 167.0 09:53:58 INFO - PROCESS | 1931 | 09:53:58 INFO - PROCESS | 1931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 09:53:58 INFO - PROCESS | 1931 | Values: 69.0 68.0 68.0 68.0 68.0 68.0 65.0 67.0 67.0 67.0 09:53:58 INFO - PROCESS | 1931 | -------- Summary: end -------- 09:53:58 INFO - PROCESS | 1931 | 09:53:59 INFO - TEST-INFO | 1931: exit 0 09:53:59 INFO - TEST-OK | kraken | took 60351ms 09:53:59 INFO - SUITE-END | took 1181s 09:53:59 INFO - Completed test suite (00:19:41) 09:53:59 INFO - javascript benchmark 09:53:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.052644996175, 3330.8501117449714, 3337.7329813614915, 3338.7329013678905, 3375.746818988575, 5666.716664166791, 5715.914261286084, 5737.397573254801, 5746.252987111675, 5778.971105144474, 5648.378678345379, 5733.397993210705, 5735.1970724098655, 5745.195672605839, 5745.339285982113, 5192.6624769390055, 5204.531592156705, 5221.008008478387, 5241.711705856176, 5262.2632831403635, 4880.585150262232, 5159.7678104485385, 5307.867303317429, 5311.49540793624, 5343.412224655285, 5161.329027226455, 5252.52727254547, 5252.921206181911, 5254.159334506479, 5263.657862238962, 5236.3978142513715, 5243.842684719464, 5249.081410753141, 5251.501107394792, 5253.60597955153, 5080.542751152377, 5184.118699821001, 5188.0, 5195.428502864682, 5224.059669259532, 5752.712364381806, 5755.625884317506, 5755.9424405756245, 5766.336871259817, 5774.2782152230975, 6105.10315090879, 6125.327021303102, 6127.556056270613, 6128.789352163547, 6138.431877890659, 5453.918191227135, 6237.532185086091, 6250.187475628185, 6257.967435373203, 6259.78090766821, 5707.857303567403, 5768.769249230026, 5783.681897495636, 5789.0, 5792.942070579283, 6311.368863113697, 6317.210348706411, 6320.936790632127, 6329.0, 6330.588511746768, 5360.785568577291, 5854.326752423441, 5981.730822113015, 6118.877622447526, 6124.295705993868, 5490.780368785284, 5900.1739756434135, 6178.814635560941, 6239.282482514478, 6305.495560355161, 6148.862460444832, 6223.937760622426, 6224.128621992924, 6270.874582508415, 6285.277193122849, 6108.877822443526, 6284.465820405226, 6286.874262514815, 6298.7480500780375, 6303.905441418382, 4198.727082739612, 4855.247436647325, 4867.172580661296, 4867.3915760529935, 4909.901801963941, 4421.0, 4422.137683151755, 4426.579474949939, 4434.002349471408, 4456.64346852251, 5806.88386232273, 5809.506191973645, 5828.12578113278, 5833.649981001154, 5857.7656893724625, 6170.197874276315, 6224.06639004153, 6233.376662333821, 6246.969250073687, 6311.147995020613, 5810.21562089121, 5815.5929084963645, 5819.709014549256, 5827.24245848037, 5876.118582212617, 5370.194470829407, 5387.003404370125, 5397.487238712238, 5400.972995135077, 5402.486763757437, 6265.373462653698, 6277.591956522811, 6328.841778955563, 6334.33489483616, 6351.587146835441, 6241.3134555197985, 6271.3415091414745, 6304.653244071436, 6355.745770169141, 6356.491480681442, 6306.432421082125, 6316.6841657916, 6318.988961766096, 6328.968355158379, 6339.302676705466, 6109.694515274307, 6213.1922850029205, 6240.875182496234, 6241.750329986749, 6253.843653908689, 4651.767411629473, 6145.539084568586, 6176.969115154396, 6236.189295391751, 6285.622862628257, 6115.057807494094, 6115.788007244199, 6122.825106970096, 6126.884121540644, 6135.2326666699655, 6082.695865206811, 6127.708789263955, 6132.38610285184, 6155.692215389123, 6162.722677479614, 4905.362302900743, 4905.730184839868, 5836.0, 5904.793332233351, 5975.701214939322, 6036.788712395045, 6108.615274519966, 6145.569810113249, 6155.322914479493, 6168.907466387918, 5802.1296805479515, 5833.533317334518, 5839.503642190291, 5964.433378829004, 5988.341282458839], "value": 5674.046376719408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.97740112994353, 461.06173936040165, 470.3203870407261, 524.0, 559.9552035837133, 22938.88530557347, 37499.0, 38610.0, 38679.41980870289, 40371.394429083586, 32406.027819165403, 39635.0, 39771.80114099433, 40029.19941601166, 40064.39903401451, 9134.406263592846, 9221.492817895012, 9300.720978370626, 9319.673811416602, 9334.113259240361, 9148.451092934445, 9266.675666351646, 9288.7677808055, 9325.207357374597, 9338.813223735522, 9278.536073196346, 9313.441193528377, 9315.953420232923, 9338.813223735522, 9347.719568412924, 9253.259739220879, 9330.066993300683, 9333.06669333068, 9345.532723363805, 9377.531123443801, 9184.0, 9240.491772952484, 9246.260299176118, 9246.445213287225, 9265.073492650748, 37963.81018094919, 38209.426858597144, 38224.0, 38294.23411531754, 38467.42298865519, 3172.714455698975, 3330.117518857505, 3334.549835772164, 3442.0706409269606, 3658.304922064826, 27582.5862612061, 28198.577021344696, 28427.147185584465, 28658.0, 28957.917830075705, 2719.9001871490955, 3120.7035331643456, 3139.309351942569, 3152.8581213845205, 3183.283761153722, 483917.0, 485853.0, 490041.0, 492038.53980730224, 503425.0, 55804.0, 55913.7204313984, 56216.718916405975, 56269.0, 56299.0, 58807.70596146992, 58879.116813247834, 58890.11664825031, 58940.41059589435, 59135.40864591385, 15550.45573404948, 15699.215039247993, 15730.764038539432, 15731.528054158394, 15761.0, 12314.199577027464, 12367.443465044094, 12381.75236495265, 12407.689807754878, 12440.564580239829, 13177.407016684272, 14527.85472145265, 15307.846921530865, 15452.922735386475, 15636.843631563766, 6210.192674952317, 6309.652969086653, 6389.105525226472, 6412.519061070345, 6433.292337842833, 837.9162083791572, 934.3693007220099, 1015.898410158993, 1021.7905329407454, 1053.4837929414532, 25566.33818801772, 29191.270218244288, 30430.0, 30525.38949221003, 31064.844675776476, 1022.0239671114068, 1055.8521806947033, 1079.1474734959452, 1082.2532452607675, 1095.4632230207142, 14658.560243192722, 14672.486462973959, 14698.0, 14907.254637268094, 14962.925185374004, 649229.0, 657084.0, 658044.0, 658573.0, 658600.0, 51937.961240774974, 52298.954020919366, 52349.73825130926, 52362.73818630959, 52448.73775631098, 1219.5426714981882, 1223.4494477485168, 1224.871388504212, 1340.7787715027107, 1378.689794796183, 28125.0, 29279.121626351243, 29685.0, 30098.097057088322, 30361.24096897595, 46676.53323466722, 47228.05543889034, 47250.29124563066, 47265.81835454004, 47343.0, 545543.0, 546890.0, 547548.0, 547780.2610987079, 548096.0, 24279.635805462578, 24303.270901872973, 25069.623955640316, 25093.372665683502, 25806.741932581186, 36214.8189259052, 43099.13801723885, 43384.783076084415, 43596.56403435925, 44736.77631611821, 35962.64037359593, 36716.082097947765, 36892.446613300286, 36985.0, 37476.0, 35682.82158589191, 36856.44715329219, 37291.81354093212, 37551.2489750198, 37910.0, 35106.0, 35564.822175888956, 36035.0, 36321.091972700895, 36353.0, 30791.84604076965, 30871.84564077165, 32643.510347345284, 32874.50688239726, 32889.67110328866, 23206.419839503473, 23965.625883788533, 24058.9173487197, 24339.783010849034, 24700.38249043788], "value": 18919.27066826048, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.277793854966, 345.7268757681432, 363.95450568678916, 369.92971335446265, 378.09069188601404, 14640.633984150389, 14971.47599834006, 15378.077315361086, 15931.522054338388, 19711.5072123197, 18682.626347473077, 19157.616847663074, 19740.407787766355, 19881.602367952633, 20107.89946050268, 5548.639338442998, 5850.063989761639, 5860.208871802316, 5862.472377486026, 5868.911966320508, 4620.445546534421, 5695.903297346034, 5746.597738158331, 5785.132230165488, 5836.649801011931, 5775.855603609923, 5789.102689083199, 5793.855153621172, 5795.217645617851, 5807.0, 5493.285872836505, 5782.3350314713925, 5788.392218817005, 5835.795747148872, 5880.059190529495, 5476.561875049986, 5692.260006199209, 5703.743331550048, 5706.514946229576, 5707.400722924116, 12685.0, 13060.477580896753, 13082.542111026163, 13093.214407135602, 13136.934315328457, 1886.699117495742, 2262.558801033799, 2278.2481781012393, 2344.179537161997, 2871.344006793728, 9858.556364963522, 10240.48797560119, 10270.89729102707, 12798.0, 14100.435982560686, 1769.9469015929415, 1828.9451316460527, 1858.7026075827937, 1860.7953125156223, 1879.6522643311032, 91291.54354228187, 124938.12592811116, 126962.0, 132062.0, 132146.0, 11276.830847537294, 11511.424428778528, 11604.187706860608, 11658.300501969909, 11795.41022948849, 14470.927645361706, 14471.710565788626, 14502.202378869264, 14505.492307769178, 14539.127652340894, 8109.391795615353, 8343.499390036495, 8373.790655233546, 8454.1123182065, 8519.318454523624, 8251.257386835094, 8258.298044666271, 8263.710770123138, 8434.198751118756, 8462.449940753831, 4344.847930322424, 4418.6023257906945, 4424.933625995613, 4498.797554110073, 4517.0, 1636.6890290844701, 1698.6347935193992, 1820.2900868661234, 1824.5529845187748, 1904.1431355889904, 776.6486313814036, 878.3280790195505, 925.8981512033671, 955.81361634482, 965.1844191658038, 18806.341778037702, 19719.309824156087, 20201.191952321744, 20333.983300834898, 20524.281650142173, 783.7139444102861, 887.9378443509022, 901.3465237702613, 962.6101428921298, 970.8834939807268, 10260.846087308697, 10444.21668374875, 10658.200634952409, 10693.465326733633, 10723.0, 602714.0, 606633.0, 611039.0, 620878.0, 624027.0, 87870.0, 126686.0, 127504.0, 133535.25660249044, 139379.0, 947.7109481608176, 949.8860136783492, 975.4732444480044, 982.1749730226501, 985.6747273399761, 18229.179686914387, 18764.906175469034, 19074.713879291543, 19143.23427062902, 19443.0, 44022.33966490441, 53713.65715857135, 54602.453975459735, 55493.7225313887, 56203.0, 64554.354456454836, 75121.49757004938, 76496.0, 82892.58553707434, 86955.0, 7690.615469226628, 7932.524048557105, 8030.759077227693, 8057.274845263954, 8064.919350806417, 11755.941220293844, 12245.081618878798, 12418.689532761753, 12420.130590858553, 12686.809697854354, 10689.0, 10753.13974881992, 10986.450677465935, 11114.555417783198, 11206.935341142578, 10612.681619551426, 10661.466926653482, 10803.081738052353, 10950.616728414467, 11056.723581910517, 10609.416482093251, 10676.412797296223, 11079.778404431705, 11334.716632083933, 11526.07791376671, 7935.0, 7936.841263174589, 7958.801029974297, 8145.348372130097, 8211.0, 10512.160371934728, 10646.467676616294, 10734.570617175537, 10745.516451759846, 10922.0], "value": 9213.194412428611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.1413152108737, 1469.522405218304, 1597.6485173261885, 1779.057099737138, 1805.7020591602386, 7892.131865494798, 8288.37837162213, 8289.295409890166, 8307.460015099014, 8308.086110527836, 7280.854382912338, 7581.734639287626, 7607.23927607239, 7621.275978782007, 8090.0291964964135, 2066.813986741193, 2100.2334148035934, 2104.1267873832417, 2181.1166477576608, 2279.954400911981, 2309.4341886237894, 2326.336993956723, 2326.9650955235684, 2327.5461285049423, 2333.2183718454253, 2250.381145185079, 2281.53228588139, 2284.3946354216146, 2299.666548350488, 2307.1117619716447, 1995.9401217963484, 2077.8129968302774, 2081.5108449514505, 2204.1183526589493, 2273.7385200701883, 2308.607536718762, 2314.166899916029, 2317.073170731704, 2318.5594737000083, 2319.5476882008015, 8267.586620669003, 8273.8345233095, 8285.42002059856, 8288.088310285864, 8291.419600627958, 4954.925676114861, 5111.335526381584, 5119.129747942859, 5124.385073791132, 5126.641135120543, 3114.2837147455984, 3215.9839200803845, 3353.5808023997, 3409.301093275897, 3441.82790860456, 964.8697425847491, 1044.7931498082528, 1073.0557109743454, 1073.8926107389277, 1078.5470102556944, 10491.160707143486, 10673.733156671067, 10677.893221067767, 10684.465776711133, 10688.0, 4481.75350355727, 4500.842470513517, 4670.229412147026, 4736.905261894743, 4756.833510827105, 8501.319894408556, 8593.52735599548, 8606.967163940368, 8613.741587752378, 8614.396992210484, 5040.143175660147, 5059.822906198266, 5063.012712521023, 5063.569596584258, 5065.493450654905, 4514.210013247669, 4661.650376221797, 4716.29255611661, 4744.620430365562, 4766.142094423037, 3194.984025079906, 3244.951325730116, 3444.50054742061, 3512.5784905810956, 3546.4680297954997, 1015.5633077776627, 1029.934018291065, 1103.332483847277, 1106.8505751723576, 1114.9275297105662, 779.6395290218605, 787.9172686867911, 887.2901678657178, 897.2373482539789, 912.466207268742, 5114.4629813869005, 5154.690718556899, 5158.793648254103, 5537.667739935617, 5568.387477377485, 421.3826743820318, 437.09957487575696, 444.220393209921, 450.4324551065615, 457.40994117588605, 3566.179778650873, 3599.6580324869096, 3623.202895363016, 3674.926501469956, 3756.718246131551, 9588.232941364675, 9918.30571859963, 9943.651972180938, 10154.644587439405, 10157.542910569042, 8364.916350836414, 10043.347182433265, 10074.899251007542, 10128.03783640553, 10171.64399246023, 7636.694532218649, 7694.576798276036, 7702.499337543042, 7833.882491762628, 7845.764627061198, 5060.190369541003, 5231.215317702375, 5280.155175171954, 5297.920531191958, 5370.043745578116, 9203.309751768511, 9215.44707317563, 9260.073992600686, 9269.44383337002, 9415.15263626277, 9307.488088154945, 9382.0, 9415.57629906642, 9452.0, 9519.428834269966, 6419.197600299963, 6488.935110648833, 6503.772367967098, 6526.477881769352, 6536.281009089092, 7308.8538229234055, 7321.267873212636, 7597.582132982739, 7669.34810541088, 7673.194314596887, 6980.546264492792, 7023.508354415142, 7025.859482810213, 7046.154461464657, 7092.9645351772915, 6473.0, 6645.6677166140535, 6788.66056697173, 6915.792526224222, 6945.722171113099, 6301.054841773771, 6419.454346380423, 6474.805755827333, 6482.319356467503, 6488.318726533646, 4529.275315949432, 4632.837850675211, 4652.511486293891, 4732.716037037789, 4755.358026666356, 4187.183499217624, 4620.953790462187, 4661.603763679989, 4713.552212539803, 4878.0], "value": 4187.101074086156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.91940337302185, 295.1190695773117, 298.52534470192376, 304.963404391473, 310.4597999480902, 4980.377452818398, 5070.214116811891, 5083.745812709363, 5085.677723791822, 5117.398555862942, 4531.297648864432, 4771.618270538357, 4799.60019990005, 5002.5247601477895, 5214.1582837353635, 3971.9205615887663, 3988.421678856564, 4017.3572228443454, 4022.0, 4051.2910240707906, 3323.7673362864607, 3458.308338332331, 3919.8044596398086, 3951.530293566521, 4035.838566457353, 3565.8038807865555, 3854.8265328060165, 3953.7627742335408, 3974.2448934702456, 3981.7810020448865, 3568.660977207161, 3629.1290090378384, 3717.9218026772205, 3758.32350176968, 3973.2450834341385, 2762.881033181565, 3468.843902024415, 3493.5283736695474, 3500.457429098494, 3501.19472521319, 4810.0, 4982.676126051795, 5071.906137256271, 5075.959428317186, 5096.847094587169, 3799.5060642116623, 3944.5660977292764, 4042.4946881639794, 4280.190630339001, 4499.797509112065, 4901.730404827733, 5032.6980381177245, 5211.869703257411, 5228.7581699346265, 5417.507946344686, 3238.886638967648, 3535.5403797506415, 3772.924541509182, 3777.452269420946, 3798.8860334190017, 5703.060959273826, 5706.944215320179, 5707.885842283131, 5710.114932185518, 5728.79949201776, 3122.35991621717, 3876.3604005339366, 3879.9436298761702, 3895.941560876589, 3897.376419772823, 3055.976247956915, 3643.560793486558, 3805.219929914361, 3931.567527571965, 3964.801759911993, 3747.8126093695205, 4090.8341122779866, 4470.658802359279, 4491.438570178728, 4581.335706322565, 4312.69811113219, 5069.8732531687, 5391.51476367121, 5470.452954704498, 5483.243977875169, 1119.8264269038311, 1162.3200427749691, 1248.6764030128093, 1284.9036322275867, 1286.3182513267982, 793.8372633610096, 859.8864470510704, 895.8253140637644, 897.546738896853, 904.6562306323686, 4179.937300940488, 4680.485146633868, 4871.3193948088565, 4873.853784386474, 4933.309336692866, 4689.343491911135, 4765.880852978634, 5279.577633789365, 5341.023821186186, 5359.892802144013, 3843.789820852965, 4787.247332783593, 4837.516248375135, 4856.902861942742, 4864.635152363516, 2506.15797388919, 2581.354112035179, 2783.3439103733244, 2786.3312804926672, 2788.316862368692, 4752.857414277577, 4949.0, 4951.3810773653295, 5249.343832020997, 5578.972105139448, 4451.888702782457, 4492.348609451611, 4828.07901219764, 5209.0, 5368.651037682616, 4806.49531799156, 5238.947610523922, 5467.797084641373, 5471.2887324647545, 5489.917651235235, 4714.882127946828, 5284.656497327662, 5302.893942121059, 5307.761150748149, 5319.707416092152, 4805.839299443874, 5018.573421259088, 5211.843644690665, 5231.529162375252, 5328.547073498796, 4478.910421791611, 4874.561289483963, 5491.28613280271, 5501.3948465667945, 5506.33923929115, 3025.667176610615, 3643.708503319781, 3670.5778835434267, 3682.974364099788, 3685.981570092132, 5238.030964271622, 5294.12646913255, 5300.70846103468, 5606.439356064361, 5714.457126572969, 5233.0, 5516.862078448071, 5549.195366671891, 5556.972215138899, 5568.55451563882, 4520.954790452185, 5521.282233309644, 5552.723383412781, 5579.860503487283, 5582.27430434041, 4853.6359773017875, 5053.69677819332, 5173.560247378864, 5383.865403364791, 5386.245925570502, 4730.351003437948, 4857.963772642099, 5552.972235138798, 5553.722313884209, 5604.467575580314, 5104.336436263262, 5387.353517577916, 5401.972990135024, 5412.350517937873, 5424.663831743528], "value": 3885.626008120384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.5821977703489, 746.4177941205861, 759.1800855076518, 774.6281784743327, 811.1482942909943, 13811.58565243043, 14062.859371406283, 14394.0, 14529.0, 14538.27308634568, 13008.544700935445, 13058.477660893577, 13171.604851854436, 13183.143095698773, 13216.53742119026, 796.6693822063836, 811.8741595052746, 811.8903947967008, 812.3217113710059, 814.3281792521194, 638.0620487882804, 659.9142111525495, 662.2880403566186, 783.3733013589106, 804.2038382001805, 857.0443954990203, 858.433433933604, 862.1163307609719, 862.1464749897588, 862.3230763850379, 853.2235665544325, 854.6154230596226, 855.0124606079987, 856.0412338181246, 856.3876828067899, 498.9716801203134, 510.9361329833771, 605.4671888737927, 625.6683957502531, 627.6798832595364, 13921.373538190806, 13944.093633913762, 13950.581482555539, 13961.86038139626, 13986.93006534971, 12926.806097908539, 13029.283389413578, 13236.272005039718, 13338.866611333859, 13393.06248562601, 11358.26171298863, 11892.940535297268, 11964.940175299154, 11969.222000569935, 12355.752884942342, 4321.567843215685, 4367.213901497729, 4478.126765280772, 4495.483019452772, 4503.932441013388, 88044.55977720134, 88952.55523722405, 89778.0, 90101.54949225277, 94357.5282123585, 10319.94840025795, 10448.68653940383, 10485.318454300446, 10503.737406564896, 10663.093637040784, 19812.801871981384, 19934.0, 19947.60104797896, 19967.0, 20028.198872045246, 7179.174394944648, 7381.520201186906, 7461.030066091374, 7563.243675632392, 7567.470277080552, 4073.1446396256524, 4131.132462182915, 4133.6693064554765, 4181.707280490397, 4269.701120921506, 3167.572377729023, 3266.7223286020953, 3273.4598791199187, 3278.0493656839726, 3283.1792051987004, 562.8058319879635, 592.3395414113319, 608.8995315772847, 609.9451049405575, 610.3408319015452, 516.2545730723576, 552.2296396526823, 586.2086183652036, 591.0867709389005, 608.9025755879038, 6957.469356741509, 7074.575525468385, 8677.132286771399, 8702.521361325062, 8747.737567872973, 520.3261776000013, 560.5683623609879, 604.7369394313399, 615.1940957345892, 629.222909706512, 3969.325214713506, 4046.838126474967, 4050.9392359114636, 4177.91644167121, 4371.901487286057, 72706.63646681733, 100199.99600007958, 111308.0, 114426.0, 120269.0, 84463.88840278919, 91762.0, 95390.8456865724, 96661.5500767489, 101620.0, 78517.60741196372, 82868.0, 86786.56606716926, 90156.19687606342, 93022.0, 8975.0, 9314.860277095713, 9504.95247523758, 9581.904180958101, 9599.712008639752, 42005.36991945062, 51851.481485186174, 52500.0, 53103.203451949026, 53842.269919215, 65867.0, 69877.0, 70607.0, 70805.0, 73009.0, 12221.14451988388, 12234.0, 12247.265164090182, 12308.199967002116, 12601.0, 11495.482703278205, 12282.140250182401, 12465.750684986431, 13606.523771667944, 14313.212773297151, 12662.430190641628, 12803.295818729686, 12866.421011054337, 12886.420111094836, 12955.352232388532, 12583.05627077991, 12846.743065138831, 12859.678508037374, 13125.081244312807, 13672.93163534176, 12073.215241009306, 12245.448954797233, 12848.100632955604, 12919.095663303855, 13192.67018324511, 10321.896781032094, 10360.844587331045, 10929.672109836718, 11037.448127593749, 11228.214025018497, 10271.332363396356, 10630.468476575985, 11030.172737044593, 11228.157888158585, 11238.0], "value": 7110.010775732415, "unit": "score"}], "name": "dromaeo_css", "value": 6967.60576377238, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 162.0, 117.0, 116.0, 116.0, 116.0, 115.0, 116.0, 116.0, 116.0], "value": 120.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 100.0, 130.0, 178.0, 140.0, 139.0, 110.0, 109.0, 143.0, 114.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 185.0, 185.0, 182.0, 184.0, 186.0, 185.0, 184.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 91.0, 62.0, 62.0, 60.0, 60.0, 83.0, 60.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 73.0, 96.0, 70.0, 69.0, 70.0, 90.0, 92.0, 98.0, 127.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 105.0, 86.0, 88.0, 129.0, 132.0, 85.0, 87.0, 86.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 102.0, 95.0, 94.0, 160.0, 95.0, 96.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 80.0, 79.0, 78.0, 84.0, 84.0, 81.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 57.0, 59.0, 58.0, 57.0, 57.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 72.0, 76.0, 74.0, 72.0, 70.0, 74.0, 71.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 85.0, 83.0, 83.0, 83.0, 82.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 143.0, 140.0, 138.0, 143.0, 141.0, 145.0, 186.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 191.0, 164.0, 167.0, 166.0, 167.0, 166.0, 167.0, 166.0, 167.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 65.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1471.9, "alertThreshold": 2.0}]} 09:53:59 INFO - Return code: 0 09:53:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:59 INFO - # TBPL SUCCESS # 09:53:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:53:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:53:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:53:59 INFO - 2016-12-18 09:53:59.428 screenresolution[1935:23838] starting screenresolution argv=screenresolution get 09:53:59 INFO - 2016-12-18 09:53:59.430 screenresolution[1935:23838] Display 0: 1600x1200x32@60 09:53:59 INFO - 2016-12-18 09:53:59.436 screenresolution[1936:23841] starting screenresolution argv=screenresolution list 09:53:59 INFO - Available Modes on Display 0 09:53:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:53:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:53:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:53:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:53:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:53:59 INFO - Intel Iris: 09:53:59 INFO - Chipset Model: Intel Iris 09:53:59 INFO - Type: GPU 09:53:59 INFO - Bus: Built-In 09:53:59 INFO - VRAM (Dynamic, Max): 1536 MB 09:53:59 INFO - Vendor: Intel (0x8086) 09:53:59 INFO - Device ID: 0x0a2e 09:53:59 INFO - Revision ID: 0x0009 09:53:59 INFO - Displays: 09:53:59 INFO - Display: 09:53:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:53:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:53:59 INFO - Display Serial Number: 1600x1200 60 09:53:59 INFO - Main Display: Yes 09:53:59 INFO - Mirror: Off 09:53:59 INFO - Online: Yes 09:53:59 INFO - Rotation: Supported 09:53:59 INFO - Return code: 0 09:53:59 INFO - Running post-action listener: _resource_record_post_action 09:53:59 INFO - [mozharness: 2016-12-18 17:53:59.678677Z] Finished run-tests step (success) 09:53:59 INFO - Running post-run listener: _resource_record_post_run 09:53:59 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 552960; Write bytes: 658673152; Read time: 8; Write time: 1848 09:53:59 INFO - TinderboxPrint: CPU usage
53.6% 09:53:59 INFO - TinderboxPrint: I/O read bytes / time
552,960 / 8 09:53:59 INFO - TinderboxPrint: I/O write bytes / time
658,673,152 / 1,848 09:53:59 INFO - TinderboxPrint: CPU idle
2,251.5 (46.4%) 09:53:59 INFO - TinderboxPrint: CPU system
978.9 (20.2%) 09:53:59 INFO - TinderboxPrint: CPU user
1,623.2 (33.4%) 09:53:59 INFO - TinderboxPrint: Swap in / out
348,880,896 / 0 09:53:59 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 344556032; Write bytes: 345794560; Read time: 26834; Write time: 621 09:53:59 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 552960; Write bytes: 305939968; Read time: 8; Write time: 1198 09:54:00 INFO - Running post-run listener: _upload_blobber_files 09:54:00 INFO - Blob upload gear active. 09:54:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:54:00 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 09:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:54:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:01 INFO - (blobuploader) - INFO - Done attempting. 09:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:54:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:02 INFO - (blobuploader) - INFO - Done attempting. 09:54:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:54:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:54:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:05 INFO - (blobuploader) - INFO - Done attempting. 09:54:05 INFO - (blobuploader) - INFO - Iteration through files over. 09:54:05 INFO - Return code: 0 09:54:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:54:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:54:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf5eb685463298c8d74a1843abb35da9c13ec938cf103ca92d7a788ced6d879f21a2559c47358954c86d8696f129c6645f186965eece8acb6f09c3368f709f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50d725a20e8206b074c5b833ee8162bf74d868223d1afb8297c133da0f485dd3c71acb47606288d17f13c566255471871025662caa223fbb5189f336fcac82fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e677f5ec7f7952223475bb1ddca794350f2d33e88237971043a8905ca83ebfd459e754ca18a9235adb1a308fa586013a75c67b7a9c7bb387365095595f27d91"} 09:54:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:54:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:54:05 INFO - Contents: 09:54:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf5eb685463298c8d74a1843abb35da9c13ec938cf103ca92d7a788ced6d879f21a2559c47358954c86d8696f129c6645f186965eece8acb6f09c3368f709f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50d725a20e8206b074c5b833ee8162bf74d868223d1afb8297c133da0f485dd3c71acb47606288d17f13c566255471871025662caa223fbb5189f336fcac82fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e677f5ec7f7952223475bb1ddca794350f2d33e88237971043a8905ca83ebfd459e754ca18a9235adb1a308fa586013a75c67b7a9c7bb387365095595f27d91"} 09:54:05 INFO - Running post-run listener: copy_logs_to_upload_dir 09:54:05 INFO - Copying logs to upload dir... 09:54:05 INFO - mkdir: /builds/slave/test/build/upload/logs 09:54:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.760265 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-18 09:54:05.298114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-12-18 09:54:05.301172) ========= 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.8oUrVizGbS/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.iM88Sr9vOA/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf5eb685463298c8d74a1843abb35da9c13ec938cf103ca92d7a788ced6d879f21a2559c47358954c86d8696f129c6645f186965eece8acb6f09c3368f709f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50d725a20e8206b074c5b833ee8162bf74d868223d1afb8297c133da0f485dd3c71acb47606288d17f13c566255471871025662caa223fbb5189f336fcac82fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e677f5ec7f7952223475bb1ddca794350f2d33e88237971043a8905ca83ebfd459e754ca18a9235adb1a308fa586013a75c67b7a9c7bb387365095595f27d91"} build_url:https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/TpOpIBitS4K5QGAH6b_R7w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf5eb685463298c8d74a1843abb35da9c13ec938cf103ca92d7a788ced6d879f21a2559c47358954c86d8696f129c6645f186965eece8acb6f09c3368f709f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50d725a20e8206b074c5b833ee8162bf74d868223d1afb8297c133da0f485dd3c71acb47606288d17f13c566255471871025662caa223fbb5189f336fcac82fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e677f5ec7f7952223475bb1ddca794350f2d33e88237971043a8905ca83ebfd459e754ca18a9235adb1a308fa586013a75c67b7a9c7bb387365095595f27d91"}' ========= master_lag: 3.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-12-18 09:54:08.553669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 09:54:08.554053) ========= 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.8oUrVizGbS/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.iM88Sr9vOA/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005092 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 09:54:08.580902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 09:54:08.581183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 09:54:08.581490) ========= ========= Total master_lag: 3.39 =========