builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0086 starttime: 1475817256.75 results: success (0) buildid: 20161006195901 builduid: 054da0f41da04033863ff8a4e33869b7 revision: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.754916) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.755501) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.755920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.783209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.783839) ========= 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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-10-06 22:14:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.3M=0s 2016-10-06 22:14:16 (25.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.931921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.932265) ========= 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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.036335 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:16.989375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 22:14:16.989743) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WrAUWlSvTB/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.p2CUyEDOaI/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-10-06 22:14:17,062 truncating revision to first 12 chars 2016-10-06 22:14:17,062 Setting DEBUG logging. 2016-10-06 22:14:17,062 attempt 1/10 2016-10-06 22:14:17,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5b04b518afe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 22:14:18,346 unpacking tar archive at: mozilla-central-a5b04b518afe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.550695 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 22:14:18.744579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:18.744906) ========= script_repo_revision: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:18.745295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:18.745580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 22:14:18.764311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-06 22:14:18.764801) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WrAUWlSvTB/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.p2CUyEDOaI/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:14:18 INFO - MultiFileLogger online at 20161006 22:14:18 in /builds/slave/test 22:14:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:14:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:14:18 INFO - {'append_to_log': False, 22:14:18 INFO - 'base_work_dir': '/builds/slave/test', 22:14:18 INFO - 'blob_upload_branch': 'Firefox', 22:14:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:14:18 INFO - 'branch': 'Firefox', 22:14:18 INFO - 'buildbot_json_path': 'buildprops.json', 22:14:18 INFO - 'config_files': ('talos/mac_config.py',), 22:14:18 INFO - 'default_actions': ('clobber', 22:14:18 INFO - 'read-buildbot-config', 22:14:18 INFO - 'download-and-extract', 22:14:18 INFO - 'populate-webroot', 22:14:18 INFO - 'create-virtualenv', 22:14:18 INFO - 'install', 22:14:18 INFO - 'run-tests'), 22:14:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:14:18 INFO - 'download_minidump_stackwalk': True, 22:14:18 INFO - 'download_symbols': 'ondemand', 22:14:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:14:18 INFO - 'tooltool.py': '/tools/tooltool.py', 22:14:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:14:18 INFO - '/tools/misc-python/virtualenv.py')}, 22:14:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:14:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:14:18 INFO - 'installer_path': 'installer.exe', 22:14:18 INFO - 'log_level': 'info', 22:14:18 INFO - 'log_name': 'talos', 22:14:18 INFO - 'log_to_console': True, 22:14:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:14:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:14:18 INFO - 'opt_config_files': (), 22:14:18 INFO - 'pip_index': False, 22:14:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:14:18 INFO - 'cmd': ('bash', 22:14:18 INFO - '-c', 22:14:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:14:18 INFO - 'enabled': True, 22:14:18 INFO - 'halt_on_failure': False, 22:14:18 INFO - 'name': 'check_screen_resolution'},), 22:14:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:14:18 INFO - 'cmd': ('bash', 22:14:18 INFO - '-c', 22:14:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:14:18 INFO - 'enabled': True, 22:14:18 INFO - 'halt_on_failure': False, 22:14:18 INFO - 'name': 'check_screen_resolution'},), 22:14:18 INFO - 'run_cmd_checks_enabled': True, 22:14:18 INFO - 'sps_profile': False, 22:14:18 INFO - 'sps_profile_interval': 0, 22:14:18 INFO - 'suite': 'dromaeojs', 22:14:18 INFO - 'system_bits': '32', 22:14:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:14:18 INFO - 'title': 't-yosemite-r7-0086', 22:14:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:14:18 INFO - 'use_talos_json': True, 22:14:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:14:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:14:18 INFO - 'work_dir': 'build'} 22:14:18 INFO - [mozharness: 2016-10-07 05:14:18.971050Z] Running clobber step. 22:14:18 INFO - Running pre-action listener: _resource_record_pre_action 22:14:18 INFO - Running main action method: clobber 22:14:18 INFO - rmtree: /builds/slave/test/build 22:14:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:14:21 INFO - Running post-action listener: _resource_record_post_action 22:14:21 INFO - [mozharness: 2016-10-07 05:14:21.224417Z] Finished clobber step (success) 22:14:21 INFO - [mozharness: 2016-10-07 05:14:21.224546Z] Running read-buildbot-config step. 22:14:21 INFO - Running pre-action listener: _resource_record_pre_action 22:14:21 INFO - Running main action method: read_buildbot_config 22:14:21 INFO - Using buildbot properties: 22:14:21 INFO - { 22:14:21 INFO - "project": "", 22:14:21 INFO - "product": "firefox", 22:14:21 INFO - "script_repo_revision": "production", 22:14:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 22:14:21 INFO - "repository": "", 22:14:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 22:14:21 INFO - "buildid": "20161006195901", 22:14:21 INFO - "pgo_build": "False", 22:14:21 INFO - "basedir": "/builds/slave/test", 22:14:21 INFO - "buildnumber": 120, 22:14:21 INFO - "slavename": "t-yosemite-r7-0086", 22:14:21 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 22:14:21 INFO - "platform": "yosemite_r7", 22:14:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 22:14:21 INFO - "branch": "mozilla-central", 22:14:21 INFO - "repo_path": "mozilla-central", 22:14:21 INFO - "revision": "a5b04b518afe0eadef15f5dd3e5e7a8408d75a67", 22:14:21 INFO - "stage_platform": "macosx64", 22:14:21 INFO - "builduid": "054da0f41da04033863ff8a4e33869b7", 22:14:21 INFO - "slavebuilddir": "test" 22:14:21 INFO - } 22:14:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 22:14:21 INFO - Running post-action listener: _resource_record_post_action 22:14:21 INFO - [mozharness: 2016-10-07 05:14:21.227636Z] Finished read-buildbot-config step (success) 22:14:21 INFO - [mozharness: 2016-10-07 05:14:21.227775Z] Running download-and-extract step. 22:14:21 INFO - Running pre-action listener: _resource_record_pre_action 22:14:21 INFO - Running main action method: download_and_extract 22:14:21 INFO - mkdir: /builds/slave/test/build/tests 22:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:21 INFO - trying https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 22:14:21 INFO - Downloading https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 22:14:22 INFO - Downloaded 1199 bytes. 22:14:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:14:22 INFO - Using the following test package requirements: 22:14:22 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:14:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 22:14:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 22:14:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'jsshell-mac.zip'], 22:14:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 22:14:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:14:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 22:14:22 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 22:14:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 22:14:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:14:22 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 22:14:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:14:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:14:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:14:22 INFO - Fetch https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:14:22 INFO - Http code: 200 22:14:22 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 22:14:22 INFO - x-amz-cf-id: zrTP1TzwCxWv9iAdvaw7hlwrRiRB8xrXUTIyvyt2EpEaJ2JJXJkaQw== 22:14:22 INFO - x-amz-version-id: _zaFRzpFaI72GC7GvmM_FG9.ssuenBcM 22:14:23 INFO - Expected file size: 16482447 22:14:23 INFO - Obtained file size: 16482447 22:14:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:14:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:14:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:14:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:14:30 INFO - Http code: 200 22:14:30 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 22:14:30 INFO - x-amz-cf-id: 071guHmaP4XKhE_42YTt2mB9pBgrEljzN0IDXQpRPA7XBFWA908s-w== 22:14:30 INFO - x-amz-version-id: _zaFRzpFaI72GC7GvmM_FG9.ssuenBcM 22:14:30 INFO - Expected file size: 16482447 22:14:30 INFO - Obtained file size: 16482447 22:14:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 22:14:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:14:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 22:14:38 INFO - Http code: 200 22:14:38 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 22:14:38 INFO - x-amz-cf-id: Fk-cOhMm1xwI7aYhANtRW9f2-XpHw1xFI-Uc4prTcXmMyS3NTS9vkg== 22:14:38 INFO - x-amz-version-id: U8YxX.IuTypnDuuy.XifnfYhp71RlhO3 22:14:38 INFO - Expected file size: 14409006 22:14:38 INFO - Obtained file size: 14409006 22:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:38 INFO - trying https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:14:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 22:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 22:14:41 INFO - Downloaded 111742768 bytes. 22:14:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:14:41 INFO - mkdir: /builds/slave/test/properties 22:14:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:14:41 INFO - Writing to file /builds/slave/test/properties/build_url 22:14:41 INFO - Contents: 22:14:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:14:42 INFO - Running post-action listener: _resource_record_post_action 22:14:42 INFO - Running post-action listener: set_extra_try_arguments 22:14:42 INFO - [mozharness: 2016-10-07 05:14:42.572906Z] Finished download-and-extract step (success) 22:14:42 INFO - [mozharness: 2016-10-07 05:14:42.573061Z] Running populate-webroot step. 22:14:42 INFO - Running pre-action listener: _resource_record_pre_action 22:14:42 INFO - Running main action method: populate_webroot 22:14:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:14:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:14:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:14:42 INFO - '--tppagecycles', 22:14:42 INFO - '7'], 22:14:42 INFO - 'tests': ['tsvgm']}}, 22:14:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:14:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:14:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:14:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:14:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['damp', 'tps']}, 22:14:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'tests': ['damp', 'tps']}, 22:14:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['dromaeo_dom']}, 22:14:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:14:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['basic_compositor_video']}, 22:14:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:14:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['a11yr', 22:14:42 INFO - 'ts_paint', 22:14:42 INFO - 'tpaint', 22:14:42 INFO - 'sessionrestore', 22:14:42 INFO - 'sessionrestore_no_auto_restore', 22:14:42 INFO - 'tabpaint']}, 22:14:42 INFO - 'other-e10s': {'tests': ['a11yr', 22:14:42 INFO - 'ts_paint', 22:14:42 INFO - 'tpaint', 22:14:42 INFO - 'sessionrestore', 22:14:42 INFO - 'sessionrestore_no_auto_restore', 22:14:42 INFO - 'tabpaint']}, 22:14:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:14:42 INFO - 'ts_paint', 22:14:42 INFO - 'tpaint', 22:14:42 INFO - 'sessionrestore', 22:14:42 INFO - 'sessionrestore_no_auto_restore', 22:14:42 INFO - 'tabpaint']}, 22:14:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:14:42 INFO - 'ts_paint', 22:14:42 INFO - 'tpaint', 22:14:42 INFO - 'sessionrestore', 22:14:42 INFO - 'sessionrestore_no_auto_restore', 22:14:42 INFO - 'tabpaint']}, 22:14:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['a11yr', 22:14:42 INFO - 'ts_paint', 22:14:42 INFO - 'tpaint', 22:14:42 INFO - 'sessionrestore', 22:14:42 INFO - 'sessionrestore_no_auto_restore', 22:14:42 INFO - 'tabpaint']}, 22:14:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['a11yr', 22:14:42 INFO - 'ts_paint', 22:14:42 INFO - 'tpaint', 22:14:42 INFO - 'sessionrestore', 22:14:42 INFO - 'sessionrestore_no_auto_restore', 22:14:42 INFO - 'tabpaint']}, 22:14:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['tsvgx', 22:14:42 INFO - 'tsvgr_opacity', 22:14:42 INFO - 'tart', 22:14:42 INFO - 'tscrollx', 22:14:42 INFO - 'cart']}, 22:14:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:14:42 INFO - 'tsvgr_opacity', 22:14:42 INFO - 'tart', 22:14:42 INFO - 'tscrollx', 22:14:42 INFO - 'cart']}, 22:14:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'talos_options': ['--disable-e10s'], 22:14:42 INFO - 'tests': ['tp5o']}, 22:14:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'tests': ['tp5o']}, 22:14:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'talos_options': ['--disable-e10s', 22:14:42 INFO - '--xperf_path', 22:14:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:42 INFO - 'tests': ['tp5n']}, 22:14:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:42 INFO - 'talos_options': ['--xperf_path', 22:14:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:42 INFO - 'tests': ['tp5n']}}, 22:14:42 INFO - 'talos.zip': {'path': '', 22:14:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:14:42 INFO - Running post-action listener: _resource_record_post_action 22:14:42 INFO - [mozharness: 2016-10-07 05:14:42.592377Z] Finished populate-webroot step (success) 22:14:42 INFO - [mozharness: 2016-10-07 05:14:42.592499Z] Running create-virtualenv step. 22:14:42 INFO - Running pre-action listener: _resource_record_pre_action 22:14:42 INFO - Running main action method: create_virtualenv 22:14:42 INFO - Creating virtualenv /builds/slave/test/build/venv 22:14:42 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 22:14:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:14:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:14:42 INFO - Using real prefix '/tools/python27' 22:14:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 22:14:46 INFO - Installing pip.................done. 22:14:46 INFO - Return code: 0 22:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:14:46 INFO - Reading from file tmpfile_stdout 22:14:46 INFO - Output received: 22:14:46 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) 22:14:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:14:46 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')]} 22:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:46 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')]} 22:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:46 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:14:46 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 22:14:46 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 22:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:14:46 INFO - 'HOME': '/Users/cltbld', 22:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:14:46 INFO - 'LOGNAME': 'cltbld', 22:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:46 INFO - 'MOZ_NO_REMOTE': '1', 22:14:46 INFO - 'NO_EM_RESTART': '1', 22:14:46 INFO - 'PAGER': '/bin/cat', 22:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:46 INFO - 'PWD': '/builds/slave/test', 22:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:14:46 INFO - 'SHELL': '/bin/bash', 22:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:14:46 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:14:46 INFO - 'USER': 'cltbld', 22:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:46 INFO - 'XPC_FLAGS': '0x0', 22:14:46 INFO - 'XPC_SERVICE_NAME': '0', 22:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:46 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 22:14:46 INFO - Cleaning up... 22:14:46 INFO - Return code: 0 22:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:14:46 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')]} 22:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:46 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')]} 22:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:46 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:14:46 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 22:14:46 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 22:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:14:46 INFO - 'HOME': '/Users/cltbld', 22:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:14:46 INFO - 'LOGNAME': 'cltbld', 22:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:46 INFO - 'MOZ_NO_REMOTE': '1', 22:14:46 INFO - 'NO_EM_RESTART': '1', 22:14:46 INFO - 'PAGER': '/bin/cat', 22:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:46 INFO - 'PWD': '/builds/slave/test', 22:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:14:46 INFO - 'SHELL': '/bin/bash', 22:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:14:46 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:14:46 INFO - 'USER': 'cltbld', 22:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:46 INFO - 'XPC_FLAGS': '0x0', 22:14:46 INFO - 'XPC_SERVICE_NAME': '0', 22:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:47 INFO - Downloading/unpacking psutil>=3.1.1 22:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:14:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:50 INFO - Installing collected packages: psutil 22:14:50 INFO - Running setup.py install for psutil 22:14:50 INFO - building 'psutil._psutil_osx' extension 22:14:50 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 22:14:51 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 22:14:51 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 22:14:51 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 22:14:51 INFO - building 'psutil._psutil_posix' extension 22:14:51 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 22:14:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:14:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:14:51 INFO - ^ 22:14:51 INFO - 1 warning generated. 22:14:51 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 22:14:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:51 INFO - Successfully installed psutil 22:14:51 INFO - Cleaning up... 22:14:51 INFO - Return code: 0 22:14:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:14:51 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')]} 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 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')]} 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:14:51 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 22:14:51 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 22:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:14:51 INFO - 'HOME': '/Users/cltbld', 22:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:14:51 INFO - 'LOGNAME': 'cltbld', 22:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:51 INFO - 'MOZ_NO_REMOTE': '1', 22:14:51 INFO - 'NO_EM_RESTART': '1', 22:14:51 INFO - 'PAGER': '/bin/cat', 22:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:51 INFO - 'PWD': '/builds/slave/test', 22:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:14:51 INFO - 'SHELL': '/bin/bash', 22:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:14:51 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:14:51 INFO - 'USER': 'cltbld', 22:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:51 INFO - 'XPC_FLAGS': '0x0', 22:14:51 INFO - 'XPC_SERVICE_NAME': '0', 22:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:14:52 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 22:14:52 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 22:14:52 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 22:14:52 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 22:14:52 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 22:14:52 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 22:14:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:14:54 INFO - Installing collected packages: mozsystemmonitor 22:14:54 INFO - Running setup.py install for mozsystemmonitor 22:14:54 INFO - Successfully installed mozsystemmonitor 22:14:54 INFO - Cleaning up... 22:14:54 INFO - Return code: 0 22:14:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:14:54 INFO - 'HOME': '/Users/cltbld', 22:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:14:54 INFO - 'LOGNAME': 'cltbld', 22:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:54 INFO - 'MOZ_NO_REMOTE': '1', 22:14:54 INFO - 'NO_EM_RESTART': '1', 22:14:54 INFO - 'PAGER': '/bin/cat', 22:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:54 INFO - 'PWD': '/builds/slave/test', 22:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:14:54 INFO - 'SHELL': '/bin/bash', 22:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:14:54 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:14:54 INFO - 'USER': 'cltbld', 22:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:54 INFO - 'XPC_FLAGS': '0x0', 22:14:54 INFO - 'XPC_SERVICE_NAME': '0', 22:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:55 INFO - Downloading/unpacking jsonschema==2.5.1 22:14:55 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 22:14:55 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 22:14:55 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 22:14:55 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 22:14:55 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 22:14:55 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 22:14:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:14:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:58 INFO - Downloading functools32-3.2.3-2.tar.gz 22:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:14:58 INFO - warning: no files found matching '*.txt' 22:14:58 INFO - no previously-included directories found matching 'build' 22:14:58 INFO - no previously-included directories found matching 'dist' 22:14:58 INFO - no previously-included directories found matching '.git*' 22:14:58 INFO - Installing collected packages: jsonschema, functools32 22:14:58 INFO - Running setup.py install for functools32 22:14:58 INFO - warning: no files found matching '*.txt' 22:14:58 INFO - no previously-included directories found matching 'build' 22:14:58 INFO - no previously-included directories found matching 'dist' 22:14:58 INFO - no previously-included directories found matching '.git*' 22:14:58 INFO - Successfully installed jsonschema functools32 22:14:58 INFO - Cleaning up... 22:14:58 INFO - Return code: 0 22:14:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:14:58 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')]} 22:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 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')]} 22:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:14:58 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 22:14:58 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 22:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:14:58 INFO - 'HOME': '/Users/cltbld', 22:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:14:58 INFO - 'LOGNAME': 'cltbld', 22:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:58 INFO - 'MOZ_NO_REMOTE': '1', 22:14:58 INFO - 'NO_EM_RESTART': '1', 22:14:58 INFO - 'PAGER': '/bin/cat', 22:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:58 INFO - 'PWD': '/builds/slave/test', 22:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:14:58 INFO - 'SHELL': '/bin/bash', 22:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:14:58 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:14:58 INFO - 'USER': 'cltbld', 22:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:58 INFO - 'XPC_FLAGS': '0x0', 22:14:58 INFO - 'XPC_SERVICE_NAME': '0', 22:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:14:58 INFO - Cleaning up... 22:14:58 INFO - Return code: 0 22:14:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:14:58 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')]} 22:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 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')]} 22:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:14:58 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 22:14:58 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 22:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:14:58 INFO - 'HOME': '/Users/cltbld', 22:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:14:58 INFO - 'LOGNAME': 'cltbld', 22:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:58 INFO - 'MOZ_NO_REMOTE': '1', 22:14:58 INFO - 'NO_EM_RESTART': '1', 22:14:58 INFO - 'PAGER': '/bin/cat', 22:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:58 INFO - 'PWD': '/builds/slave/test', 22:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:14:58 INFO - 'SHELL': '/bin/bash', 22:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:14:58 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:14:58 INFO - 'USER': 'cltbld', 22:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:58 INFO - 'XPC_FLAGS': '0x0', 22:14:58 INFO - 'XPC_SERVICE_NAME': '0', 22:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:58 INFO - Downloading/unpacking blobuploader==1.2.4 22:14:58 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 22:14:58 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 22:14:58 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 22:14:58 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 22:14:58 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 22:14:58 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 22:15:01 INFO - Downloading blobuploader-1.2.4.tar.gz 22:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:15:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:15:01 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 22:15:01 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 22:15:01 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 22:15:01 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 22:15:01 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 22:15:01 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 22:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:15:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:02 INFO - Downloading docopt-0.6.1.tar.gz 22:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:15:02 INFO - Installing collected packages: blobuploader, requests, docopt 22:15:02 INFO - Running setup.py install for blobuploader 22:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:15:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:15:02 INFO - Running setup.py install for requests 22:15:03 INFO - Running setup.py install for docopt 22:15:03 INFO - Successfully installed blobuploader requests docopt 22:15:03 INFO - Cleaning up... 22:15:03 INFO - Return code: 0 22:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:03 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')]} 22:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:03 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')]} 22:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:03 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:15:03 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 22:15:03 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 22:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:15:03 INFO - 'HOME': '/Users/cltbld', 22:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:15:03 INFO - 'LOGNAME': 'cltbld', 22:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:03 INFO - 'MOZ_NO_REMOTE': '1', 22:15:03 INFO - 'NO_EM_RESTART': '1', 22:15:03 INFO - 'PAGER': '/bin/cat', 22:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:03 INFO - 'PWD': '/builds/slave/test', 22:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:15:03 INFO - 'SHELL': '/bin/bash', 22:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:15:03 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:15:03 INFO - 'USER': 'cltbld', 22:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:03 INFO - 'XPC_FLAGS': '0x0', 22:15:03 INFO - 'XPC_SERVICE_NAME': '0', 22:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-4hUK_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8psKNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:03 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-oL5pUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-QtUfvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-6HT4Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-XjTtah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-HpeoHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-NP18wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-JzSRWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wffT3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-GcBOnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:04 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-iEJolu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:05 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-iFB0M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:05 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wD1BJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:05 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-pveQIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:05 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LfrJFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:05 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-y0zbg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:15:05 INFO - Running setup.py install for manifestparser 22:15:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:15:05 INFO - Running setup.py install for mozcrash 22:15:05 INFO - Running setup.py install for mozdebug 22:15:05 INFO - Running setup.py install for mozdevice 22:15:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Running setup.py install for mozfile 22:15:06 INFO - Running setup.py install for mozhttpd 22:15:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Running setup.py install for mozinfo 22:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Running setup.py install for mozInstall 22:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:15:06 INFO - Running setup.py install for mozleak 22:15:06 INFO - Running setup.py install for mozlog 22:15:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:15:07 INFO - Running setup.py install for moznetwork 22:15:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:15:07 INFO - Running setup.py install for mozprocess 22:15:07 INFO - Running setup.py install for mozprofile 22:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:15:07 INFO - Running setup.py install for mozrunner 22:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:15:07 INFO - Running setup.py install for mozscreenshot 22:15:07 INFO - Running setup.py install for moztest 22:15:07 INFO - Running setup.py install for mozversion 22:15:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:15:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:15:08 INFO - Cleaning up... 22:15:08 INFO - Return code: 0 22:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:08 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:15:08 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 22:15:08 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 22:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:15:08 INFO - 'HOME': '/Users/cltbld', 22:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:15:08 INFO - 'LOGNAME': 'cltbld', 22:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:08 INFO - 'MOZ_NO_REMOTE': '1', 22:15:08 INFO - 'NO_EM_RESTART': '1', 22:15:08 INFO - 'PAGER': '/bin/cat', 22:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:08 INFO - 'PWD': '/builds/slave/test', 22:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:15:08 INFO - 'SHELL': '/bin/bash', 22:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:15:08 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:15:08 INFO - 'USER': 'cltbld', 22:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:08 INFO - 'XPC_FLAGS': '0x0', 22:15:08 INFO - 'XPC_SERVICE_NAME': '0', 22:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-mw_b2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:08 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)) 22:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Vft853-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 22:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gqkI9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:08 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)) 22:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-nUSTTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:08 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)) 22:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-trMC2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:08 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)) 22:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-YhJMqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-L6aQaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-GrjSoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-JwmpTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jxsfw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-qvnZsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Gfw32Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0PrM36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:09 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-dMLSFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 22:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:09 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-apL0TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:10 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)) 22:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:10 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A38ZgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:10 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)) 22:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:10 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kqSoFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:10 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)) 22:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:15:10 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)) 22:15:10 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)) 22:15:10 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)) 22:15:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:12 INFO - Downloading blessings-1.6.tar.gz 22:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:15:12 INFO - Installing collected packages: blessings 22:15:12 INFO - Running setup.py install for blessings 22:15:12 INFO - Successfully installed blessings 22:15:12 INFO - Cleaning up... 22:15:13 INFO - Return code: 0 22:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:13 INFO - Reading from file tmpfile_stdout 22:15:13 INFO - Current package versions: 22:15:13 INFO - blessings == 1.6 22:15:13 INFO - blobuploader == 1.2.4 22:15:13 INFO - docopt == 0.6.1 22:15:13 INFO - functools32 == 3.2.3-2 22:15:13 INFO - jsonschema == 2.5.1 22:15:13 INFO - manifestparser == 1.1 22:15:13 INFO - mozInstall == 1.12 22:15:13 INFO - mozcrash == 0.17 22:15:13 INFO - mozdebug == 0.1 22:15:13 INFO - mozdevice == 0.48 22:15:13 INFO - mozfile == 1.2 22:15:13 INFO - mozhttpd == 0.7 22:15:13 INFO - mozinfo == 0.9 22:15:13 INFO - mozleak == 0.1 22:15:13 INFO - mozlog == 3.4 22:15:13 INFO - moznetwork == 0.27 22:15:13 INFO - mozprocess == 0.23 22:15:13 INFO - mozprofile == 0.28 22:15:13 INFO - mozrunner == 6.12 22:15:13 INFO - mozscreenshot == 0.1 22:15:13 INFO - mozsystemmonitor == 0.3 22:15:13 INFO - moztest == 0.7 22:15:13 INFO - mozversion == 1.4 22:15:13 INFO - psutil == 3.1.1 22:15:13 INFO - requests == 1.2.3 22:15:13 INFO - wsgiref == 0.1.2 22:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:14 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 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:15:14 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 22:15:14 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 22:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:15:14 INFO - 'HOME': '/Users/cltbld', 22:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:15:14 INFO - 'LOGNAME': 'cltbld', 22:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:14 INFO - 'MOZ_NO_REMOTE': '1', 22:15:14 INFO - 'NO_EM_RESTART': '1', 22:15:14 INFO - 'PAGER': '/bin/cat', 22:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:14 INFO - 'PWD': '/builds/slave/test', 22:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:15:14 INFO - 'SHELL': '/bin/bash', 22:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:15:14 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:15:14 INFO - 'USER': 'cltbld', 22:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:14 INFO - 'XPC_FLAGS': '0x0', 22:15:14 INFO - 'XPC_SERVICE_NAME': '0', 22:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 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)) 22:15:14 INFO - Cleaning up... 22:15:14 INFO - Return code: 0 22:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa28bcc14b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, '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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 22:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:15:15 INFO - 'HOME': '/Users/cltbld', 22:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:15:15 INFO - 'LOGNAME': 'cltbld', 22:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:15 INFO - 'MOZ_NO_REMOTE': '1', 22:15:15 INFO - 'NO_EM_RESTART': '1', 22:15:15 INFO - 'PAGER': '/bin/cat', 22:15:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:15 INFO - 'PWD': '/builds/slave/test', 22:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:15:15 INFO - 'SHELL': '/bin/bash', 22:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:15:15 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:15:15 INFO - 'USER': 'cltbld', 22:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:15 INFO - 'XPC_FLAGS': '0x0', 22:15:15 INFO - 'XPC_SERVICE_NAME': '0', 22:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:15:15 INFO - Cleaning up... 22:15:15 INFO - Return code: 0 22:15:15 INFO - Running post-action listener: _resource_record_post_action 22:15:15 INFO - Running post-action listener: _start_resource_monitoring 22:15:15 INFO - Starting resource monitoring. 22:15:15 INFO - [mozharness: 2016-10-07 05:15:15.409618Z] Finished create-virtualenv step (success) 22:15:15 INFO - [mozharness: 2016-10-07 05:15:15.410565Z] Running install step. 22:15:15 INFO - Running pre-action listener: _resource_record_pre_action 22:15:15 INFO - Running main action method: install 22:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:15 INFO - Reading from file tmpfile_stdout 22:15:15 INFO - Detecting whether we're running mozinstall >=1.0... 22:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:15:15 INFO - Reading from file tmpfile_stdout 22:15:15 INFO - Output received: 22:15:15 INFO - Usage: mozinstall [options] installer 22:15:15 INFO - Options: 22:15:15 INFO - -h, --help show this help message and exit 22:15:15 INFO - -d DEST, --destination=DEST 22:15:15 INFO - Directory to install application into. [default: 22:15:15 INFO - "/builds/slave/test"] 22:15:15 INFO - --app=APP Application being installed. [default: firefox] 22:15:15 INFO - mkdir: /builds/slave/test/build/application 22:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:15:50 INFO - Reading from file tmpfile_stdout 22:15:50 INFO - Output received: 22:15:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:15:50 INFO - Running post-action listener: _resource_record_post_action 22:15:50 INFO - [mozharness: 2016-10-07 05:15:50.324807Z] Finished install step (success) 22:15:50 INFO - [mozharness: 2016-10-07 05:15:50.324965Z] Running run-tests step. 22:15:50 INFO - Running pre-action listener: _resource_record_pre_action 22:15:50 INFO - Running main action method: run_tests 22:15:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:15:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:15:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:15:50 INFO - 2016-10-06 22:15:50.339 screenresolution[1635:7634] starting screenresolution argv=screenresolution get 22:15:50 INFO - 2016-10-06 22:15:50.342 screenresolution[1635:7634] Display 0: 1600x1200x32@60 22:15:50 INFO - 2016-10-06 22:15:50.348 screenresolution[1636:7636] starting screenresolution argv=screenresolution list 22:15:50 INFO - Available Modes on Display 0 22:15:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:15:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:15:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:15:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:15:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:15:50 INFO - Intel Iris: 22:15:50 INFO - Chipset Model: Intel Iris 22:15:50 INFO - Type: GPU 22:15:50 INFO - Bus: Built-In 22:15:50 INFO - VRAM (Dynamic, Max): 1536 MB 22:15:50 INFO - Vendor: Intel (0x8086) 22:15:50 INFO - Device ID: 0x0a2e 22:15:50 INFO - Revision ID: 0x0009 22:15:50 INFO - Displays: 22:15:50 INFO - Display: 22:15:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:15:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:15:50 INFO - Display Serial Number: 1600x1200 60 22:15:50 INFO - Main Display: Yes 22:15:50 INFO - Mirror: Off 22:15:50 INFO - Online: Yes 22:15:50 INFO - Rotation: Supported 22:15:50 INFO - Return code: 0 22:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:15:50 INFO - Python 2.7.3 22:15:50 INFO - Return code: 0 22:15:50 INFO - grabbing minidump binary from tooltool 22:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:15:50 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 0x101a08d30>, '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 0x10182edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a00b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:15:50 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 22:15:50 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 22:15:50 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 22:15:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:15:50 INFO - Return code: 0 22:15:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:15:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:15:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:15:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:15:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 22:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 22:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WrAUWlSvTB/Render', 22:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:15:50 INFO - 'HOME': '/Users/cltbld', 22:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:15:50 INFO - 'LOGNAME': 'cltbld', 22:15:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:15:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:50 INFO - 'MOZ_NO_REMOTE': '1', 22:15:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:15:50 INFO - 'NO_EM_RESTART': '1', 22:15:50 INFO - 'PAGER': '/bin/cat', 22:15:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:50 INFO - 'PWD': '/builds/slave/test', 22:15:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:15:50 INFO - 'SHELL': '/bin/bash', 22:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p2CUyEDOaI/Listeners', 22:15:50 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 22:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:15:50 INFO - 'USER': 'cltbld', 22:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:50 INFO - 'XPC_FLAGS': '0x0', 22:15:50 INFO - 'XPC_SERVICE_NAME': '0', 22:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:15:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 22:15:50 INFO - mozversion application_buildid: 20161006195901 22:15:50 INFO - mozversion application_changeset: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 22:15:50 INFO - mozversion application_display_name: Nightly 22:15:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:15:50 INFO - mozversion application_name: Firefox 22:15:50 INFO - mozversion application_remotingname: firefox 22:15:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:15:50 INFO - mozversion application_vendor: Mozilla 22:15:50 INFO - mozversion application_version: 52.0a1 22:15:50 INFO - mozversion platform_buildid: 20161006195901 22:15:50 INFO - mozversion platform_changeset: a5b04b518afe0eadef15f5dd3e5e7a8408d75a67 22:15:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:15:50 INFO - mozversion platform_version: 52.0a1 22:15:50 INFO - using testdate: 1475817350 22:15:50 INFO - actual date: 1475817350 22:15:50 INFO - starting webserver on 'localhost:49272' 22:15:50 INFO - SUITE-START | Running 2 tests 22:15:50 INFO - TEST-START | dromaeo_css 22:15:50 INFO - operating with platform_type : mac_ 22:15:50 INFO - Initialising browser for dromaeo_css test... 22:15:50 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpW7bsjz/profile http://localhost:49272/getInfo.html) 22:15:53 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 22:15:53 INFO - PROCESS | 1646 | colorDepth:24 22:15:53 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 22:15:53 INFO - PROCESS | 1646 | __metrics 22:15:53 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:15:53 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:15:54 INFO - TEST-INFO | 1646: exit 0 22:15:54 INFO - Browser initialized. 22:15:54 INFO - Running cycle 1/1 for dromaeo_css test... 22:15:54 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpW7bsjz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:16:06 INFO - PROCESS | 1648 | RSS: Main: 235864064 22:16:06 INFO - PROCESS | 1648 | 22:16:57 INFO - PROCESS | 1648 | 1475817417325 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] 22:19:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 22:19:12 INFO - PROCESS | 1648 | RSS: Main: 340758528 22:19:12 INFO - PROCESS | 1648 | 22:22:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 22:22:15 INFO - PROCESS | 1648 | RSS: Main: 373665792 22:22:15 INFO - PROCESS | 1648 | 22:25:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 22:25:18 INFO - PROCESS | 1648 | RSS: Main: 359960576 22:25:18 INFO - PROCESS | 1648 | 22:28:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 22:28:21 INFO - PROCESS | 1648 | RSS: Main: 333324288 22:28:21 INFO - PROCESS | 1648 | 22:31:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 22:31:25 INFO - PROCESS | 1648 | RSS: Main: 324096000 22:31:25 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 22:34:29 INFO - PROCESS | 1648 | RSS: Main: 377364480 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | __start_tp_report 22:34:29 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 22:34:29 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 22:34:29 INFO - PROCESS | 1648 | |i|pagename|runs| 22:34:29 INFO - PROCESS | 1648 | |0;dojo.html;3294.044727029161;3320.30273642535;3322.5680661513998;3334.5998480182384;3385.018344680043;5405.918911216335;5492.835214943558;5608.46719561642;5675.687837168949;5704.37251902291;5579.218909352684;5585.720713964296;5641.746121424525;5704.714764261791;5712.400197979215;5024.095662780698;5110.616703747215;5134.845954621349;5160.690358578498;5224.63427560071;4757.976210118944;5226.398964119118;5232.424433312332;5261.158214685651;5345.4387289334645;5230.816921407752;5233.293505376763;5240.9213861792105;5270.868228294285;5327.946720532803;5067.923981140286;5150.96980603877;5153.3558305211845;5163.967206558666;5172.896542069175;5100.591952643779;5146.073706732786;5191.844244672666;5201.947980520222;5250.7637156328055;5558.944410555883;5585.776568937237;5598;5621.156826476021;5697.658140511582;6116.877662446771;6132.294786099611;6134.754609815602;6154.169187159721;6155.476784473325;6067.393260673942;6076.270847498285;6097.040762675677;6100.611450805989;6190.659513726743;5639.069553523664;5689.630174038674;5690.4025077367105;5704.942950570441;5706.172604972256;6298.622082675054;6308.968455157787;6310.242770867525;6315.652639104894;6319.494440444753;5138.2292656101135;5500.762328476061;5864.912026319608;5925.614835035795;6068.302145253352;6094.7432096071825;6125.693326622322;6174.228221472316;6175.96912015437;6228.719707613078;6148.985417406078;6158.846028849314;6163.445289923929;6165.229346331708;6168.228971378578;6063.757449701962;6144.446999770043;6147.116266092724;6170.7223174957235;6178.907316390258;4076.7553946762696;4780.498047704941;4845.394325709286;4846.418429788448;4913.115639184981;4386.912261754747;4393.055493068941;4403.14138742942;4475.1273501666865;4498.550144985541;4779.402574678165;5687.459691329317;5698.230738850285;5699.031164702011;5716.57125715573;5982.042873140276;6112.260323016922;6228.47058000066;6246.531510136758;6254.468370188494;5235;5597;5623.634463759924;5644.802431914945;5662.631928924607;5299.655522391109;5307.28351672527;5323.334583177103;5326.094563924142;5331.306930099062;6275.874482510324;6309.842253943688;6313.55805093639;6320.968395157995;6327.620342779448;5961.701914904151;6104.725287362168;6113.877722445615;6126.456603435028;6206.658633775005;6264.874702505833;6287.371262873676;6309.211348581427;6317.399847014526;6336.936630633634;6051.273847138372;6132.41742034506;6145.938540614716;6152.292486363946;6152.569320147547;6077.179580756541;6103.883205879467;6139.2325959255095;6224.502039836892;6238.875222495615;5955;5979.252593425822;6027.78902738402;6047.09293605945;6109.083637454418;6000.969995150171;6033.095035744674;6034.849128771816;6046.123312119806;6047.123167140828;5606.355269144101;5669.773209071756;5782.681952492653;5848.093545500455;5855.94144058571;5852.531797456279;5944.494717949023;5983.431574000463;5985.940140598713;6087.847803804941;5846.912296315644;5867.823965281048;5873.618214816023;5875.41245875409;5916.053431450947 22:34:29 INFO - PROCESS | 1648 | |1;ext.html;486.6496122791591;502.5928997512018;513.9999999999999;521.1895502493621;555.7415801652231;31056;36103;40534.59465405345;41913.58086419139;41959.160816783726;37675.811620941924;42026.73919782404;43064.3540346895;43230;43243.135137297235;9710.077542633457;9947.055029772197;9952.203823694088;9956.751081222956;9968;9679.661211857587;9784.461854597994;9785.266105042114;9795.706128816148;9806.754831129207;9673.467959262272;9725.805483890317;9729.173020293283;9737.172340351044;9755.317127801021;9764.267679923998;9781.559829807604;9824.803503929952;9825.066618671215;9870.555824987892;9748.561314740853;9759.853602195974;9833.606655733762;9836.950815245878;9847.90152098477;41282.38076428856;41620;41633.58366416327;41678.1664366714;41827.95430114241;3089.567460555524;3279.753044485966;3305.801651900894;3401.9149521262166;3571.2500374921296;30932;31947;32434.02697919066;32568.837155814304;32620.184495387566;3131.6711745266875;3166.414213370511;3306.504024396336;3335.5663763710804;3380.2056516718553;486105;487406;487464;488323.1167688313;494285;60981.695091525144;61182.694086529285;61267.6936615323;61496;61853.38146618566;53320.46679533233;64957.67521162364;64974.35025649683;64975.67512162409;65034.699306013616;16260.349586016664;16337.509874703777;16411.343546258016;16443;16443.506694799176;12637.557685481148;12720.491180352867;12742.745145097231;12757.68105797344;12765.808512872314;16406.09766462856;17173.57066073333;17796.644067118585;17821.7326740099;17872.195751191226;6118.785842495491;7396.408287337;7413.480236551494;7455.478116531791;7480;833.9583020848934;848.6930127603545;930.4649826349876;985.6550207427343;1055.3404122423485;29226.561601575995;30199;30335.696643033727;31005.689943100733;31006.68993310083;826.446280991737;871.8866547348804;925.6019911438011;1071.9517621707041;1102.2064113838023;15156.166410847289;15715.978461399973;15791.447299344467;15872.365105395886;16129.951553149007;601827;605787;609299;609853;618700;58384.57769645336;58453.415465844795;58512.707436462544;58519.53701157505;58529.707351462974;1229.6372570091844;1268.055298802398;1336.1048097774515;1377.7175678985784;1402.831660200762;26040.479190415706;28046.579301310903;30590.694093058784;31836.04491865248;32397;50818.237726434876;51394.71513212199;51476.742616286676;51508.74245628898;51510.48489515057;492084;493454;493814;496610;497783;25945.6108158374;26870.865645671645;26893;27779.722202777713;27796;47385.763071184425;47770.522294778;48312.758436207594;48748.75625621849;49268;39921.60078399295;39934.60065399309;40427;40479.638822577064;40960.38559421551;38833.80583097066;38952.41571376488;39270;40628.59371406248;40845.79577102095;38697.6130238694;39224.80387598044;39478.43390179629;39514.40728389134;39555;33644.99065028053;34992.65007349894;35089.47365789464;35310;35370.46944295889;20691;22102.00540975628;24260.908259128733;25469.87265063663;26352.604710929736 22:34:29 INFO - PROCESS | 1648 | |2;jquery.html;343.3013816882644;362.47260236356107;367.71502085883435;376.7231085152412;392.0121294338266;12796.91226245769;15025.39898404064;15148.999999999985;17030.063346515937;20373.796262037376;20307.289244876432;20317;20557.074931628074;20759.68860467094;21449.46376340592;5619.5785316101355;5864;5928.347881733006;6033.306169790487;6038.728257228435;5155.020546096249;5991.640501569898;6006.279246490405;6081.148639190517;6099.664518451484;5724.856878578027;6034.849128771794;6042.425969532887;6042.546808989321;6058.182145410357;5897.11543268511;6008.068749343859;6009.639421634716;6026.939730602681;6032.336442991267;5140.7172605506685;5178.844634660966;5185.274061631375;5195.324607801;5429.294191755086;13023.674408139777;13241;13288.202707837561;13325.933370333183;21233.68149477759;2062.2988184017354;2104.2424727098232;2174.1621454655897;2174.9782502175094;2369.7203510104523;9570.712878613653;9733.124018838338;10051.648192313234;10245.84631230532;10335.586576536929;1569.916757437376;1816.5458635341165;1923.3556758485925;2033.5627840014467;2045.4681782736448;117353.41323293414;118507;119981.80018199794;124706;129596;9447.669331573363;11144.665660030212;11393.316401015965;11575.363355015555;11787;14614.780778288334;14624.634384140481;14627.26863656813;14650.780238296435;14662.266886655625;8158.265756081981;8514.446560973516;8521.318294536422;8620.956895215484;8637.179467950535;7586.848263034708;7904.695725205392;8413.368997325226;8432.53621050848;8602.39783215169;3701.3892707702926;3982.984338993538;4184.184084103571;4521.886952826206;4614.215583350771;1751.9939669078833;1867.215769376865;1902.5719213177201;1920.308688872005;1932.4975506368446;735.577043200162;843.9915600844035;844.815047271782;876.6537217798933;947.9194268487256;20905.37283881486;21054;21201;21352.359429217147;21458.248961286594;870.7083127152348;907.1563445995156;919.048784508031;943.5612440215333;974.2985050763439;8227.876581851277;11006.95433933775;11111.72220694489;11189.608363707393;11194.720131996764;591393;600096;601029;607851;608036.8392632211;128091;135194;135342.32328838488;135632.32183839215;137816.31091844477;947.8767760191131;958.7315551645411;968.8885778135464;1030.1861529391697;1033.720895358249;16504.75242871382;18929.769564978233;20006.799932001075;20072.698909516075;20101.29645462402;57482.38952520346;57533.42466575448;57965;58413.70793146007;58424.123638144614;67439;68260.29349266308;81970;82982.58508707659;84430.57784711037;7875.8818617719635;8020.318272946864;8118.107008228972;8228.382871284797;8269.586520673822;10697.352775829067;12810.487580496676;13328.2669453181;13449.260290684106;13474.663133421744;9720.465374404193;10817.621383251548;11155.330680159217;11302.00496868314;11517;9944.403335799876;10839.729006774895;11005.478246960896;11335.773284534429;11594.88405115938;9771.462569558742;10912.597300078736;11017.054217435023;11281.71795705114;11880.702982425508;4422.889427764203;8055.436119471581;8075.111737708965;8201.876971845546;8279.089300176855;8197.549134797406;11159.888401115884;11202.887971120184;11478.368689722145;11771.470283837076 22:34:29 INFO - PROCESS | 1648 | |3;mootools.html;1445.2845841308554;1495.3943652820612;1529.8393668664787;1826.6985947318692;1880.116345317701;7754.418418618612;8022.277994980451;8282.213189746979;8766.56167191641;8775.166359195875;7927.445078844483;8335.458195217307;8537.10360412157;8559.529225892573;8651.221390074892;2301.907923683055;2329.988350058256;2332.8483648562874;2335.2877372401413;2340.531893621274;2069.430906500717;2300.7584203658625;2322.674825524428;2346.5216913344652;2351.447409858682;1900.2399040383818;1972.8520360972914;2334.171369163948;2336.894839732208;2338.567365037465;2274.977250227493;2289.702338695959;2294.231432470116;2301.7915594312954;2314.1900334882826;2271.4094335472732;2283.292179424384;2319.524497478013;2320.5358928214255;2321.3848330192513;8547.273481754059;8664.523451210182;8691.39160258782;8696.260817830493;8715.651373945035;4365.497967733688;5071.3153724247495;5214.661047031931;5224.111900976843;5224.294720212761;3345.9498107528407;3511.17487390463;3564.269324788412;3573.6426357364317;3577.5528058992627;1031.9948400258027;1063.3566692151292;1068.4283908109123;1086.8098082835552;1092.7814437112609;11182.049525790237;11240;11260.887391126065;11263.774724505463;11274.098072154207;4371.562843715603;4462.107578484316;4657.278121891045;4662.720236785736;4681.9297710534365;9701.6119355225;9706.951465242628;9710.271729620306;9721.805563888682;9740.977197394313;5230.3985041719925;5246.895062098737;5248.527632513092;5248.895022099537;5249.737513124329;4620.953790462119;4769.499202583748;4815.470298267188;4826.396700412449;4832.661713680009;3775.2638235544355;3786.4888240087785;3838.2707285615643;3885.747426417274;3914.706397020235;1153.7404084081184;1200.8078707406949;1227.5764861122898;1251.8122281657643;1276.6361586947862;646.1761254400677;712.9108861392326;732.7323729947221;742.3281929853491;756.277754744218;4338.893582136535;4640.257558790578;4722.952770472251;5332;5340.866478338073;782.6791015683656;901.2429559170329;937.1893312284825;994.1351024608637;1026.5226669598671;3736.3933508591567;3748.4002559590335;3759;3828.157805282833;3875.3218186817194;9528.333016688764;10100.898991010143;10196.898031019744;10564.366138031743;10575.41835199056;8830.42602230853;10437.060664540228;10536.10443112344;10554.736131596617;10578.841317380246;7788.260115289152;7963.880541791762;8099.878501822477;8122.675092996214;8124.22819832115;5147;5507.5593952484505;5587.832365029056;5639;5688.516476099412;7557;9504.192143667866;9643.469609171563;9725.562349694423;9775.120239178508;9383.483908385104;9669.98465161148;9869.407835529892;9999.450030248407;10017.248706346907;7256.637168141678;7446.813829654302;7460.813479663052;7462.626868656654;7464.514806537558;7966.322862556747;8281.875771863306;8300.916990830256;8320.750377488685;8423.368247381593;7318.048653674989;7393.593352365671;7416.4066874648815;7430.256974302527;7563.168051514219;6066.908996364969;7281.453890958305;7289.744858929912;7327.413806895543;7344.008558844701;6831.419329356861;6835.043093966749;6852.623105729033;6878.621675807879;6926.376626103674;4656.650751193606;4844.75776211181;4853.344798452164;4905.190643543775;4916.992016636653;4512.503624601357;4552.88617784558;4853.68661871795;4899.632527560376;5099.23511473282 22:34:29 INFO - PROCESS | 1648 | |4;prototype.html;299.1056740346364;301.2303564392975;309.5295151369918;314.56904041463184;316.90968074098885;4394.846180383687;4926.916078462741;5054.014467178901;5253.212018197272;5271.7891284348625;4608.400907881971;4848.551481501845;5044.722540260284;5114.667546609477;5160.980826216668;3669.935718641591;3725.590185079639;4032.495938007749;4036.9394459083137;4069.8168582413787;3175.793573417732;3516.1209697575605;4033.1530378620523;4045.9885028742815;4051.7568945863195;3587.5336206293146;3605.260921511097;3927.3519869221545;3941.3890846918775;3944.329463991114;3920.901977450558;3938.5273767147837;3945;3945.191235796655;3958.901027474293;2834.5889845972424;2886.5670149477537;3271.247613048988;3416.982915085409;3428.5371474850826;4282.972086699201;4308.116836048603;4839.491853355417;4966.354373931402;5026.346574945271;4497.460304763416;4507.166174257773;4515.864524064284;4547.477040140393;4552.430946131733;4608.603526166375;5156.788154783623;5435.320584926884;5473.67157970523;5530.5299049580835;3381.8647254109806;3500.844721241984;3753.474513568103;3757.210985693008;3782.508273924372;5648.774049038034;5670.886582268373;5707.1724599933195;5734.139879018139;5805.664697119686;3220.7745457817728;3452.913677158091;3766.7551609145316;3828.349180639298;3831.59768224338;3378.0034889707595;3405.591329040531;3625.057485053905;3878.3794592865006;3894.844206231776;4485.981308411228;4494;4504.373978946914;4507.4365704286965;4521.457425109008;4380.6933514653665;4838.395200599925;5535.557155427556;5563.666180029211;5614.9157762633595;1030.2479190191202;1211.3095535544655;1304.3869381390732;1319.2150670351125;1320.6727239124618;782.4710751113302;797.9640916158787;807.9052883343103;807.9757607271791;809.0372456776417;3782.583915769263;4212.841468596161;4255.340422234559;4263.658907287409;4310.706787963599;4522;4572.742495813612;4617.653675974316;4628.9537104628525;4640.3967484227505;3561.3233485637647;3599.8601608150834;3842.346801043829;4002.399640053957;4155.2602657608395;2097.8216851567786;2440.6217036359394;2659.255408485627;2953.8375389353364;2975.7619390449145;4935.284383764334;5108.17667858634;5744.454276843693;5791.913121303184;5792.754557770099;5182.119039763249;5749.195112684144;5760;5773.826785196451;5784.004518441131;5064.3034583414965;5368.624196306221;5789.363170051291;5867.970660146672;5869.236999189992;5593.9440605595055;5655.660660360227;5661.2923384576925;5685.635447492655;5689.800856969986;4923.901521969469;5208.895822083461;5511.090670039399;5578.693171875586;5597.80407685729;4770.0936822003705;5411.540019098421;5419.699272174728;5685.891251205975;5855.970720146543;3337.3992681317595;3554.306910152495;3621.0223239725656;3702.407614781622;3778.263238668433;5005.727264717004;5485.369182544058;5598.356189038313;5659.405762394889;5711.771529138788;4498.617617502549;5130.2817605536;5324.707141107121;5399.946000539944;5524.613277070566;4583.518730533246;4782.736949467673;5519.558435325244;5546.861328466821;5561.943230786138;4617.998301104309;5413.702246376487;5423.372988103632;5424.674519528841;5426.348838139448;4543.977280113579;5074.492550744896;5513;5517.668939863621;5531.419200983839;4336.674749393871;4692.835750748707;5403.64876283056;5430.212619170277;5444.891102178013 22:34:29 INFO - PROCESS | 1648 | |5;yui.html;708.0370695853638;710.7192658899735;763.5571368606209;811.6469335838907;821.6384790692096;15716.528504144866;16014.439494617662;16026.67946641068;16036.679266414665;16053.117078560674;14318.997670163068;14392.49626263081;14395.92802035991;14411.423543058292;14426.5672029839;666.2637785247292;688.4836372720459;689.348565605503;691.7717153339411;691.9827853056024;686.5503095472474;829.179112678447;859.0292968945115;863.0290922711949;863.2058506174303;901.9954900225523;906.0079213261469;916.6562539047857;917.5962576466367;919.9264058875274;911.6854685133618;913.1690161952591;913.2739472119681;913.7258822353301;915.2449229385717;520.1287842863227;535.9892802143975;673.1719984419192;673.5285300289817;674.1775034457953;12431.502739890393;12529.122961392706;12533;14271.215083170526;14853.405863765436;12247.632571022794;14277.428902843874;14846.925765371105;14969.176695281754;15237.847621523753;11484.966353028267;11857;11946.431517223838;12155.209911355734;12156.756864862653;3843.865464708722;3865.8840234793;3912.980435097806;4028;4033.8184781684895;111641.44179279133;113318;114956.42521787337;119117;121441;10379.325343852777;10428.687139385831;10429;10437.32157409766;10855.837162442569;23481.882590586938;23511.17710880111;23566.764332356455;23566.882165589406;23568.175113870933;8007.6796928123385;8079.878801817978;8115.634796434175;8150.144234855374;8384.958075209584;4359.651227901761;4462.553744625577;4512.120136573402;4602.976985115053;4669.579737823612;3617.7286703497343;3717.442383642421;3753.399456087013;3759.5300587426573;3762.887113386548;698.2005603583868;736.9815754606178;743.1008479739468;743.3867059675681;745.3329270303157;604.5647134063468;665.8368699668612;666.1573110015834;666.4335314982324;704.0706267726551;7599.544027358376;8084.39367047462;9395.497782810131;9571.18644915176;9651.758706032406;595.3243069116497;630.8202162383699;637.8964391602553;666.9699863506154;704.0882057735245;4063.4311196432523;4492.820287188541;4504.932426013613;4652.232381657056;4709.646776491777;73343;97536;115272;167751;172605;79597;102635;109445.90554094357;110628;140505.29747351402;78260;99185;99831.50084249678;109967.45016274868;110864;9325.533723313943;9340.673076442292;9491.05089491073;9699.792133035004;10034;49954.00183992745;57046.57383565444;58566.70716646389;59579.40420595912;59896;90354.54822725845;97166;97542.5122874381;99372;100887;10892.50983705751;12000.219985700902;13221.140625859289;13576.456941722221;13658.931705341409;11810.940945295219;14853.777193342325;15177.696446071237;15334.693306134039;15611.453599123975;12092.455839487067;13769.655758606115;13887.861121389062;13898.027138100237;14063.507777227747;13290.667733306746;13664.795028074786;13676.247806370746;14030.368633411725;14039.298035098409;13253.271070091238;13670.248136352198;14037.649058773612;14132.50536231227;14137.929310353382;9617.663381781604;11446.713832154262;11471.4264286787;11518.424078796193;11797.35114568707;11168.050715689258;11298.322100673986;11513.481893314989;11568.88431115678;11572.768544629229 22:34:29 INFO - PROCESS | 1648 | __end_tp_report 22:34:29 INFO - PROCESS | 1648 | __start_cc_report 22:34:29 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1658 22:34:29 INFO - PROCESS | 1648 | __end_cc_report 22:34:29 INFO - PROCESS | 1648 | __startTimestamp1475818469730__endTimestamp 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | ------- Summary: start ------- 22:34:29 INFO - PROCESS | 1648 | Number of tests: 6 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5659.84 Median:5852.53 stddev:640.79 (10.9%) stddev-sans-first:615.29 22:34:29 INFO - PROCESS | 1648 | Values: 3294.0 3320.3 3322.6 3334.6 3385.0 5405.9 5492.8 5608.5 5675.7 5704.4 5579.2 5585.7 5641.7 5704.7 5712.4 5024.1 5110.6 5134.8 5160.7 5224.6 4758.0 5226.4 5232.4 5261.2 5345.4 5230.8 5233.3 5240.9 5270.9 5327.9 5067.9 5151.0 5153.4 5164.0 5172.9 5100.6 5146.1 5191.8 5201.9 5250.8 5558.9 5585.8 5598.0 5621.2 5697.7 6116.9 6132.3 6134.8 6154.2 6155.5 6067.4 6076.3 6097.0 6100.6 6190.7 5639.1 5689.6 5690.4 5704.9 5706.2 6298.6 6309.0 6310.2 6315.7 6319.5 5138.2 5500.8 5864.9 5925.6 6068.3 6094.7 6125.7 6174.2 6176.0 6228.7 6149.0 6158.8 6163.4 6165.2 6168.2 6063.8 6144.4 6147.1 6170.7 6178.9 4076.8 4780.5 4845.4 4846.4 4913.1 4386.9 4393.1 4403.1 4475.1 4498.6 4779.4 5687.5 5698.2 5699.0 5716.6 5982.0 6112.3 6228.5 6246.5 6254.5 5235.0 5597.0 5623.6 5644.8 5662.6 5299.7 5307.3 5323.3 5326.1 5331.3 6275.9 6309.8 6313.6 6321.0 6327.6 5961.7 6104.7 6113.9 6126.5 6206.7 6264.9 6287.4 6309.2 6317.4 6336.9 6051.3 6132.4 6145.9 6152.3 6152.6 6077.2 6103.9 6139.2 6224.5 6238.9 5955.0 5979.3 6027.8 6047.1 6109.1 6001.0 6033.1 6034.8 6046.1 6047.1 5606.4 5669.8 5782.7 5848.1 5855.9 5852.5 5944.5 5983.4 5985.9 6087.8 5846.9 5867.8 5873.6 5875.4 5916.1 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:67292.21 Median:41753.06 stddev:142245.50 (340.7%) stddev-sans-first:142556.10 22:34:29 INFO - PROCESS | 1648 | Values: 486.6 502.6 514.0 521.2 555.7 31056.0 36103.0 40534.6 41913.6 41959.2 37675.8 42026.7 43064.4 43230.0 43243.1 9710.1 9947.1 9952.2 9956.8 9968.0 9679.7 9784.5 9785.3 9795.7 9806.8 9673.5 9725.8 9729.2 9737.2 9755.3 9764.3 9781.6 9824.8 9825.1 9870.6 9748.6 9759.9 9833.6 9837.0 9847.9 41282.4 41620.0 41633.6 41678.2 41828.0 3089.6 3279.8 3305.8 3401.9 3571.3 30932.0 31947.0 32434.0 32568.8 32620.2 3131.7 3166.4 3306.5 3335.6 3380.2 486105.0 487406.0 487464.0 488323.1 494285.0 60981.7 61182.7 61267.7 61496.0 61853.4 53320.5 64957.7 64974.4 64975.7 65034.7 16260.3 16337.5 16411.3 16443.0 16443.5 12637.6 12720.5 12742.7 12757.7 12765.8 16406.1 17173.6 17796.6 17821.7 17872.2 6118.8 7396.4 7413.5 7455.5 7480.0 834.0 848.7 930.5 985.7 1055.3 29226.6 30199.0 30335.7 31005.7 31006.7 826.4 871.9 925.6 1072.0 1102.2 15156.2 15716.0 15791.4 15872.4 16130.0 601827.0 605787.0 609299.0 609853.0 618700.0 58384.6 58453.4 58512.7 58519.5 58529.7 1229.6 1268.1 1336.1 1377.7 1402.8 26040.5 28046.6 30590.7 31836.0 32397.0 50818.2 51394.7 51476.7 51508.7 51510.5 492084.0 493454.0 493814.0 496610.0 497783.0 25945.6 26870.9 26893.0 27779.7 27796.0 47385.8 47770.5 48312.8 48748.8 49268.0 39921.6 39934.6 40427.0 40479.6 40960.4 38833.8 38952.4 39270.0 40628.6 40845.8 38697.6 39224.8 39478.4 39514.4 39555.0 33645.0 34992.7 35089.5 35310.0 35370.5 20691.0 22102.0 24260.9 25469.9 26352.6 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:35055.08 Median:365.09 stddev:100772.21 (27601.7%) stddev-sans-first:101021.20 22:34:29 INFO - PROCESS | 1648 | Values: 343.3 362.5 367.7 376.7 392.0 12796.9 15025.4 15149.0 17030.1 20373.8 20307.3 20317.0 20557.1 20759.7 21449.5 5619.6 5864.0 5928.3 6033.3 6038.7 5155.0 5991.6 6006.3 6081.1 6099.7 5724.9 6034.8 6042.4 6042.5 6058.2 5897.1 6008.1 6009.6 6026.9 6032.3 5140.7 5178.8 5185.3 5195.3 5429.3 13023.7 13241.0 13288.2 13325.9 21233.7 2062.3 2104.2 2174.2 2175.0 2369.7 9570.7 9733.1 10051.6 10245.8 10335.6 1569.9 1816.5 1923.4 2033.6 2045.5 117353.4 118507.0 119981.8 124706.0 129596.0 9447.7 11144.7 11393.3 11575.4 11787.0 14614.8 14624.6 14627.3 14650.8 14662.3 8158.3 8514.4 8521.3 8621.0 8637.2 7586.8 7904.7 8413.4 8432.5 8602.4 3701.4 3983.0 4184.2 4521.9 4614.2 1752.0 1867.2 1902.6 1920.3 1932.5 735.6 844.0 844.8 876.7 947.9 20905.4 21054.0 21201.0 21352.4 21458.2 870.7 907.2 919.0 943.6 974.3 8227.9 11007.0 11111.7 11189.6 11194.7 591393.0 600096.0 601029.0 607851.0 608036.8 128091.0 135194.0 135342.3 135632.3 137816.3 947.9 958.7 968.9 1030.2 1033.7 16504.8 18929.8 20006.8 20072.7 20101.3 57482.4 57533.4 57965.0 58413.7 58424.1 67439.0 68260.3 81970.0 82982.6 84430.6 7875.9 8020.3 8118.1 8228.4 8269.6 10697.4 12810.5 13328.3 13449.3 13474.7 9720.5 10817.6 11155.3 11302.0 11517.0 9944.4 10839.7 11005.5 11335.8 11594.9 9771.5 10912.6 11017.1 11281.7 11880.7 4422.9 8055.4 8075.1 8201.9 8279.1 8197.5 11159.9 11202.9 11478.4 11771.5 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5514.27 Median:4902.41 stddev:3094.71 (63.1%) stddev-sans-first:3088.29 22:34:29 INFO - PROCESS | 1648 | Values: 1445.3 1495.4 1529.8 1826.7 1880.1 7754.4 8022.3 8282.2 8766.6 8775.2 7927.4 8335.5 8537.1 8559.5 8651.2 2301.9 2330.0 2332.8 2335.3 2340.5 2069.4 2300.8 2322.7 2346.5 2351.4 1900.2 1972.9 2334.2 2336.9 2338.6 2275.0 2289.7 2294.2 2301.8 2314.2 2271.4 2283.3 2319.5 2320.5 2321.4 8547.3 8664.5 8691.4 8696.3 8715.7 4365.5 5071.3 5214.7 5224.1 5224.3 3345.9 3511.2 3564.3 3573.6 3577.6 1032.0 1063.4 1068.4 1086.8 1092.8 11182.0 11240.0 11260.9 11263.8 11274.1 4371.6 4462.1 4657.3 4662.7 4681.9 9701.6 9707.0 9710.3 9721.8 9741.0 5230.4 5246.9 5248.5 5248.9 5249.7 4621.0 4769.5 4815.5 4826.4 4832.7 3775.3 3786.5 3838.3 3885.7 3914.7 1153.7 1200.8 1227.6 1251.8 1276.6 646.2 712.9 732.7 742.3 756.3 4338.9 4640.3 4723.0 5332.0 5340.9 782.7 901.2 937.2 994.1 1026.5 3736.4 3748.4 3759.0 3828.2 3875.3 9528.3 10100.9 10196.9 10564.4 10575.4 8830.4 10437.1 10536.1 10554.7 10578.8 7788.3 7963.9 8099.9 8122.7 8124.2 5147.0 5507.6 5587.8 5639.0 5688.5 7557.0 9504.2 9643.5 9725.6 9775.1 9383.5 9670.0 9869.4 9999.5 10017.2 7256.6 7446.8 7460.8 7462.6 7464.5 7966.3 8281.9 8300.9 8320.8 8423.4 7318.0 7393.6 7416.4 7430.3 7563.2 6066.9 7281.5 7289.7 7327.4 7344.0 6831.4 6835.0 6852.6 6878.6 6926.4 4656.7 4844.8 4853.3 4905.2 4917.0 4512.5 4552.9 4853.7 4899.6 5099.2 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4306.05 Median:4608.50 stddev:1362.92 (29.6%) stddev-sans-first:1333.15 22:34:29 INFO - PROCESS | 1648 | Values: 299.1 301.2 309.5 314.6 316.9 4394.8 4926.9 5054.0 5253.2 5271.8 4608.4 4848.6 5044.7 5114.7 5161.0 3669.9 3725.6 4032.5 4036.9 4069.8 3175.8 3516.1 4033.2 4046.0 4051.8 3587.5 3605.3 3927.4 3941.4 3944.3 3920.9 3938.5 3945.0 3945.2 3958.9 2834.6 2886.6 3271.2 3417.0 3428.5 4283.0 4308.1 4839.5 4966.4 5026.3 4497.5 4507.2 4515.9 4547.5 4552.4 4608.6 5156.8 5435.3 5473.7 5530.5 3381.9 3500.8 3753.5 3757.2 3782.5 5648.8 5670.9 5707.2 5734.1 5805.7 3220.8 3452.9 3766.8 3828.3 3831.6 3378.0 3405.6 3625.1 3878.4 3894.8 4486.0 4494.0 4504.4 4507.4 4521.5 4380.7 4838.4 5535.6 5563.7 5614.9 1030.2 1211.3 1304.4 1319.2 1320.7 782.5 798.0 807.9 808.0 809.0 3782.6 4212.8 4255.3 4263.7 4310.7 4522.0 4572.7 4617.7 4629.0 4640.4 3561.3 3599.9 3842.3 4002.4 4155.3 2097.8 2440.6 2659.3 2953.8 2975.8 4935.3 5108.2 5744.5 5791.9 5792.8 5182.1 5749.2 5760.0 5773.8 5784.0 5064.3 5368.6 5789.4 5868.0 5869.2 5593.9 5655.7 5661.3 5685.6 5689.8 4923.9 5208.9 5511.1 5578.7 5597.8 4770.1 5411.5 5419.7 5685.9 5856.0 3337.4 3554.3 3621.0 3702.4 3778.3 5005.7 5485.4 5598.4 5659.4 5711.8 4498.6 5130.3 5324.7 5399.9 5524.6 4583.5 4782.7 5519.6 5546.9 5561.9 4618.0 5413.7 5423.4 5424.7 5426.3 4544.0 5074.5 5513.0 5517.7 5531.4 4336.7 4692.8 5403.6 5430.2 5444.9 22:34:29 INFO - PROCESS | 1648 | 22:34:29 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:23571.40 Median:3854.87 stddev:36920.61 (957.8%) stddev-sans-first:36984.27 22:34:29 INFO - PROCESS | 1648 | Values: 708.0 710.7 763.6 811.6 821.6 15716.5 16014.4 16026.7 16036.7 16053.1 14319.0 14392.5 14395.9 14411.4 14426.6 666.3 688.5 689.3 691.8 692.0 686.6 829.2 859.0 863.0 863.2 902.0 906.0 916.7 917.6 919.9 911.7 913.2 913.3 913.7 915.2 520.1 536.0 673.2 673.5 674.2 12431.5 12529.1 12533.0 14271.2 14853.4 12247.6 14277.4 14846.9 14969.2 15237.8 11485.0 11857.0 11946.4 12155.2 12156.8 3843.9 3865.9 3913.0 4028.0 4033.8 111641.4 113318.0 114956.4 119117.0 121441.0 10379.3 10428.7 10429.0 10437.3 10855.8 23481.9 23511.2 23566.8 23566.9 23568.2 8007.7 8079.9 8115.6 8150.1 8385.0 4359.7 4462.6 4512.1 4603.0 4669.6 3617.7 3717.4 3753.4 3759.5 3762.9 698.2 737.0 743.1 743.4 745.3 604.6 665.8 666.2 666.4 704.1 7599.5 8084.4 9395.5 9571.2 9651.8 595.3 630.8 637.9 667.0 704.1 4063.4 4492.8 4504.9 4652.2 4709.6 73343.0 97536.0 115272.0 167751.0 172605.0 79597.0 102635.0 109445.9 110628.0 140505.3 78260.0 99185.0 99831.5 109967.5 110864.0 9325.5 9340.7 9491.1 9699.8 10034.0 49954.0 57046.6 58566.7 59579.4 59896.0 90354.5 97166.0 97542.5 99372.0 100887.0 10892.5 12000.2 13221.1 13576.5 13658.9 11810.9 14853.8 15177.7 15334.7 15611.5 12092.5 13769.7 13887.9 13898.0 14063.5 13290.7 13664.8 13676.2 14030.4 14039.3 13253.3 13670.2 14037.6 14132.5 14137.9 9617.7 11446.7 11471.4 11518.4 11797.4 11168.1 11298.3 11513.5 11568.9 11572.8 22:34:29 INFO - PROCESS | 1648 | -------- Summary: end -------- 22:34:29 INFO - PROCESS | 1648 | 22:34:30 INFO - TEST-INFO | 1648: exit 0 22:34:30 INFO - TEST-OK | dromaeo_css | took 1119458ms 22:34:30 INFO - TEST-START | kraken 22:34:30 INFO - operating with platform_type : mac_ 22:34:30 INFO - Initialising browser for kraken test... 22:34:30 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmprgvdHE/profile http://localhost:49272/getInfo.html) 22:34:32 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 22:34:32 INFO - PROCESS | 1658 | colorDepth:24 22:34:32 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 22:34:32 INFO - PROCESS | 1658 | __metrics 22:34:32 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:34:32 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:34:33 INFO - TEST-INFO | 1658: exit 0 22:34:33 INFO - Browser initialized. 22:34:33 INFO - Running cycle 1/1 for kraken test... 22:34:33 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmprgvdHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:45 INFO - PROCESS | 1659 | RSS: Main: 236175360 22:34:45 INFO - PROCESS | 1659 | 22:34:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 22:34:49 INFO - PROCESS | 1659 | RSS: Main: 294502400 22:34:49 INFO - PROCESS | 1659 | 22:34:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 22:34:52 INFO - PROCESS | 1659 | RSS: Main: 294469632 22:34:52 INFO - PROCESS | 1659 | 22:34:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 22:34:56 INFO - PROCESS | 1659 | RSS: Main: 385249280 22:34:56 INFO - PROCESS | 1659 | 22:34:58 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 22:34:59 INFO - PROCESS | 1659 | RSS: Main: 286146560 22:34:59 INFO - PROCESS | 1659 | 22:35:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:35:01 INFO - PROCESS | 1659 | RSS: Main: 290750464 22:35:01 INFO - PROCESS | 1659 | 22:35:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 22:35:05 INFO - PROCESS | 1659 | RSS: Main: 328089600 22:35:05 INFO - PROCESS | 1659 | 22:35:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 22:35:08 INFO - PROCESS | 1659 | RSS: Main: 328564736 22:35:08 INFO - PROCESS | 1659 | 22:35:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 22:35:12 INFO - PROCESS | 1659 | RSS: Main: 325931008 22:35:12 INFO - PROCESS | 1659 | 22:35:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:35:14 INFO - PROCESS | 1659 | RSS: Main: 302628864 22:35:14 INFO - PROCESS | 1659 | 22:35:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:35:16 INFO - PROCESS | 1659 | RSS: Main: 304148480 22:35:16 INFO - PROCESS | 1659 | 22:35:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:35:19 INFO - PROCESS | 1659 | RSS: Main: 307380224 22:35:19 INFO - PROCESS | 1659 | 22:35:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:35:23 INFO - PROCESS | 1659 | RSS: Main: 319873024 22:35:23 INFO - PROCESS | 1659 | 22:35:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:35:27 INFO - PROCESS | 1659 | RSS: Main: 319893504 22:35:27 INFO - PROCESS | 1659 | 22:35:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 22:35:29 INFO - PROCESS | 1659 | RSS: Main: 364482560 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | __start_tp_report 22:35:29 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 22:35:29 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 22:35:29 INFO - PROCESS | 1659 | |i|pagename|runs| 22:35:29 INFO - PROCESS | 1659 | |0;ai-astar;113;112;110;110;111;112;112;112;111;112 22:35:29 INFO - PROCESS | 1659 | |1;audio-beat-detection;150;112;112;149;115;115;111;115;143;116 22:35:29 INFO - PROCESS | 1659 | |2;audio-dft;202;260;197;187;183;182;193;180;184;183 22:35:29 INFO - PROCESS | 1659 | |3;audio-fft;79;58;60;88;61;59;60;58;80;57 22:35:29 INFO - PROCESS | 1659 | |4;audio-oscillator;87;71;91;69;69;68;93;68;70;90 22:35:29 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;89;87;90;87;89;86;91;88;89;87 22:35:29 INFO - PROCESS | 1659 | |6;imaging-darkroom;133;149;95;112;149;107;95;95;114;124 22:35:29 INFO - PROCESS | 1659 | |7;imaging-desaturate;86;84;83;86;84;84;84;85;86;83 22:35:29 INFO - PROCESS | 1659 | |8;json-parse-financial;57;56;54;55;55;54;53;53;55;54 22:35:29 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;63;72;75;74;74;70;70;69;69;71 22:35:29 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;85;88;86;89;85;81;84;78;95;100 22:35:29 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;144;146;146;163;161;157;147;150;209;157 22:35:29 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;217;174;174;177;172;170;172;171;171;167 22:35:29 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;69;69;69;68;68;69;68;69;69;69 22:35:29 INFO - PROCESS | 1659 | __end_tp_report 22:35:29 INFO - PROCESS | 1659 | __start_cc_report 22:35:29 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1933 22:35:29 INFO - PROCESS | 1659 | __end_cc_report 22:35:29 INFO - PROCESS | 1659 | __startTimestamp1475818529053__endTimestamp 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | ------- Summary: start ------- 22:35:29 INFO - PROCESS | 1659 | Number of tests: 14 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:0.87 22:35:29 INFO - PROCESS | 1659 | Values: 113.0 112.0 110.0 110.0 111.0 112.0 112.0 112.0 111.0 112.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:115.50 stddev:16.42 (14.2%) stddev-sans-first:14.42 22:35:29 INFO - PROCESS | 1659 | Values: 150.0 112.0 112.0 149.0 115.0 115.0 111.0 115.0 143.0 116.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:195.10 Median:190.00 stddev:23.92 (12.6%) stddev-sans-first:25.24 22:35:29 INFO - PROCESS | 1659 | Values: 202.0 260.0 197.0 187.0 183.0 182.0 193.0 180.0 184.0 183.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:11.57 (19.1%) stddev-sans-first:11.27 22:35:29 INFO - PROCESS | 1659 | Values: 79.0 58.0 60.0 88.0 61.0 59.0 60.0 58.0 80.0 57.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.00 stddev:11.02 (13.9%) stddev-sans-first:11.15 22:35:29 INFO - PROCESS | 1659 | Values: 87.0 71.0 91.0 69.0 69.0 68.0 93.0 68.0 70.0 90.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.57 (1.8%) stddev-sans-first:1.64 22:35:29 INFO - PROCESS | 1659 | Values: 89.0 87.0 90.0 87.0 89.0 86.0 91.0 88.0 89.0 87.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:117.30 Median:149.00 stddev:20.92 (14.0%) stddev-sans-first:21.40 22:35:29 INFO - PROCESS | 1659 | Values: 133.0 149.0 95.0 112.0 149.0 107.0 95.0 95.0 114.0 124.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:1.18 (1.4%) stddev-sans-first:1.12 22:35:29 INFO - PROCESS | 1659 | Values: 86.0 84.0 83.0 86.0 84.0 84.0 84.0 85.0 86.0 83.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.26 (2.3%) stddev-sans-first:1.00 22:35:29 INFO - PROCESS | 1659 | Values: 57.0 56.0 54.0 55.0 55.0 54.0 53.0 53.0 55.0 54.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.50 stddev:3.47 (4.8%) stddev-sans-first:2.30 22:35:29 INFO - PROCESS | 1659 | Values: 63.0 72.0 75.0 74.0 74.0 70.0 70.0 69.0 69.0 71.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.50 stddev:6.44 (7.5%) stddev-sans-first:6.78 22:35:29 INFO - PROCESS | 1659 | Values: 85.0 88.0 86.0 89.0 85.0 81.0 84.0 78.0 95.0 100.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:158.00 Median:157.00 stddev:19.17 (12.2%) stddev-sans-first:19.65 22:35:29 INFO - PROCESS | 1659 | Values: 144.0 146.0 146.0 163.0 161.0 157.0 147.0 150.0 209.0 157.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:173.00 stddev:14.48 (8.4%) stddev-sans-first:2.83 22:35:29 INFO - PROCESS | 1659 | Values: 217.0 174.0 174.0 177.0 172.0 170.0 172.0 171.0 171.0 167.0 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 22:35:29 INFO - PROCESS | 1659 | Values: 69.0 69.0 69.0 68.0 68.0 69.0 68.0 69.0 69.0 69.0 22:35:29 INFO - PROCESS | 1659 | -------- Summary: end -------- 22:35:29 INFO - PROCESS | 1659 | 22:35:29 INFO - TEST-INFO | 1659: exit 0 22:35:29 INFO - TEST-OK | kraken | took 59538ms 22:35:29 INFO - SUITE-END | took 1178s 22:35:30 INFO - Completed test suite (00:19:39) 22:35:30 INFO - javascript benchmark 22:35:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.044727029161, 3320.30273642535, 3322.5680661513998, 3334.5998480182384, 3385.018344680043, 5405.918911216335, 5492.835214943558, 5608.46719561642, 5675.687837168949, 5704.37251902291, 5579.218909352684, 5585.720713964296, 5641.746121424525, 5704.714764261791, 5712.400197979215, 5024.095662780698, 5110.616703747215, 5134.845954621349, 5160.690358578498, 5224.63427560071, 4757.976210118944, 5226.398964119118, 5232.424433312332, 5261.158214685651, 5345.4387289334645, 5230.816921407752, 5233.293505376763, 5240.9213861792105, 5270.868228294285, 5327.946720532803, 5067.923981140286, 5150.96980603877, 5153.3558305211845, 5163.967206558666, 5172.896542069175, 5100.591952643779, 5146.073706732786, 5191.844244672666, 5201.947980520222, 5250.7637156328055, 5558.944410555883, 5585.776568937237, 5598.0, 5621.156826476021, 5697.658140511582, 6116.877662446771, 6132.294786099611, 6134.754609815602, 6154.169187159721, 6155.476784473325, 6067.393260673942, 6076.270847498285, 6097.040762675677, 6100.611450805989, 6190.659513726743, 5639.069553523664, 5689.630174038674, 5690.4025077367105, 5704.942950570441, 5706.172604972256, 6298.622082675054, 6308.968455157787, 6310.242770867525, 6315.652639104894, 6319.494440444753, 5138.2292656101135, 5500.762328476061, 5864.912026319608, 5925.614835035795, 6068.302145253352, 6094.7432096071825, 6125.693326622322, 6174.228221472316, 6175.96912015437, 6228.719707613078, 6148.985417406078, 6158.846028849314, 6163.445289923929, 6165.229346331708, 6168.228971378578, 6063.757449701962, 6144.446999770043, 6147.116266092724, 6170.7223174957235, 6178.907316390258, 4076.7553946762696, 4780.498047704941, 4845.394325709286, 4846.418429788448, 4913.115639184981, 4386.912261754747, 4393.055493068941, 4403.14138742942, 4475.1273501666865, 4498.550144985541, 4779.402574678165, 5687.459691329317, 5698.230738850285, 5699.031164702011, 5716.57125715573, 5982.042873140276, 6112.260323016922, 6228.47058000066, 6246.531510136758, 6254.468370188494, 5235.0, 5597.0, 5623.634463759924, 5644.802431914945, 5662.631928924607, 5299.655522391109, 5307.28351672527, 5323.334583177103, 5326.094563924142, 5331.306930099062, 6275.874482510324, 6309.842253943688, 6313.55805093639, 6320.968395157995, 6327.620342779448, 5961.701914904151, 6104.725287362168, 6113.877722445615, 6126.456603435028, 6206.658633775005, 6264.874702505833, 6287.371262873676, 6309.211348581427, 6317.399847014526, 6336.936630633634, 6051.273847138372, 6132.41742034506, 6145.938540614716, 6152.292486363946, 6152.569320147547, 6077.179580756541, 6103.883205879467, 6139.2325959255095, 6224.502039836892, 6238.875222495615, 5955.0, 5979.252593425822, 6027.78902738402, 6047.09293605945, 6109.083637454418, 6000.969995150171, 6033.095035744674, 6034.849128771816, 6046.123312119806, 6047.123167140828, 5606.355269144101, 5669.773209071756, 5782.681952492653, 5848.093545500455, 5855.94144058571, 5852.531797456279, 5944.494717949023, 5983.431574000463, 5985.940140598713, 6087.847803804941, 5846.912296315644, 5867.823965281048, 5873.618214816023, 5875.41245875409, 5916.053431450947], "value": 5618.780286132538, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.6496122791591, 502.5928997512018, 513.9999999999999, 521.1895502493621, 555.7415801652231, 31056.0, 36103.0, 40534.59465405345, 41913.58086419139, 41959.160816783726, 37675.811620941924, 42026.73919782404, 43064.3540346895, 43230.0, 43243.135137297235, 9710.077542633457, 9947.055029772197, 9952.203823694088, 9956.751081222956, 9968.0, 9679.661211857587, 9784.461854597994, 9785.266105042114, 9795.706128816148, 9806.754831129207, 9673.467959262272, 9725.805483890317, 9729.173020293283, 9737.172340351044, 9755.317127801021, 9764.267679923998, 9781.559829807604, 9824.803503929952, 9825.066618671215, 9870.555824987892, 9748.561314740853, 9759.853602195974, 9833.606655733762, 9836.950815245878, 9847.90152098477, 41282.38076428856, 41620.0, 41633.58366416327, 41678.1664366714, 41827.95430114241, 3089.567460555524, 3279.753044485966, 3305.801651900894, 3401.9149521262166, 3571.2500374921296, 30932.0, 31947.0, 32434.02697919066, 32568.837155814304, 32620.184495387566, 3131.6711745266875, 3166.414213370511, 3306.504024396336, 3335.5663763710804, 3380.2056516718553, 486105.0, 487406.0, 487464.0, 488323.1167688313, 494285.0, 60981.695091525144, 61182.694086529285, 61267.6936615323, 61496.0, 61853.38146618566, 53320.46679533233, 64957.67521162364, 64974.35025649683, 64975.67512162409, 65034.699306013616, 16260.349586016664, 16337.509874703777, 16411.343546258016, 16443.0, 16443.506694799176, 12637.557685481148, 12720.491180352867, 12742.745145097231, 12757.68105797344, 12765.808512872314, 16406.09766462856, 17173.57066073333, 17796.644067118585, 17821.7326740099, 17872.195751191226, 6118.785842495491, 7396.408287337, 7413.480236551494, 7455.478116531791, 7480.0, 833.9583020848934, 848.6930127603545, 930.4649826349876, 985.6550207427343, 1055.3404122423485, 29226.561601575995, 30199.0, 30335.696643033727, 31005.689943100733, 31006.68993310083, 826.446280991737, 871.8866547348804, 925.6019911438011, 1071.9517621707041, 1102.2064113838023, 15156.166410847289, 15715.978461399973, 15791.447299344467, 15872.365105395886, 16129.951553149007, 601827.0, 605787.0, 609299.0, 609853.0, 618700.0, 58384.57769645336, 58453.415465844795, 58512.707436462544, 58519.53701157505, 58529.707351462974, 1229.6372570091844, 1268.055298802398, 1336.1048097774515, 1377.7175678985784, 1402.831660200762, 26040.479190415706, 28046.579301310903, 30590.694093058784, 31836.04491865248, 32397.0, 50818.237726434876, 51394.71513212199, 51476.742616286676, 51508.74245628898, 51510.48489515057, 492084.0, 493454.0, 493814.0, 496610.0, 497783.0, 25945.6108158374, 26870.865645671645, 26893.0, 27779.722202777713, 27796.0, 47385.763071184425, 47770.522294778, 48312.758436207594, 48748.75625621849, 49268.0, 39921.60078399295, 39934.60065399309, 40427.0, 40479.638822577064, 40960.38559421551, 38833.80583097066, 38952.41571376488, 39270.0, 40628.59371406248, 40845.79577102095, 38697.6130238694, 39224.80387598044, 39478.43390179629, 39514.40728389134, 39555.0, 33644.99065028053, 34992.65007349894, 35089.47365789464, 35310.0, 35370.46944295889, 20691.0, 22102.00540975628, 24260.908259128733, 25469.87265063663, 26352.604710929736], "value": 19881.279438237147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.3013816882644, 362.47260236356107, 367.71502085883435, 376.7231085152412, 392.0121294338266, 12796.91226245769, 15025.39898404064, 15148.999999999985, 17030.063346515937, 20373.796262037376, 20307.289244876432, 20317.0, 20557.074931628074, 20759.68860467094, 21449.46376340592, 5619.5785316101355, 5864.0, 5928.347881733006, 6033.306169790487, 6038.728257228435, 5155.020546096249, 5991.640501569898, 6006.279246490405, 6081.148639190517, 6099.664518451484, 5724.856878578027, 6034.849128771794, 6042.425969532887, 6042.546808989321, 6058.182145410357, 5897.11543268511, 6008.068749343859, 6009.639421634716, 6026.939730602681, 6032.336442991267, 5140.7172605506685, 5178.844634660966, 5185.274061631375, 5195.324607801, 5429.294191755086, 13023.674408139777, 13241.0, 13288.202707837561, 13325.933370333183, 21233.68149477759, 2062.2988184017354, 2104.2424727098232, 2174.1621454655897, 2174.9782502175094, 2369.7203510104523, 9570.712878613653, 9733.124018838338, 10051.648192313234, 10245.84631230532, 10335.586576536929, 1569.916757437376, 1816.5458635341165, 1923.3556758485925, 2033.5627840014467, 2045.4681782736448, 117353.41323293414, 118507.0, 119981.80018199794, 124706.0, 129596.0, 9447.669331573363, 11144.665660030212, 11393.316401015965, 11575.363355015555, 11787.0, 14614.780778288334, 14624.634384140481, 14627.26863656813, 14650.780238296435, 14662.266886655625, 8158.265756081981, 8514.446560973516, 8521.318294536422, 8620.956895215484, 8637.179467950535, 7586.848263034708, 7904.695725205392, 8413.368997325226, 8432.53621050848, 8602.39783215169, 3701.3892707702926, 3982.984338993538, 4184.184084103571, 4521.886952826206, 4614.215583350771, 1751.9939669078833, 1867.215769376865, 1902.5719213177201, 1920.308688872005, 1932.4975506368446, 735.577043200162, 843.9915600844035, 844.815047271782, 876.6537217798933, 947.9194268487256, 20905.37283881486, 21054.0, 21201.0, 21352.359429217147, 21458.248961286594, 870.7083127152348, 907.1563445995156, 919.048784508031, 943.5612440215333, 974.2985050763439, 8227.876581851277, 11006.95433933775, 11111.72220694489, 11189.608363707393, 11194.720131996764, 591393.0, 600096.0, 601029.0, 607851.0, 608036.8392632211, 128091.0, 135194.0, 135342.32328838488, 135632.32183839215, 137816.31091844477, 947.8767760191131, 958.7315551645411, 968.8885778135464, 1030.1861529391697, 1033.720895358249, 16504.75242871382, 18929.769564978233, 20006.799932001075, 20072.698909516075, 20101.29645462402, 57482.38952520346, 57533.42466575448, 57965.0, 58413.70793146007, 58424.123638144614, 67439.0, 68260.29349266308, 81970.0, 82982.58508707659, 84430.57784711037, 7875.8818617719635, 8020.318272946864, 8118.107008228972, 8228.382871284797, 8269.586520673822, 10697.352775829067, 12810.487580496676, 13328.2669453181, 13449.260290684106, 13474.663133421744, 9720.465374404193, 10817.621383251548, 11155.330680159217, 11302.00496868314, 11517.0, 9944.403335799876, 10839.729006774895, 11005.478246960896, 11335.773284534429, 11594.88405115938, 9771.462569558742, 10912.597300078736, 11017.054217435023, 11281.71795705114, 11880.702982425508, 4422.889427764203, 8055.436119471581, 8075.111737708965, 8201.876971845546, 8279.089300176855, 8197.549134797406, 11159.888401115884, 11202.887971120184, 11478.368689722145, 11771.470283837076], "value": 9278.493857036792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.2845841308554, 1495.3943652820612, 1529.8393668664787, 1826.6985947318692, 1880.116345317701, 7754.418418618612, 8022.277994980451, 8282.213189746979, 8766.56167191641, 8775.166359195875, 7927.445078844483, 8335.458195217307, 8537.10360412157, 8559.529225892573, 8651.221390074892, 2301.907923683055, 2329.988350058256, 2332.8483648562874, 2335.2877372401413, 2340.531893621274, 2069.430906500717, 2300.7584203658625, 2322.674825524428, 2346.5216913344652, 2351.447409858682, 1900.2399040383818, 1972.8520360972914, 2334.171369163948, 2336.894839732208, 2338.567365037465, 2274.977250227493, 2289.702338695959, 2294.231432470116, 2301.7915594312954, 2314.1900334882826, 2271.4094335472732, 2283.292179424384, 2319.524497478013, 2320.5358928214255, 2321.3848330192513, 8547.273481754059, 8664.523451210182, 8691.39160258782, 8696.260817830493, 8715.651373945035, 4365.497967733688, 5071.3153724247495, 5214.661047031931, 5224.111900976843, 5224.294720212761, 3345.9498107528407, 3511.17487390463, 3564.269324788412, 3573.6426357364317, 3577.5528058992627, 1031.9948400258027, 1063.3566692151292, 1068.4283908109123, 1086.8098082835552, 1092.7814437112609, 11182.049525790237, 11240.0, 11260.887391126065, 11263.774724505463, 11274.098072154207, 4371.562843715603, 4462.107578484316, 4657.278121891045, 4662.720236785736, 4681.9297710534365, 9701.6119355225, 9706.951465242628, 9710.271729620306, 9721.805563888682, 9740.977197394313, 5230.3985041719925, 5246.895062098737, 5248.527632513092, 5248.895022099537, 5249.737513124329, 4620.953790462119, 4769.499202583748, 4815.470298267188, 4826.396700412449, 4832.661713680009, 3775.2638235544355, 3786.4888240087785, 3838.2707285615643, 3885.747426417274, 3914.706397020235, 1153.7404084081184, 1200.8078707406949, 1227.5764861122898, 1251.8122281657643, 1276.6361586947862, 646.1761254400677, 712.9108861392326, 732.7323729947221, 742.3281929853491, 756.277754744218, 4338.893582136535, 4640.257558790578, 4722.952770472251, 5332.0, 5340.866478338073, 782.6791015683656, 901.2429559170329, 937.1893312284825, 994.1351024608637, 1026.5226669598671, 3736.3933508591567, 3748.4002559590335, 3759.0, 3828.157805282833, 3875.3218186817194, 9528.333016688764, 10100.898991010143, 10196.898031019744, 10564.366138031743, 10575.41835199056, 8830.42602230853, 10437.060664540228, 10536.10443112344, 10554.736131596617, 10578.841317380246, 7788.260115289152, 7963.880541791762, 8099.878501822477, 8122.675092996214, 8124.22819832115, 5147.0, 5507.5593952484505, 5587.832365029056, 5639.0, 5688.516476099412, 7557.0, 9504.192143667866, 9643.469609171563, 9725.562349694423, 9775.120239178508, 9383.483908385104, 9669.98465161148, 9869.407835529892, 9999.450030248407, 10017.248706346907, 7256.637168141678, 7446.813829654302, 7460.813479663052, 7462.626868656654, 7464.514806537558, 7966.322862556747, 8281.875771863306, 8300.916990830256, 8320.750377488685, 8423.368247381593, 7318.048653674989, 7393.593352365671, 7416.4066874648815, 7430.256974302527, 7563.168051514219, 6066.908996364969, 7281.453890958305, 7289.744858929912, 7327.413806895543, 7344.008558844701, 6831.419329356861, 6835.043093966749, 6852.623105729033, 6878.621675807879, 6926.376626103674, 4656.650751193606, 4844.75776211181, 4853.344798452164, 4905.190643543775, 4916.992016636653, 4512.503624601357, 4552.88617784558, 4853.68661871795, 4899.632527560376, 5099.23511473282], "value": 4422.081929660673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.1056740346364, 301.2303564392975, 309.5295151369918, 314.56904041463184, 316.90968074098885, 4394.846180383687, 4926.916078462741, 5054.014467178901, 5253.212018197272, 5271.7891284348625, 4608.400907881971, 4848.551481501845, 5044.722540260284, 5114.667546609477, 5160.980826216668, 3669.935718641591, 3725.590185079639, 4032.495938007749, 4036.9394459083137, 4069.8168582413787, 3175.793573417732, 3516.1209697575605, 4033.1530378620523, 4045.9885028742815, 4051.7568945863195, 3587.5336206293146, 3605.260921511097, 3927.3519869221545, 3941.3890846918775, 3944.329463991114, 3920.901977450558, 3938.5273767147837, 3945.0, 3945.191235796655, 3958.901027474293, 2834.5889845972424, 2886.5670149477537, 3271.247613048988, 3416.982915085409, 3428.5371474850826, 4282.972086699201, 4308.116836048603, 4839.491853355417, 4966.354373931402, 5026.346574945271, 4497.460304763416, 4507.166174257773, 4515.864524064284, 4547.477040140393, 4552.430946131733, 4608.603526166375, 5156.788154783623, 5435.320584926884, 5473.67157970523, 5530.5299049580835, 3381.8647254109806, 3500.844721241984, 3753.474513568103, 3757.210985693008, 3782.508273924372, 5648.774049038034, 5670.886582268373, 5707.1724599933195, 5734.139879018139, 5805.664697119686, 3220.7745457817728, 3452.913677158091, 3766.7551609145316, 3828.349180639298, 3831.59768224338, 3378.0034889707595, 3405.591329040531, 3625.057485053905, 3878.3794592865006, 3894.844206231776, 4485.981308411228, 4494.0, 4504.373978946914, 4507.4365704286965, 4521.457425109008, 4380.6933514653665, 4838.395200599925, 5535.557155427556, 5563.666180029211, 5614.9157762633595, 1030.2479190191202, 1211.3095535544655, 1304.3869381390732, 1319.2150670351125, 1320.6727239124618, 782.4710751113302, 797.9640916158787, 807.9052883343103, 807.9757607271791, 809.0372456776417, 3782.583915769263, 4212.841468596161, 4255.340422234559, 4263.658907287409, 4310.706787963599, 4522.0, 4572.742495813612, 4617.653675974316, 4628.9537104628525, 4640.3967484227505, 3561.3233485637647, 3599.8601608150834, 3842.346801043829, 4002.399640053957, 4155.2602657608395, 2097.8216851567786, 2440.6217036359394, 2659.255408485627, 2953.8375389353364, 2975.7619390449145, 4935.284383764334, 5108.17667858634, 5744.454276843693, 5791.913121303184, 5792.754557770099, 5182.119039763249, 5749.195112684144, 5760.0, 5773.826785196451, 5784.004518441131, 5064.3034583414965, 5368.624196306221, 5789.363170051291, 5867.970660146672, 5869.236999189992, 5593.9440605595055, 5655.660660360227, 5661.2923384576925, 5685.635447492655, 5689.800856969986, 4923.901521969469, 5208.895822083461, 5511.090670039399, 5578.693171875586, 5597.80407685729, 4770.0936822003705, 5411.540019098421, 5419.699272174728, 5685.891251205975, 5855.970720146543, 3337.3992681317595, 3554.306910152495, 3621.0223239725656, 3702.407614781622, 3778.263238668433, 5005.727264717004, 5485.369182544058, 5598.356189038313, 5659.405762394889, 5711.771529138788, 4498.617617502549, 5130.2817605536, 5324.707141107121, 5399.946000539944, 5524.613277070566, 4583.518730533246, 4782.736949467673, 5519.558435325244, 5546.861328466821, 5561.943230786138, 4617.998301104309, 5413.702246376487, 5423.372988103632, 5424.674519528841, 5426.348838139448, 4543.977280113579, 5074.492550744896, 5513.0, 5517.668939863621, 5531.419200983839, 4336.674749393871, 4692.835750748707, 5403.64876283056, 5430.212619170277, 5444.891102178013], "value": 3876.310767548033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.0370695853638, 710.7192658899735, 763.5571368606209, 811.6469335838907, 821.6384790692096, 15716.528504144866, 16014.439494617662, 16026.67946641068, 16036.679266414665, 16053.117078560674, 14318.997670163068, 14392.49626263081, 14395.92802035991, 14411.423543058292, 14426.5672029839, 666.2637785247292, 688.4836372720459, 689.348565605503, 691.7717153339411, 691.9827853056024, 686.5503095472474, 829.179112678447, 859.0292968945115, 863.0290922711949, 863.2058506174303, 901.9954900225523, 906.0079213261469, 916.6562539047857, 917.5962576466367, 919.9264058875274, 911.6854685133618, 913.1690161952591, 913.2739472119681, 913.7258822353301, 915.2449229385717, 520.1287842863227, 535.9892802143975, 673.1719984419192, 673.5285300289817, 674.1775034457953, 12431.502739890393, 12529.122961392706, 12533.0, 14271.215083170526, 14853.405863765436, 12247.632571022794, 14277.428902843874, 14846.925765371105, 14969.176695281754, 15237.847621523753, 11484.966353028267, 11857.0, 11946.431517223838, 12155.209911355734, 12156.756864862653, 3843.865464708722, 3865.8840234793, 3912.980435097806, 4028.0, 4033.8184781684895, 111641.44179279133, 113318.0, 114956.42521787337, 119117.0, 121441.0, 10379.325343852777, 10428.687139385831, 10429.0, 10437.32157409766, 10855.837162442569, 23481.882590586938, 23511.17710880111, 23566.764332356455, 23566.882165589406, 23568.175113870933, 8007.6796928123385, 8079.878801817978, 8115.634796434175, 8150.144234855374, 8384.958075209584, 4359.651227901761, 4462.553744625577, 4512.120136573402, 4602.976985115053, 4669.579737823612, 3617.7286703497343, 3717.442383642421, 3753.399456087013, 3759.5300587426573, 3762.887113386548, 698.2005603583868, 736.9815754606178, 743.1008479739468, 743.3867059675681, 745.3329270303157, 604.5647134063468, 665.8368699668612, 666.1573110015834, 666.4335314982324, 704.0706267726551, 7599.544027358376, 8084.39367047462, 9395.497782810131, 9571.18644915176, 9651.758706032406, 595.3243069116497, 630.8202162383699, 637.8964391602553, 666.9699863506154, 704.0882057735245, 4063.4311196432523, 4492.820287188541, 4504.932426013613, 4652.232381657056, 4709.646776491777, 73343.0, 97536.0, 115272.0, 167751.0, 172605.0, 79597.0, 102635.0, 109445.90554094357, 110628.0, 140505.29747351402, 78260.0, 99185.0, 99831.50084249678, 109967.45016274868, 110864.0, 9325.533723313943, 9340.673076442292, 9491.05089491073, 9699.792133035004, 10034.0, 49954.00183992745, 57046.57383565444, 58566.70716646389, 59579.40420595912, 59896.0, 90354.54822725845, 97166.0, 97542.5122874381, 99372.0, 100887.0, 10892.50983705751, 12000.219985700902, 13221.140625859289, 13576.456941722221, 13658.931705341409, 11810.940945295219, 14853.777193342325, 15177.696446071237, 15334.693306134039, 15611.453599123975, 12092.455839487067, 13769.655758606115, 13887.861121389062, 13898.027138100237, 14063.507777227747, 13290.667733306746, 13664.795028074786, 13676.247806370746, 14030.368633411725, 14039.298035098409, 13253.271070091238, 13670.248136352198, 14037.649058773612, 14132.50536231227, 14137.929310353382, 9617.663381781604, 11446.713832154262, 11471.4264286787, 11518.424078796193, 11797.35114568707, 11168.050715689258, 11298.322100673986, 11513.481893314989, 11568.88431115678, 11572.768544629229], "value": 7737.80182830632, "unit": "score"}], "name": "dromaeo_css", "value": 7184.216411928278, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 110.0, 110.0, 111.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 112.0, 112.0, 149.0, 115.0, 115.0, 111.0, 115.0, 143.0, 116.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 260.0, 197.0, 187.0, 183.0, 182.0, 193.0, 180.0, 184.0, 183.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 88.0, 61.0, 59.0, 60.0, 58.0, 80.0, 57.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 91.0, 69.0, 69.0, 68.0, 93.0, 68.0, 70.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 87.0, 89.0, 86.0, 91.0, 88.0, 89.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 149.0, 95.0, 112.0, 149.0, 107.0, 95.0, 95.0, 114.0, 124.0], "value": 117.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 86.0, 84.0, 84.0, 84.0, 85.0, 86.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 55.0, 55.0, 54.0, 53.0, 53.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 75.0, 74.0, 74.0, 70.0, 70.0, 69.0, 69.0, 71.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 86.0, 89.0, 85.0, 81.0, 84.0, 78.0, 95.0, 100.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 146.0, 163.0, 161.0, 157.0, 147.0, 150.0, 209.0, 157.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 174.0, 174.0, 177.0, 172.0, 170.0, 172.0, 171.0, 171.0, 167.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1479.7, "alertThreshold": 2.0}]} 22:35:30 INFO - Return code: 0 22:35:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:35:30 INFO - # TBPL SUCCESS # 22:35:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:35:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:35:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:35:30 INFO - 2016-10-06 22:35:30.382 screenresolution[1663:10137] starting screenresolution argv=screenresolution get 22:35:30 INFO - 2016-10-06 22:35:30.385 screenresolution[1663:10137] Display 0: 1600x1200x32@60 22:35:30 INFO - 2016-10-06 22:35:30.391 screenresolution[1664:10140] starting screenresolution argv=screenresolution list 22:35:30 INFO - Available Modes on Display 0 22:35:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:35:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:35:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:35:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:35:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:35:30 INFO - Intel Iris: 22:35:30 INFO - Chipset Model: Intel Iris 22:35:30 INFO - Type: GPU 22:35:30 INFO - Bus: Built-In 22:35:30 INFO - VRAM (Dynamic, Max): 1536 MB 22:35:30 INFO - Vendor: Intel (0x8086) 22:35:30 INFO - Device ID: 0x0a2e 22:35:30 INFO - Revision ID: 0x0009 22:35:30 INFO - Displays: 22:35:30 INFO - Display: 22:35:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:35:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:35:30 INFO - Display Serial Number: 1600x1200 60 22:35:30 INFO - Main Display: Yes 22:35:30 INFO - Mirror: Off 22:35:30 INFO - Online: Yes 22:35:30 INFO - Rotation: Supported 22:35:30 INFO - Return code: 0 22:35:30 INFO - Running post-action listener: _resource_record_post_action 22:35:30 INFO - [mozharness: 2016-10-07 05:35:30.624083Z] Finished run-tests step (success) 22:35:30 INFO - Running post-run listener: _resource_record_post_run 22:35:30 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 38528000; Write bytes: 707896320; Read time: 377; Write time: 1878 22:35:30 INFO - TinderboxPrint: CPU usage
53.5% 22:35:30 INFO - TinderboxPrint: I/O read bytes / time
38,528,000 / 377 22:35:30 INFO - TinderboxPrint: I/O write bytes / time
707,896,320 / 1,878 22:35:30 INFO - TinderboxPrint: CPU idle
2,259.6 (46.5%) 22:35:30 INFO - TinderboxPrint: CPU system
971.6 (20.0%) 22:35:30 INFO - TinderboxPrint: CPU user
1,626.5 (33.5%) 22:35:30 INFO - TinderboxPrint: Swap in / out
446,251,008 / 0 22:35:30 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389888512; Write bytes: 383890944; Read time: 29241; Write time: 701 22:35:30 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 37557248; Write bytes: 297549312; Read time: 362; Write time: 1125 22:35:31 INFO - Running post-run listener: _upload_blobber_files 22:35:31 INFO - Blob upload gear active. 22:35:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:35:31 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 22:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:35:31 INFO - (blobuploader) - INFO - Open directory for files ... 22:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:35:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:33 INFO - (blobuploader) - INFO - Done attempting. 22:35:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:35:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:35:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:34 INFO - (blobuploader) - INFO - Done attempting. 22:35:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:35:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:36 INFO - (blobuploader) - INFO - Done attempting. 22:35:36 INFO - (blobuploader) - INFO - Iteration through files over. 22:35:37 INFO - Return code: 0 22:35:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:35:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:35:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01a6c90f0d75126c81e0cfc84e7db65c42da4af86d2e71475dcf4cd61021ad7ab3f083ca4eba0e988da1b7d7d660b9d1c89afd338dd2ec5a3a4ee101eabac708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6275624d47d8b8a4529f302e5fbf3503eb1b72239cef29e9228611ffcffb942e2525a720e8e3c67bef5aeb7b730289b72a98c2461715b292f2929d561e20d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21576c5028892859d7acc50f0963c1e158f0dca6fbab6a265ff248e0feb47582e3010a824a0bfd434e9902115e99d65e9ec5d6556b5a3a387ea6c425be207aac"} 22:35:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:35:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:35:37 INFO - Contents: 22:35:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01a6c90f0d75126c81e0cfc84e7db65c42da4af86d2e71475dcf4cd61021ad7ab3f083ca4eba0e988da1b7d7d660b9d1c89afd338dd2ec5a3a4ee101eabac708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6275624d47d8b8a4529f302e5fbf3503eb1b72239cef29e9228611ffcffb942e2525a720e8e3c67bef5aeb7b730289b72a98c2461715b292f2929d561e20d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21576c5028892859d7acc50f0963c1e158f0dca6fbab6a265ff248e0feb47582e3010a824a0bfd434e9902115e99d65e9ec5d6556b5a3a387ea6c425be207aac"} 22:35:37 INFO - Running post-run listener: copy_logs_to_upload_dir 22:35:37 INFO - Copying logs to upload dir... 22:35:37 INFO - mkdir: /builds/slave/test/build/upload/logs 22:35:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.265919 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-06 22:35:37.070575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 22:35:37.074131) ========= 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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01a6c90f0d75126c81e0cfc84e7db65c42da4af86d2e71475dcf4cd61021ad7ab3f083ca4eba0e988da1b7d7d660b9d1c89afd338dd2ec5a3a4ee101eabac708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6275624d47d8b8a4529f302e5fbf3503eb1b72239cef29e9228611ffcffb942e2525a720e8e3c67bef5aeb7b730289b72a98c2461715b292f2929d561e20d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21576c5028892859d7acc50f0963c1e158f0dca6fbab6a265ff248e0feb47582e3010a824a0bfd434e9902115e99d65e9ec5d6556b5a3a387ea6c425be207aac"} build_url:https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010896 build_url: 'https://queue.taskcluster.net/v1/task/ee-184XxQEC91FDtXTmYSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01a6c90f0d75126c81e0cfc84e7db65c42da4af86d2e71475dcf4cd61021ad7ab3f083ca4eba0e988da1b7d7d660b9d1c89afd338dd2ec5a3a4ee101eabac708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6275624d47d8b8a4529f302e5fbf3503eb1b72239cef29e9228611ffcffb942e2525a720e8e3c67bef5aeb7b730289b72a98c2461715b292f2929d561e20d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21576c5028892859d7acc50f0963c1e158f0dca6fbab6a265ff248e0feb47582e3010a824a0bfd434e9902115e99d65e9ec5d6556b5a3a387ea6c425be207aac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 22:35:37.109826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:35:37.110153) ========= 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.WrAUWlSvTB/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.p2CUyEDOaI/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.004983 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 22:35:37.159010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 22:35:37.159325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 22:35:37.159692) ========= ========= Total master_lag: 0.36 =========