builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0064 starttime: 1480349768.89 results: success (0) buildid: 20161128062657 builduid: 3434d47c347c484196e0e1393c517fd1 revision: 0652448d05a11d64422033cfd006666bce9c696f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:08.891785) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:08.892216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:08.892518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:08.918772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:08.919123) ========= 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.OaqqePW4gr/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.xYNWvUZvVd/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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-11-28 08:16:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2016-11-28 08:16:09 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:09.032333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:09.032655) ========= 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.OaqqePW4gr/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.xYNWvUZvVd/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.027547 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:09.083472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 08:16:09.084209) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0652448d05a11d64422033cfd006666bce9c696f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0652448d05a11d64422033cfd006666bce9c696f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OaqqePW4gr/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.xYNWvUZvVd/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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-11-28 08:16:09,178 truncating revision to first 12 chars 2016-11-28 08:16:09,178 Setting DEBUG logging. 2016-11-28 08:16:09,178 attempt 1/10 2016-11-28 08:16:09,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0652448d05a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 08:16:10,214 unpacking tar archive at: mozilla-aurora-0652448d05a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331009 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 08:16:10.439968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:10.440286) ========= script_repo_revision: 0652448d05a11d64422033cfd006666bce9c696f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:10.440692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:10.440956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 08:16:10.460543) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-28 08:16:10.460837) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OaqqePW4gr/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.xYNWvUZvVd/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16:10 INFO - MultiFileLogger online at 20161128 08:16:10 in /builds/slave/test 08:16:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:16:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:10 INFO - {'append_to_log': False, 08:16:10 INFO - 'base_work_dir': '/builds/slave/test', 08:16:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:16:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:10 INFO - 'branch': 'Mozilla-Aurora', 08:16:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:10 INFO - 'config_files': ('talos/mac_config.py',), 08:16:10 INFO - 'default_actions': ('clobber', 08:16:10 INFO - 'read-buildbot-config', 08:16:10 INFO - 'download-and-extract', 08:16:10 INFO - 'populate-webroot', 08:16:10 INFO - 'create-virtualenv', 08:16:10 INFO - 'install', 08:16:10 INFO - 'run-tests'), 08:16:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:10 INFO - 'download_minidump_stackwalk': True, 08:16:10 INFO - 'download_symbols': 'ondemand', 08:16:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:10 INFO - 'installer_path': 'installer.exe', 08:16:10 INFO - 'log_level': 'info', 08:16:10 INFO - 'log_name': 'talos', 08:16:10 INFO - 'log_to_console': True, 08:16:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:16:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:16:10 INFO - 'opt_config_files': (), 08:16:10 INFO - 'pip_index': False, 08:16:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:16:10 INFO - 'cmd': ('bash', 08:16:10 INFO - '-c', 08:16:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:16:10 INFO - 'enabled': True, 08:16:10 INFO - 'halt_on_failure': False, 08:16:10 INFO - 'name': 'check_screen_resolution'},), 08:16:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:16:10 INFO - 'cmd': ('bash', 08:16:10 INFO - '-c', 08:16:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:16:10 INFO - 'enabled': True, 08:16:10 INFO - 'halt_on_failure': False, 08:16:10 INFO - 'name': 'check_screen_resolution'},), 08:16:10 INFO - 'run_cmd_checks_enabled': True, 08:16:10 INFO - 'sps_profile': False, 08:16:10 INFO - 'sps_profile_interval': 0, 08:16:10 INFO - 'suite': 'dromaeojs-e10s', 08:16:10 INFO - 'system_bits': '32', 08:16:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:10 INFO - 'title': 't-yosemite-r7-0064', 08:16:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:10 INFO - 'use_talos_json': True, 08:16:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:10 INFO - 'work_dir': 'build'} 08:16:10 INFO - [mozharness: 2016-11-28 16:16:10.669022Z] Running clobber step. 08:16:10 INFO - Running pre-action listener: _resource_record_pre_action 08:16:10 INFO - Running main action method: clobber 08:16:10 INFO - rmtree: /builds/slave/test/build 08:16:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:13 INFO - Running post-action listener: _resource_record_post_action 08:16:13 INFO - [mozharness: 2016-11-28 16:16:13.124002Z] Finished clobber step (success) 08:16:13 INFO - [mozharness: 2016-11-28 16:16:13.124127Z] Running read-buildbot-config step. 08:16:13 INFO - Running pre-action listener: _resource_record_pre_action 08:16:13 INFO - Running main action method: read_buildbot_config 08:16:13 INFO - Using buildbot properties: 08:16:13 INFO - { 08:16:13 INFO - "project": "", 08:16:13 INFO - "product": "firefox", 08:16:13 INFO - "script_repo_revision": "production", 08:16:13 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:16:13 INFO - "repository": "", 08:16:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:16:13 INFO - "buildid": "20161128062657", 08:16:13 INFO - "pgo_build": "False", 08:16:13 INFO - "basedir": "/builds/slave/test", 08:16:13 INFO - "buildnumber": 463, 08:16:13 INFO - "slavename": "t-yosemite-r7-0064", 08:16:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:16:13 INFO - "platform": "yosemite_r7", 08:16:13 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:16:13 INFO - "branch": "mozilla-aurora", 08:16:13 INFO - "repo_path": "releases/mozilla-aurora", 08:16:13 INFO - "revision": "0652448d05a11d64422033cfd006666bce9c696f", 08:16:13 INFO - "stage_platform": "macosx64", 08:16:13 INFO - "builduid": "3434d47c347c484196e0e1393c517fd1", 08:16:13 INFO - "slavebuilddir": "test" 08:16:13 INFO - } 08:16:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:16:13 INFO - Running post-action listener: _resource_record_post_action 08:16:13 INFO - [mozharness: 2016-11-28 16:16:13.127338Z] Finished read-buildbot-config step (success) 08:16:13 INFO - [mozharness: 2016-11-28 16:16:13.127467Z] Running download-and-extract step. 08:16:13 INFO - Running pre-action listener: _resource_record_pre_action 08:16:13 INFO - Running main action method: download_and_extract 08:16:13 INFO - mkdir: /builds/slave/test/build/tests 08:16: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')]} 08:16:13 INFO - trying https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:16:13 INFO - Downloading https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:16:14 INFO - Downloaded 1199 bytes. 08:16:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:16:14 INFO - Using the following test package requirements: 08:16:14 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:16:14 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:16:14 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:16:14 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'jsshell-mac.zip'], 08:16:14 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:16:14 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:16:14 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:16:14 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:16:14 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:16:14 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:16:14 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:16:14 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:16:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:16:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:16:14 INFO - Fetch https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:16:14 INFO - Http code: 200 08:16:14 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 08:16:14 INFO - x-amz-cf-id: hncwf2tSkK7n_M3q8y1hzpXJYOxHMySx_tdPqQuYEGQhpY87EJL5Og== 08:16:14 INFO - x-amz-version-id: w3OHQSzMKMvt4gl8UCptUz0_6Eu6YVqt 08:16:15 INFO - Expected file size: 16279370 08:16:15 INFO - Obtained file size: 16279370 08:16:21 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:16:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:16:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:16:21 INFO - Fetch https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:16:22 INFO - Http code: 200 08:16:22 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 08:16:22 INFO - x-amz-cf-id: xWYbuaxulz15OMKeWXuFQcqv02oNxuCB4nEygCrqIqIKFnLGZZOXKg== 08:16:22 INFO - x-amz-version-id: w3OHQSzMKMvt4gl8UCptUz0_6Eu6YVqt 08:16:22 INFO - Expected file size: 16279370 08:16:22 INFO - Obtained file size: 16279370 08:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:16:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:16:29 INFO - Fetch https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:16:30 INFO - Http code: 200 08:16:30 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 08:16:30 INFO - x-amz-cf-id: VwLo-k6PliiVmAGGt5hrrd3NkcH9zmxkCsu-j1-i4oD6cAAXOFiPPg== 08:16:30 INFO - x-amz-version-id: pGqW8rp9XnHmJdWmIfD.7Msw0usdn4Ok 08:16:30 INFO - Expected file size: 14409038 08:16:30 INFO - Obtained file size: 14409038 08:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:30 INFO - trying https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:16:30 INFO - Downloading https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:16:33 INFO - Downloaded 109721343 bytes. 08:16:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:16:33 INFO - mkdir: /builds/slave/test/properties 08:16:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:33 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:33 INFO - Contents: 08:16:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:16:34 INFO - Running post-action listener: _resource_record_post_action 08:16:34 INFO - Running post-action listener: set_extra_try_arguments 08:16:34 INFO - [mozharness: 2016-11-28 16:16:34.287646Z] Finished download-and-extract step (success) 08:16:34 INFO - [mozharness: 2016-11-28 16:16:34.287776Z] Running populate-webroot step. 08:16:34 INFO - Running pre-action listener: _resource_record_pre_action 08:16:34 INFO - Running main action method: populate_webroot 08:16:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:34 INFO - '--tppagecycles', 08:16:34 INFO - '7'], 08:16:34 INFO - 'tests': ['tsvgm']}}, 08:16:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['damp', 'tps']}, 08:16:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'tests': ['damp', 'tps']}, 08:16:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['dromaeo_dom']}, 08:16:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['basic_compositor_video']}, 08:16:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['a11yr', 08:16:34 INFO - 'ts_paint', 08:16:34 INFO - 'tpaint', 08:16:34 INFO - 'sessionrestore', 08:16:34 INFO - 'sessionrestore_no_auto_restore', 08:16:34 INFO - 'tabpaint']}, 08:16:34 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:34 INFO - 'ts_paint', 08:16:34 INFO - 'tpaint', 08:16:34 INFO - 'sessionrestore', 08:16:34 INFO - 'sessionrestore_no_auto_restore', 08:16:34 INFO - 'tabpaint']}, 08:16:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:34 INFO - 'ts_paint', 08:16:34 INFO - 'tpaint', 08:16:34 INFO - 'sessionrestore', 08:16:34 INFO - 'sessionrestore_no_auto_restore', 08:16:34 INFO - 'tabpaint']}, 08:16:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:34 INFO - 'ts_paint', 08:16:34 INFO - 'tpaint', 08:16:34 INFO - 'sessionrestore', 08:16:34 INFO - 'sessionrestore_no_auto_restore', 08:16:34 INFO - 'tabpaint']}, 08:16:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['a11yr', 08:16:34 INFO - 'ts_paint', 08:16:34 INFO - 'tpaint', 08:16:34 INFO - 'sessionrestore', 08:16:34 INFO - 'sessionrestore_no_auto_restore', 08:16:34 INFO - 'tabpaint']}, 08:16:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['a11yr', 08:16:34 INFO - 'ts_paint', 08:16:34 INFO - 'tpaint', 08:16:34 INFO - 'sessionrestore', 08:16:34 INFO - 'sessionrestore_no_auto_restore', 08:16:34 INFO - 'tabpaint']}, 08:16:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['tsvgx', 08:16:34 INFO - 'tsvgr_opacity', 08:16:34 INFO - 'tart', 08:16:34 INFO - 'tscrollx', 08:16:34 INFO - 'cart']}, 08:16:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:34 INFO - 'tsvgr_opacity', 08:16:34 INFO - 'tart', 08:16:34 INFO - 'tscrollx', 08:16:34 INFO - 'cart']}, 08:16:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'talos_options': ['--disable-e10s'], 08:16:34 INFO - 'tests': ['tp5o']}, 08:16:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'tests': ['tp5o']}, 08:16:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'talos_options': ['--disable-e10s', 08:16:34 INFO - '--xperf_path', 08:16:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:34 INFO - 'tests': ['tp5n']}, 08:16:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:34 INFO - 'talos_options': ['--xperf_path', 08:16:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:34 INFO - 'tests': ['tp5n']}}, 08:16:34 INFO - 'talos.zip': {'path': '', 08:16:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:34 INFO - Running post-action listener: _resource_record_post_action 08:16:34 INFO - [mozharness: 2016-11-28 16:16:34.306602Z] Finished populate-webroot step (success) 08:16:34 INFO - [mozharness: 2016-11-28 16:16:34.306736Z] Running create-virtualenv step. 08:16:34 INFO - Running pre-action listener: _resource_record_pre_action 08:16:34 INFO - Running main action method: create_virtualenv 08:16:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:34 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 08:16:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:34 INFO - Using real prefix '/tools/python27' 08:16:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:35 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:38 INFO - Installing pip.................done. 08:16:38 INFO - Return code: 0 08:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:16:38 INFO - Reading from file tmpfile_stdout 08:16:38 INFO - Output received: 08:16:38 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) 08:16:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:38 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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16:38 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 08:16:38 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 08:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:38 INFO - 'HOME': '/Users/cltbld', 08:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:38 INFO - 'LOGNAME': 'cltbld', 08:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:38 INFO - 'MOZ_NO_REMOTE': '1', 08:16:38 INFO - 'NO_EM_RESTART': '1', 08:16:38 INFO - 'PAGER': '/bin/cat', 08:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:38 INFO - 'PWD': '/builds/slave/test', 08:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:38 INFO - 'SHELL': '/bin/bash', 08:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:16:38 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:38 INFO - 'USER': 'cltbld', 08:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:38 INFO - 'XPC_FLAGS': '0x0', 08:16:38 INFO - 'XPC_SERVICE_NAME': '0', 08:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:38 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 08:16:38 INFO - Cleaning up... 08:16:38 INFO - Return code: 0 08:16:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:38 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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16:38 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 08:16:38 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 08:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:38 INFO - 'HOME': '/Users/cltbld', 08:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:38 INFO - 'LOGNAME': 'cltbld', 08:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:38 INFO - 'MOZ_NO_REMOTE': '1', 08:16:38 INFO - 'NO_EM_RESTART': '1', 08:16:38 INFO - 'PAGER': '/bin/cat', 08:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:38 INFO - 'PWD': '/builds/slave/test', 08:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:38 INFO - 'SHELL': '/bin/bash', 08:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:16:38 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:38 INFO - 'USER': 'cltbld', 08:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:38 INFO - 'XPC_FLAGS': '0x0', 08:16:38 INFO - 'XPC_SERVICE_NAME': '0', 08:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:38 INFO - Downloading/unpacking psutil>=3.1.1 08:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:42 INFO - Installing collected packages: psutil 08:16:42 INFO - Running setup.py install for psutil 08:16:42 INFO - building 'psutil._psutil_osx' extension 08:16:42 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 08:16:43 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 08:16:43 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 08:16:43 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 08:16:43 INFO - building 'psutil._psutil_posix' extension 08:16:43 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 08:16:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:16:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:16:43 INFO - ^ 08:16:43 INFO - 1 warning generated. 08:16:43 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 08:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:43 INFO - Successfully installed psutil 08:16:43 INFO - Cleaning up... 08:16:43 INFO - Return code: 0 08:16:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:43 INFO - 'HOME': '/Users/cltbld', 08:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:43 INFO - 'LOGNAME': 'cltbld', 08:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:43 INFO - 'MOZ_NO_REMOTE': '1', 08:16:43 INFO - 'NO_EM_RESTART': '1', 08:16:43 INFO - 'PAGER': '/bin/cat', 08:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:43 INFO - 'PWD': '/builds/slave/test', 08:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:43 INFO - 'SHELL': '/bin/bash', 08:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:16:43 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:43 INFO - 'USER': 'cltbld', 08:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:43 INFO - 'XPC_FLAGS': '0x0', 08:16:43 INFO - 'XPC_SERVICE_NAME': '0', 08:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:43 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 08:16:43 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 08:16:43 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 08:16:43 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 08:16:43 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 08:16:43 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 08:16:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:46 INFO - Installing collected packages: mozsystemmonitor 08:16:46 INFO - Running setup.py install for mozsystemmonitor 08:16:46 INFO - Successfully installed mozsystemmonitor 08:16:46 INFO - Cleaning up... 08:16:46 INFO - Return code: 0 08:16:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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', '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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:16: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 jsonschema==2.5.1 08:16:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:16:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:46 INFO - 'HOME': '/Users/cltbld', 08:16:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:46 INFO - 'LOGNAME': 'cltbld', 08:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:46 INFO - 'MOZ_NO_REMOTE': '1', 08:16:46 INFO - 'NO_EM_RESTART': '1', 08:16:46 INFO - 'PAGER': '/bin/cat', 08:16:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:46 INFO - 'PWD': '/builds/slave/test', 08:16:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:46 INFO - 'SHELL': '/bin/bash', 08:16:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:16:46 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:16:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:46 INFO - 'USER': 'cltbld', 08:16:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:46 INFO - 'XPC_FLAGS': '0x0', 08:16:46 INFO - 'XPC_SERVICE_NAME': '0', 08:16:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:46 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:46 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 08:16:46 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 08:16:46 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 08:16:46 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 08:16:46 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 08:16:46 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 08:16:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:49 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 08:16:49 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 08:16:49 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 08:16:49 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 08:16:49 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 08:16:49 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 08:16:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:50 INFO - warning: no files found matching '*.txt' 08:16:50 INFO - no previously-included directories found matching 'build' 08:16:50 INFO - no previously-included directories found matching 'dist' 08:16:50 INFO - no previously-included directories found matching '.git*' 08:16:50 INFO - Installing collected packages: jsonschema, functools32 08:16:50 INFO - Running setup.py install for functools32 08:16:50 INFO - warning: no files found matching '*.txt' 08:16:50 INFO - no previously-included directories found matching 'build' 08:16:50 INFO - no previously-included directories found matching 'dist' 08:16:50 INFO - no previously-included directories found matching '.git*' 08:16:50 INFO - Successfully installed jsonschema functools32 08:16:50 INFO - Cleaning up... 08:16:50 INFO - Return code: 0 08:16:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:50 INFO - 'HOME': '/Users/cltbld', 08:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:50 INFO - 'LOGNAME': 'cltbld', 08:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:50 INFO - 'MOZ_NO_REMOTE': '1', 08:16:50 INFO - 'NO_EM_RESTART': '1', 08:16:50 INFO - 'PAGER': '/bin/cat', 08:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:50 INFO - 'PWD': '/builds/slave/test', 08:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:50 INFO - 'SHELL': '/bin/bash', 08:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:16:50 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:50 INFO - 'USER': 'cltbld', 08:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:50 INFO - 'XPC_FLAGS': '0x0', 08:16:50 INFO - 'XPC_SERVICE_NAME': '0', 08:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:16:50 INFO - Cleaning up... 08:16:50 INFO - Return code: 0 08:16:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:50 INFO - 'HOME': '/Users/cltbld', 08:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:50 INFO - 'LOGNAME': 'cltbld', 08:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:50 INFO - 'MOZ_NO_REMOTE': '1', 08:16:50 INFO - 'NO_EM_RESTART': '1', 08:16:50 INFO - 'PAGER': '/bin/cat', 08:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:50 INFO - 'PWD': '/builds/slave/test', 08:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:50 INFO - 'SHELL': '/bin/bash', 08:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:16:50 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:50 INFO - 'USER': 'cltbld', 08:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:50 INFO - 'XPC_FLAGS': '0x0', 08:16:50 INFO - 'XPC_SERVICE_NAME': '0', 08:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:50 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 08:16:50 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 08:16:50 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 08:16:50 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 08:16:50 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 08:16:50 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 08:16:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:53 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 08:16:53 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 08:16:53 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 08:16:53 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 08:16:53 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 08:16:53 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 08:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:54 INFO - Downloading docopt-0.6.1.tar.gz 08:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:54 INFO - Running setup.py install for blobuploader 08:16:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:54 INFO - Running setup.py install for requests 08:16:55 INFO - Running setup.py install for docopt 08:16:55 INFO - Successfully installed blobuploader requests docopt 08:16:55 INFO - Cleaning up... 08:16:55 INFO - Return code: 0 08:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:55 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')]} 08:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:55 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')]} 08:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:55 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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:16:55 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 08:16:55 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 08:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:55 INFO - 'HOME': '/Users/cltbld', 08:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:55 INFO - 'LOGNAME': 'cltbld', 08:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:55 INFO - 'MOZ_NO_REMOTE': '1', 08:16:55 INFO - 'NO_EM_RESTART': '1', 08:16:55 INFO - 'PAGER': '/bin/cat', 08:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:55 INFO - 'PWD': '/builds/slave/test', 08:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:55 INFO - 'SHELL': '/bin/bash', 08:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:16:55 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:55 INFO - 'USER': 'cltbld', 08:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:55 INFO - 'XPC_FLAGS': '0x0', 08:16:55 INFO - 'XPC_SERVICE_NAME': '0', 08:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-V9lejS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-M8N2lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-TP17uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-cH1O_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4AIRzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-_TP2g7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-EbMGzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-KlpGlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-oiDSQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-sWdlR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-aer8nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:57 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-robjel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:57 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-7V333A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:57 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-acSGQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:57 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-QMwr8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:57 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-x7zGZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:57 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-OHMV_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:57 INFO - Running setup.py install for manifestparser 08:16:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:57 INFO - Running setup.py install for mozcrash 08:16:57 INFO - Running setup.py install for mozdebug 08:16:58 INFO - Running setup.py install for mozdevice 08:16:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozfile 08:16:58 INFO - Running setup.py install for mozhttpd 08:16:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozinfo 08:16:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozInstall 08:16:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozleak 08:16:58 INFO - Running setup.py install for mozlog 08:16:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Running setup.py install for moznetwork 08:16:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Running setup.py install for mozprocess 08:16:59 INFO - Running setup.py install for mozprofile 08:16:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Running setup.py install for mozrunner 08:16:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Running setup.py install for mozscreenshot 08:16:59 INFO - Running setup.py install for moztest 08:17:00 INFO - Running setup.py install for mozversion 08:17:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:00 INFO - Cleaning up... 08:17:00 INFO - Return code: 0 08:17:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:00 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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:17:00 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 08:17:00 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 08:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:00 INFO - 'HOME': '/Users/cltbld', 08:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:00 INFO - 'LOGNAME': 'cltbld', 08:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:00 INFO - 'MOZ_NO_REMOTE': '1', 08:17:00 INFO - 'NO_EM_RESTART': '1', 08:17:00 INFO - 'PAGER': '/bin/cat', 08:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:00 INFO - 'PWD': '/builds/slave/test', 08:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:00 INFO - 'SHELL': '/bin/bash', 08:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:17:00 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:00 INFO - 'USER': 'cltbld', 08:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:00 INFO - 'XPC_FLAGS': '0x0', 08:17:00 INFO - 'XPC_SERVICE_NAME': '0', 08:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-s_Qu4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4cfJvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-bNjW6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-IPH6Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4M4Ka4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-lQHFhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Qekkis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-2ENSKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-rWA2gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-cOdLVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-X5eXQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-QOUACe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-i1misU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-PsU_ID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-FA72e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-8d7qT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:02 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)) 08:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-tD37VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:03 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)) 08:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:03 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 08:17:03 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 08:17:03 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 08:17:03 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 08:17:03 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 08:17:03 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 08:17:05 INFO - Downloading blessings-1.6.tar.gz 08:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:06 INFO - Installing collected packages: blessings 08:17:06 INFO - Running setup.py install for blessings 08:17:06 INFO - Successfully installed blessings 08:17:06 INFO - Cleaning up... 08:17:06 INFO - Return code: 0 08:17:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:06 INFO - Reading from file tmpfile_stdout 08:17:06 INFO - Current package versions: 08:17:06 INFO - blessings == 1.6 08:17:06 INFO - blobuploader == 1.2.4 08:17:06 INFO - docopt == 0.6.1 08:17:06 INFO - functools32 == 3.2.3-2 08:17:06 INFO - jsonschema == 2.5.1 08:17:06 INFO - manifestparser == 1.1 08:17:06 INFO - mozInstall == 1.12 08:17:06 INFO - mozcrash == 1.0 08:17:06 INFO - mozdebug == 0.1 08:17:06 INFO - mozdevice == 0.48 08:17:06 INFO - mozfile == 1.2 08:17:06 INFO - mozhttpd == 0.7 08:17:06 INFO - mozinfo == 0.9 08:17:06 INFO - mozleak == 0.1 08:17:06 INFO - mozlog == 3.4 08:17:06 INFO - moznetwork == 0.27 08:17:06 INFO - mozprocess == 0.23 08:17:06 INFO - mozprofile == 0.28 08:17:06 INFO - mozrunner == 6.13 08:17:06 INFO - mozscreenshot == 0.1 08:17:06 INFO - mozsystemmonitor == 0.3 08:17:06 INFO - moztest == 0.7 08:17:06 INFO - mozversion == 1.4 08:17:06 INFO - psutil == 3.1.1 08:17:06 INFO - requests == 1.2.3 08:17:06 INFO - wsgiref == 0.1.2 08:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:06 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')]} 08:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:06 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')]} 08:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:06 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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:17:06 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 08:17:06 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 08:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:06 INFO - 'HOME': '/Users/cltbld', 08:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:06 INFO - 'LOGNAME': 'cltbld', 08:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:06 INFO - 'MOZ_NO_REMOTE': '1', 08:17:06 INFO - 'NO_EM_RESTART': '1', 08:17:06 INFO - 'PAGER': '/bin/cat', 08:17:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:06 INFO - 'PWD': '/builds/slave/test', 08:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:06 INFO - 'SHELL': '/bin/bash', 08:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:17:06 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:06 INFO - 'USER': 'cltbld', 08:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:06 INFO - 'XPC_FLAGS': '0x0', 08:17:06 INFO - 'XPC_SERVICE_NAME': '0', 08:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 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)) 08:17:06 INFO - Cleaning up... 08:17:06 INFO - Return code: 0 08:17:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:06 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')]} 08:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:06 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')]} 08:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:06 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 0x10b283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1f9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679574020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, '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.OaqqePW4gr/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.xYNWvUZvVd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 08:17:06 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 08:17:06 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 08:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:06 INFO - 'HOME': '/Users/cltbld', 08:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:06 INFO - 'LOGNAME': 'cltbld', 08:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:06 INFO - 'MOZ_NO_REMOTE': '1', 08:17:06 INFO - 'NO_EM_RESTART': '1', 08:17:06 INFO - 'PAGER': '/bin/cat', 08:17:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:06 INFO - 'PWD': '/builds/slave/test', 08:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:06 INFO - 'SHELL': '/bin/bash', 08:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:17:06 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:06 INFO - 'USER': 'cltbld', 08:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:06 INFO - 'XPC_FLAGS': '0x0', 08:17:06 INFO - 'XPC_SERVICE_NAME': '0', 08:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:07 INFO - Cleaning up... 08:17:07 INFO - Return code: 0 08:17:07 INFO - Running post-action listener: _resource_record_post_action 08:17:07 INFO - Running post-action listener: _start_resource_monitoring 08:17:07 INFO - Starting resource monitoring. 08:17:07 INFO - [mozharness: 2016-11-28 16:17:07.201800Z] Finished create-virtualenv step (success) 08:17:07 INFO - [mozharness: 2016-11-28 16:17:07.202752Z] Running install step. 08:17:07 INFO - Running pre-action listener: _resource_record_pre_action 08:17:07 INFO - Running main action method: install 08:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:07 INFO - Reading from file tmpfile_stdout 08:17:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:07 INFO - Reading from file tmpfile_stdout 08:17:07 INFO - Output received: 08:17:07 INFO - Usage: mozinstall [options] installer 08:17:07 INFO - Options: 08:17:07 INFO - -h, --help show this help message and exit 08:17:07 INFO - -d DEST, --destination=DEST 08:17:07 INFO - Directory to install application into. [default: 08:17:07 INFO - "/builds/slave/test"] 08:17:07 INFO - --app=APP Application being installed. [default: firefox] 08:17:07 INFO - mkdir: /builds/slave/test/build/application 08:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:17:38 INFO - Reading from file tmpfile_stdout 08:17:38 INFO - Output received: 08:17:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:17:38 INFO - Running post-action listener: _resource_record_post_action 08:17:38 INFO - [mozharness: 2016-11-28 16:17:38.521081Z] Finished install step (success) 08:17:38 INFO - [mozharness: 2016-11-28 16:17:38.521216Z] Running run-tests step. 08:17:38 INFO - Running pre-action listener: _resource_record_pre_action 08:17:38 INFO - Running main action method: run_tests 08:17:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:38 INFO - 2016-11-28 08:17:38.535 screenresolution[1622:7376] starting screenresolution argv=screenresolution get 08:17:38 INFO - 2016-11-28 08:17:38.538 screenresolution[1622:7376] Display 0: 1600x1200x32@60 08:17:38 INFO - 2016-11-28 08:17:38.544 screenresolution[1623:7378] starting screenresolution argv=screenresolution list 08:17:38 INFO - Available Modes on Display 0 08:17:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:38 INFO - Intel Iris: 08:17:38 INFO - Chipset Model: Intel Iris 08:17:38 INFO - Type: GPU 08:17:38 INFO - Bus: Built-In 08:17:38 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:38 INFO - Vendor: Intel (0x8086) 08:17:38 INFO - Device ID: 0x0a2e 08:17:38 INFO - Revision ID: 0x0009 08:17:38 INFO - Displays: 08:17:38 INFO - Display: 08:17:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:38 INFO - Display Serial Number: 1600x1200 60 08:17:38 INFO - Main Display: Yes 08:17:38 INFO - Mirror: Off 08:17:38 INFO - Online: Yes 08:17:38 INFO - Rotation: Supported 08:17:38 INFO - Return code: 0 08:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:38 INFO - Python 2.7.3 08:17:38 INFO - Return code: 0 08:17:38 INFO - grabbing minidump binary from tooltool 08:17: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')]} 08:17:38 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 0x10b097d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b08fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:38 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 08:17:38 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 08:17:38 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 08:17:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:38 INFO - Return code: 0 08:17:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:17:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:17:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OaqqePW4gr/Render', 08:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:38 INFO - 'HOME': '/Users/cltbld', 08:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:38 INFO - 'LOGNAME': 'cltbld', 08:17:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:38 INFO - 'MOZ_NO_REMOTE': '1', 08:17:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:38 INFO - 'NO_EM_RESTART': '1', 08:17:38 INFO - 'PAGER': '/bin/cat', 08:17:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:38 INFO - 'PWD': '/builds/slave/test', 08:17:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:38 INFO - 'SHELL': '/bin/bash', 08:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xYNWvUZvVd/Listeners', 08:17:38 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 08:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:38 INFO - 'USER': 'cltbld', 08:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:38 INFO - 'XPC_FLAGS': '0x0', 08:17:38 INFO - 'XPC_SERVICE_NAME': '0', 08:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:17:39 INFO - mozversion application_buildid: 20161128062657 08:17:39 INFO - mozversion application_changeset: 0652448d05a11d64422033cfd006666bce9c696f 08:17:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:17:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:39 INFO - mozversion application_name: Firefox 08:17:39 INFO - mozversion application_remotingname: firefox-dev 08:17:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:17:39 INFO - mozversion application_vendor: Mozilla 08:17:39 INFO - mozversion application_version: 52.0a2 08:17:39 INFO - mozversion platform_buildid: 20161128062657 08:17:39 INFO - mozversion platform_changeset: 0652448d05a11d64422033cfd006666bce9c696f 08:17:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:17:39 INFO - mozversion platform_version: 52.0a2 08:17:39 INFO - using testdate: 1480349859 08:17:39 INFO - actual date: 1480349859 08:17:39 INFO - starting webserver on 'localhost:49242' 08:17:39 INFO - SUITE-START | Running 2 tests 08:17:39 INFO - TEST-START | dromaeo_css 08:17:39 INFO - operating with platform_type : mac_ 08:17:39 INFO - Initialising browser for dromaeo_css test... 08:17:39 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmph6GVK0/profile http://localhost:49242/getInfo.html) 08:17:42 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 08:17:42 INFO - PROCESS | 1633 | colorDepth:24 08:17:42 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 08:17:42 INFO - PROCESS | 1633 | __metrics 08:17:42 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:17:43 INFO - TEST-INFO | 1633: exit 0 08:17:43 INFO - Browser initialized. 08:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:43 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmph6GVK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:55 INFO - PROCESS | 1636 | RSS: Main: 229732352 08:17:55 INFO - PROCESS | 1636 | 08:18:45 INFO - PROCESS | 1636 | 1480349925039 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] 08:20:58 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 08:21:00 INFO - PROCESS | 1636 | RSS: Main: 232554496 08:21:00 INFO - PROCESS | 1636 | 08:24:02 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 08:24:03 INFO - PROCESS | 1636 | RSS: Main: 243363840 08:24:03 INFO - PROCESS | 1636 | 08:27:05 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 08:27:06 INFO - PROCESS | 1636 | RSS: Main: 246304768 08:27:06 INFO - PROCESS | 1636 | 08:30:08 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 08:30:08 INFO - PROCESS | 1636 | RSS: Main: 245800960 08:30:08 INFO - PROCESS | 1636 | 08:33:11 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 08:33:12 INFO - PROCESS | 1636 | RSS: Main: 249204736 08:33:12 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 08:36:15 INFO - PROCESS | 1636 | RSS: Main: 251793408 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | __start_tp_report 08:36:15 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 08:36:15 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 08:36:15 INFO - PROCESS | 1636 | |i|pagename|runs| 08:36:15 INFO - PROCESS | 1636 | |0;dojo.html;2920.649522057353;3400.8809691660795;3408.965910340896;3432.6052503962037;3471.1148657092444;5735.770569177228;5775.364709881909;5780.0751879699255;5793.362730099691;5813.651180929147;5767.279090113736;5831.008728516152;5840.299164100304;5862.618929769562;5880.3237627672725;5288.968651113025;5298.311219541473;5315.495027972336;5318.202269659562;5336.519713225809;5369.060414427479;5375.354957405117;5376.274202982606;5382.8923421531545;5397.892042159155;5213.921791173117;5239.685618862862;5369;5369.4362091980365;5375.462453754632;5316.096263635172;5332.92000619991;5338.786448542053;5350.705711185883;5351.545118664918;5166.61250406221;5240.213967904807;5260.289860868772;5302.2841916341185;5309.203619457074;5876.794312199053;5903.380145084747;5941.494972927307;5961.850953726192;5984.97007514964;6077.513798896078;6260.9999999999545;6290.559660823744;6297.181366422382;6299.346379100111;6218.9378106219265;6241.407066328691;6270.341614130496;6297.87404251917;6299.37006299371;4784.449788274358;5956.434138756811;5967.791127310524;5988.041913293896;6019.909701354527;5259.395169555473;6303.905441418291;6307.400796924285;6356.650384228819;6360.173177486897;5999.190109335271;6066.757329706762;6225.221847269091;6241.656708881055;6259.6870156492;6137.4689182037;6171.938280617136;6185.536084793658;6210.596311239845;6225.564210505312;6095.512359011268;6118.816435506942;6122.908156377658;6136.140940268366;6188.845278868064;6110.892920173631;6144.78493252734;6150.154575278875;6193.256809182927;6200.596961197508;4915.18899381598;4918.975405123023;4922.630802689812;4973.477784832613;4990.8752281193265;4405.449318835145;4451.354553589711;4456.9331460028125;4465.866024019285;4498.347739577743;5699.857503562361;5925.822225333247;5949.9107513387335;5970.820875373745;5976.551758618121;5480;6207.441330280297;6252.656103914328;6276.372362763778;6288.276848162428;5763.538916886639;6004.819855404345;6018.879622407528;6050.152978582913;6057.939420605826;4963.925541116886;5327.38735045467;5391.622586418992;5427.810026649048;5467.617266791366;4950.232713929347;6302.653354065479;6313.463355614824;6335.049742538656;6346.238451385863;6238.656873871981;6244.843878902882;6286.622802631857;6300.905486417616;6312.684365781784;6326.588771729823;6351.777687780906;6361.427471527585;6368.395002474757;6402.295747467681;5339.652922560022;6272.905906411499;6273.404026617464;6275.466585340298;6284.937150628618;5188.818391356284;6101.969490152521;6219.813405597839;6224.346443623354;6268.467180289544;6160.383961603804;6182.28903676083;6192.349803270592;6211.627302361872;6231.345708700521;6147.231596050494;6159.076138579249;6186.876262474635;6200.658963757037;6252.468540174136;5873.471387575139;5924.4667979882015;5938.960681880567;5949.137375080676;5978.581499295182;5951.732172052181;6062.939370606237;6109.34393638171;6126.295476020315;6143.235544005126;5880.882382352414;5894.528437725057;5926.703664816828;5944.078667806497;5959.28488581373 08:36:15 INFO - PROCESS | 1636 | |1;ext.html;451.33202859767545;454.9818007279709;512.0067069884424;521.3769545393255;544.9972051425376;30068.699313006862;31148.90978815739;37376;38783;38848;35423.4686479703;38570.4571817127;39911.800440997824;40350.39474407886;40383.798081009554;9166.312526560501;9344;9348.626054957793;9376.8593471098;9379;9138.543072846363;9232.953835230814;9234.86147707785;9239.307051971095;9255.305852061088;9212.769680757967;9219.032001639833;9235.861462078074;9257.39826911252;9257.490838003907;8053;8310.667573297062;9089.68186113486;9211.723648290563;9232.030636783109;9194.724158275263;9260.305477089178;9271.582778774971;9275.979642239348;9303.069693030642;37515.24969500622;37717.05707357311;37763.81118094392;37771;37849;3056.9847150764103;3272.2637406583567;3288.408086544421;3297.5878015248095;3317.20387107095;28289;28455.146345609457;29076;29763.80944762207;30333.24166895823;2537.3022418834785;2761.4753196892525;3173.2066983254185;3179.157523256339;3194.6645602211665;415592.9220353879;481763;482312;486101.5694921538;486440.7033894459;58777.70611146917;59017.704911475164;59131.74775387309;59248;59418.811623768146;50338;51798.48201517937;51923;53848;56426.71786641041;16078.839211607969;16316.26576804023;16332.510024699279;16364.67270654604;16370.263338149813;12533.686657833627;12603.117781755189;12610.936945315214;12628.747425051632;12641.557545486048;14926.40294388234;17821.7326740099;18023.72964405509;18061.548461288574;18177.72733409;6513.609183449008;6684.732610695615;7592.81017974544;7775.22247775218;7844.450888437868;834.5201509132273;869.9473636899296;898.5372533145435;937.3438592984937;986.6645340584236;29347.972820951163;29457.852710736308;29509.704902951125;29665.851670741507;29830.70169298279;1036.7719101797593;1063.1388575254068;1064.1005804638683;1096.3367162866512;1107.7230692326918;13304.467821287233;13709.931450342685;14525.346359413852;14716.411343546353;15019.02376345534;656179;660821;661232;662408;664403;54133;54592.727036364566;54728.72635636876;54747.45252547503;54861.725691371284;1334.739725753488;1357.9660508487366;1386.4038463460606;1386.5770939863237;1386.8890488760876;23398;28603.28491787722;29001.56497652579;29029.98395056163;29608;46584;47288.763556182;47404;47461.762691186326;47570.286445704034;583519;587696;589381;589500;592069;25241.495170096863;25472.363190920376;25472.872635637446;25637.74362256428;25677.87161064183;43266.35100473558;43578.78210608927;43658.25366985412;44865;44968.8757781045;37049.629503704615;37112;37118.628813712596;37363.2527349446;38231.617683822806;36808.26383472369;36998.07504812401;38114.809425953805;38168.236635266585;38195;35766;35776.82111589425;36439.817800911886;36585.63414365822;36742.44886326761;31647.683523165393;32953;33221.00336989894;33221.16947076342;33245.33509329848;22712.205072822373;23233.30300091;24415.877920610284;24862.50274994454;25295.873520632278 08:36:15 INFO - PROCESS | 1636 | |2;jquery.html;302.8394950676142;372.2945019188636;378.2265267527905;384.6057790764467;404.54286656078625;15791.921040394796;16747.33010679573;19302.324418645334;19547;19575.608487830235;11390.430478476084;17537.123143842822;17699.55751106223;18276.268949242014;18320;5248.0553500369915;5466.835994920159;5491.780328786864;5493.725313734298;5502.9174562381595;5217.34783152106;5271.973640131794;5329.333833270841;5411.864703382427;5504.559635229172;5313.9734301328435;5316.813911513098;5319.148936170213;5319.414864364917;5325.4142044375085;5098.821541246039;5295.973520132394;5304.389995150549;5322.600804939645;5409.702466364349;5231.3199284092825;5275.155975044013;5280.339957505312;5286.286351342596;5292.603054770908;12738.87261127386;14267.07264027835;20386.98065096754;22484;23402.297931062094;1999.7600287965538;2150.0754675489534;2268.943276418086;2430.902763889442;2866.967891559037;7939.64271607779;9748.415095094246;10153.28926975112;10164;13502.729945401135;1630.2745278351138;1779.7508348831175;1865.4590168851016;1922.9615407691908;1951.1317463728647;91008.54495727479;112050;119257.80742192554;119726;120166.39916800447;11498.310101393943;11683.591074312359;11683.707907302385;11793.174477786473;11822.88177118235;11522.193446458667;12101.697457563456;14599.978001540003;14626.707465850623;14628;7915.802104947423;8029.317508011768;8137.389695772841;8173.346132309401;8216.09622941476;8446.831063378699;8464.957675211585;8550.230479256772;8588.969323681198;8613.741587752378;3799.8290076946605;3913.1977944521304;3917.5494818096286;3955.8417663293144;3970.82131304092;1928;1959.3730006397816;1961.3527535913115;1961.8724782889067;1969.222157247879;844.50174397106;908.909109089099;938.5401153434768;944.900785417535;974.5858010345574;19796.60406791856;20420.0810963507;20465.89767051185;20582.485437864172;20982.160713571593;913.3789023464108;930.4835816121982;990.2721499697716;1001.3241062283075;1003.533356988989;9693.806123877483;10749.998759348273;10781.676549703521;10782.137429005661;10844.620438284623;387727;388759;392041;487680;546838;95133.57299640511;124506.75493245132;125749;126101.15412418639;131570;949.886013678363;969.7236287658125;1002.518790980319;1006.3056491021318;1009.2733232072895;17977.191026403583;18312.72530912011;18443.907780461548;18458.35395761142;18529.44411667652;34684;44671;51189;51900.480995189566;53986.19020714771;61757;71161;75529;77964.61017694876;78955;6297.433231009231;7370.96314518424;8033.919660803317;8050.6779728812535;8092.231238032377;10384;12404.937975310066;12455;12528.060395470558;12586.24482531051;8245.917540824516;9653.455447128426;10232.23258255619;10670.786584268426;10955.890441095806;10058.34620749649;10470.528826202992;10671.039606435457;10735.141188704729;11004.22970392097;5516.172574113915;8915.73252802417;10520.473976301308;10796.298240614335;10833.783324333312;6752.5948443093575;7229.457790665616;7393.297636724503;7749.7287594933905;8407;10726.302790318605;10773.138148947908;10880.891191087987;11022.393768342497;11149.219554631098 08:36:15 INFO - PROCESS | 1636 | |3;mootools.html;1422.9359678814453;1505.9096454212747;1686.5362025443;1800.6398720255952;1865.899119519484;7443.106827180733;7499.762539181035;7876.527408355502;8078.636461359239;8545.572721363938;6980.511364204508;8009.59952002399;8332.958335208315;8451.788705282372;8461.196186362302;1833.6241070580531;2262.536180083079;2262.7737226277404;2263.8868056597103;2271.9091236350528;2329.23135365329;2375.893084811179;2375.9168429104984;2384.3204686664303;2398.724146723123;1921.3851567498407;1944.6985717213854;2300.0339857259905;2316.293530473205;2343.3907184132077;2291.690621766057;2302.6315789473606;2316.06199489208;2337.415646088478;2338.3452633262714;2287.176616418088;2313.976860231393;2321.1875843454823;2326.953460930772;2336.7896889280046;8469.11074337198;8481.02468216157;8538.615762290712;8568.143185681445;8594.226519613203;5070.315507406527;5230.712310822903;5234.18870075139;5237.371515418136;5240.868978275574;3191.776575639706;3219.919502012445;3244.5944256967878;3310.9006729798143;3481.9129521761906;1035.1098055672117;1055.8680164979378;1085.6037546295624;1103.6535426779317;1110.7167672243527;10748.892511074946;10757.892421075767;10817.83773243402;10918.563257469772;10934.726631834188;4506.369108324837;4650.093231819763;4738.19450693383;4753.6910100844025;4756.500567440369;9450.149486546106;9546.284028697875;9564.90435095654;9570.808583828284;9611;5235.450277720861;5240.580753539708;5249.580033597303;5254.947450525522;5264.236685680555;4095.1400205957084;4751.572358487683;4796.136695394793;4810.95189048112;4816.229403295456;3798.1264309208486;3812.390017597171;3911.2959667260166;3924.941125883114;3925.9988702881155;1141.9828702569469;1266.2972050511871;1284.7237843863613;1293.140061858872;1300.219868079164;880.0275695356539;892.1346294094718;902.120432578231;902.9819403611891;907.3376435202339;5519.31008623922;5717.799877004368;5806.4193580641595;5833.095870140135;5878.3239927408895;916.9174774270215;918.93108016899;920.5535315372039;933.9579718912665;978.3151793744407;3719.776813391205;3837.4819399380726;3849.846006159722;3850.306944749972;3866.4586957825927;9929.255305851946;10248.026437488426;10342.37945723259;10381.377117372831;10383.273170878118;8854.64581416749;10218.978102189722;10232.181425485944;10249.12882405004;10350.016748408889;6892.586444813327;7780.961095194601;7894.763157105296;7925.564093974886;7934.127246002935;5592.608517403743;5662.7734890603915;5677.233573467529;5775.075987841925;5807.970960145172;7251.746188883364;8517.892673952594;9311.068893110634;9477.668281610111;9627.989061148479;7876.84246315059;9512.1439070484;9700.708978730649;9733.124018838338;9796.85304720444;6647.867042659216;6888.276730943179;7171.42628589722;7302.56184628924;7329;7743.45795794289;7936.722214722457;7980.241877021674;8079.636416361395;8090.555019473985;6865.107536020485;7067.540609860343;7085.326893945067;7107.680154393168;7126;7051.471139664443;7087.893681594677;7121.323474269936;7149.0706208192605;7177.928220717726;6579.046038324512;6618.437432818265;6659.134312539532;6698.966505167443;6738.66306684654;4013.8884731658386;4743.739094349844;4784.593309568587;4804.25534042224;4888.291197776373;4721.079389519011;4819.975900120618;4827.541383568555;4858.975705121452;4920.286558449076 08:36:15 INFO - PROCESS | 1636 | |4;prototype.html;287.44236181807304;308.19407250041144;315.3016069406265;316.06287357983575;318.8437665543884;5326.360836699591;5478.835634930949;5511.779528818853;5520.530754885829;5573.526250268727;4307.67692423068;5154.819581314655;5444.6932736143335;5460.481254280847;5460.535854452376;3423.623401425841;3960.8019599020076;3964.801759912007;4085.305498065336;4150.667946564267;3440.9827950860335;4132.462779838616;4159.812808423628;4164.396162556428;4168.291000689718;4113.670906327501;4136.97931510342;4151.83392664293;4171.895702607429;4198.895027624319;3127.4526957782296;4118.670506359514;4152.875413737593;4194.664426845845;4200.928763165389;3250.6586808385014;3511.877084302063;3527.9647203527893;3531;3531.8587256509963;4017.7589344639123;4583.587477127041;4792.400949881265;5316.415194328621;5356.276902618175;3896.8636097736444;4477.395551600524;4710.646701497401;4743.857684269477;4744;5050.964552266813;5093.643444958854;5356.643356643357;5741.736817900055;5781.4507621775865;3324.85292574064;3790.4124860646643;3915.7063220258597;3917.334053210961;3955.5055618047745;5138.152204886189;5557.054760976689;6040.154378387029;6067.544934129958;6094.360092190301;3364.966350336514;3399.8810041648917;3474.974882409695;3646.978845923146;3868.516435445569;3920.3923391874305;3986.1828325193264;3991.2416640838146;4014.9397759033636;4026.315526360467;4502.16709908668;4671.906561868744;4672.906541869143;4681.976590117096;4686.437627484655;4858.854234372974;4884.169691152441;5582.7766889323975;5820.447057529528;5902.409759024149;1287.7810772168755;1295.8898493627958;1301.5965050834272;1302.257713103541;1311.567182829664;820.8481430935177;834.3658819297377;873.899501557329;876.5354362187923;890.617034675096;4999.275105109738;5248.60635452335;5378.78484860609;5455.863603409946;5472.425395333433;5014.749262536931;5250.164910948121;5925.881482370414;5940.405959404112;5941.8211256978175;4659.4175728034;4670.462896766848;5473.452654734574;5478.342598888159;5499.807506737325;2684.919452416392;2925.1224632610133;2960.4967155583604;2969.9257518561776;3010.6086208792717;5024.422191447957;5162.716050617252;5576.9163462548095;5711.315162027212;5972.880542389128;5221.373435187802;5730.736359138117;5805.767769289181;5885.705714714247;6214.502839772807;6196.47329976948;6225.719842607094;6233.781817636361;6275.309715931244;6295.811125666238;5392.110301800159;5613.621375327251;5969.1495636352865;6053.334133245427;6079.361667024898;5408.323959505062;5557.193617223438;5926.911096333472;5939.46544810969;5940.46535811779;5524.613277070566;6177.444030037318;6178.158047298293;6291.496680265659;6333.018382150774;3731.645493678096;3918.9804050979565;3919.4904662393706;3925.5681874994298;3961.6632586230494;5880.970595146997;5889.970550147222;5905.40945905406;5912;5934.961381758261;5441.204402547229;5751.705866180076;5761.5102716269585;5794.82615521535;5816.912746308724;5712.800051998326;5782.913256301074;5786;5837.620554663933;5869.532616845789;4341.587549182823;4793.9041219176115;5641.294838145232;5652.2086907833755;5716.056850619601;5276.7310056676;5500.614956952975;5656.236408084856;5676.403977582459;5794.884102318014;5446.455354464521;5627.352854421794;5643.435656434488;5667.829965101054;5667.8866422672145 08:36:15 INFO - PROCESS | 1636 | |5;yui.html;652.8661624367004;655.9442447391972;747.3012733094554;772.370518027807;774.6243072110029;11233.326000439969;11312.717182070452;12845.807312890302;15368.923155384235;16203.83796162038;14644.267786610653;15044;15323.233838308068;15328.15695136767;15410.30653620587;795.2445177081767;822.6257053040852;825.1130035212141;831.5883637599396;831.5966756123275;661.1438187547114;678.1895634716516;804.6499772598909;811.4644334739044;828.4325237212529;851.953142577158;858.2318824651933;859.6002858670716;862.0732712334235;864.3733293362325;851.8594431918726;858.2447446247294;858.5792961448908;860.6084231674573;862.2498426369068;638.4381744065239;640.4236187431303;643.5559463969846;644.3427703742203;644.6776611694153;13750.312484375741;14267;14275.14349139055;14279.286035698278;14294.428222871073;13121.343932803322;13182.340882955814;13340.466381344831;13395.19628822264;13446;10897.67306980792;11010.084475463418;11266.943665281704;11273.549058037668;11565.479553420117;3523.6652518010746;3620.7827530348;3726.739128261023;3759.473673685686;3766.3785475396526;72939;84613.15386846176;85686.57156714177;90179;90915;10192.949035254924;10344.120749736358;10392.532336044897;10418;10463.947680261703;19980.3006894758;20134.993250337717;20156.29452969139;20349.694754578693;20404.897975510026;7520.887186692204;7522.6614802334025;7524.322810947041;7552.207018263003;7643.4267429942975;3712.1647629283193;4123.113530590937;4183.414321994923;4198;4234.788260586958;2908;3391.3047825195777;3483.26851361217;3490.7381946354126;3496.056064862473;616.8889599872066;652.5138771615177;655.4559715436177;656.3272645538361;672.0893189727848;597.7071235094859;640.8814369341686;646.5344951634816;646.8609249011486;658.4732214228694;7525.623718814038;8379.748607541784;9011.143941325563;9086.772830679285;9370.718878433658;547.7015026810398;557.3701717059697;598.3776872053103;616.2851092732499;628.9339619339995;4470.329450582439;4470.9105817883465;4471.619912307425;4478.462584489817;4521.728696278234;118791;120095;120765.18852217223;121824;124685;77235.2276477228;96281;107524.9247507515;108871.45564272128;109863.90136098697;69282.65358673174;94182.52908735412;94260.64348391345;95671.52164239273;96039;8522.318214542945;8746;8757.861478007819;8779.692710755093;8874.112588741074;47921.28118078162;51041.48958510367;52003.47996519986;60092.69953650204;60311.69844150751;50086.749566251936;72224;76102;78867.21132788599;81112.5944370298;11846.348450834943;12270.570530031406;12532;12615.621531354074;12916.289604071866;13801.51694690681;13979.510717124851;14271.357788899317;14786.63033424173;14837.109773413198;13158.539451119164;13210.669733256746;13571.79642305386;13706.520271790838;13726.86273137256;13082.476700932237;13175.07774455779;13214.603561893158;13220.537281195497;13318;12081.879181208427;12329.198602090835;12416.875831241934;12683.936580317039;12762.17045892014;10506.789864202827;10837.188983101407;11206.159538034517;11453;11588.88411115878;8007.719729809429;10775.191860610643;11423.257488263236;11584.073274138218;11637.592684256011 08:36:15 INFO - PROCESS | 1636 | __end_tp_report 08:36:15 INFO - PROCESS | 1636 | __start_cc_report 08:36:15 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,369 08:36:15 INFO - PROCESS | 1636 | __end_cc_report 08:36:15 INFO - PROCESS | 1636 | __startTimestamp1480350975249__endTimestamp 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | ------- Summary: start ------- 08:36:15 INFO - PROCESS | 1636 | Number of tests: 6 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5766.07 Median:5976.55 stddev:644.35 (10.8%) stddev-sans-first:606.44 08:36:15 INFO - PROCESS | 1636 | Values: 2920.6 3400.9 3409.0 3432.6 3471.1 5735.8 5775.4 5780.1 5793.4 5813.7 5767.3 5831.0 5840.3 5862.6 5880.3 5289.0 5298.3 5315.5 5318.2 5336.5 5369.1 5375.4 5376.3 5382.9 5397.9 5213.9 5239.7 5369.0 5369.4 5375.5 5316.1 5332.9 5338.8 5350.7 5351.5 5166.6 5240.2 5260.3 5302.3 5309.2 5876.8 5903.4 5941.5 5961.9 5985.0 6077.5 6261.0 6290.6 6297.2 6299.3 6218.9 6241.4 6270.3 6297.9 6299.4 4784.4 5956.4 5967.8 5988.0 6019.9 5259.4 6303.9 6307.4 6356.7 6360.2 5999.2 6066.8 6225.2 6241.7 6259.7 6137.5 6171.9 6185.5 6210.6 6225.6 6095.5 6118.8 6122.9 6136.1 6188.8 6110.9 6144.8 6150.2 6193.3 6200.6 4915.2 4919.0 4922.6 4973.5 4990.9 4405.4 4451.4 4456.9 4465.9 4498.3 5699.9 5925.8 5949.9 5970.8 5976.6 5480.0 6207.4 6252.7 6276.4 6288.3 5763.5 6004.8 6018.9 6050.2 6057.9 4963.9 5327.4 5391.6 5427.8 5467.6 4950.2 6302.7 6313.5 6335.0 6346.2 6238.7 6244.8 6286.6 6300.9 6312.7 6326.6 6351.8 6361.4 6368.4 6402.3 5339.7 6272.9 6273.4 6275.5 6284.9 5188.8 6102.0 6219.8 6224.3 6268.5 6160.4 6182.3 6192.3 6211.6 6231.3 6147.2 6159.1 6186.9 6200.7 6252.5 5873.5 5924.5 5939.0 5949.1 5978.6 5951.7 6062.9 6109.3 6126.3 6143.2 5880.9 5894.5 5926.7 5944.1 5959.3 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:69273.76 Median:38141.52 stddev:155040.98 (406.5%) stddev-sans-first:155389.80 08:36:15 INFO - PROCESS | 1636 | Values: 451.3 455.0 512.0 521.4 545.0 30068.7 31148.9 37376.0 38783.0 38848.0 35423.5 38570.5 39911.8 40350.4 40383.8 9166.3 9344.0 9348.6 9376.9 9379.0 9138.5 9233.0 9234.9 9239.3 9255.3 9212.8 9219.0 9235.9 9257.4 9257.5 8053.0 8310.7 9089.7 9211.7 9232.0 9194.7 9260.3 9271.6 9276.0 9303.1 37515.2 37717.1 37763.8 37771.0 37849.0 3057.0 3272.3 3288.4 3297.6 3317.2 28289.0 28455.1 29076.0 29763.8 30333.2 2537.3 2761.5 3173.2 3179.2 3194.7 415592.9 481763.0 482312.0 486101.6 486440.7 58777.7 59017.7 59131.7 59248.0 59418.8 50338.0 51798.5 51923.0 53848.0 56426.7 16078.8 16316.3 16332.5 16364.7 16370.3 12533.7 12603.1 12610.9 12628.7 12641.6 14926.4 17821.7 18023.7 18061.5 18177.7 6513.6 6684.7 7592.8 7775.2 7844.5 834.5 869.9 898.5 937.3 986.7 29348.0 29457.9 29509.7 29665.9 29830.7 1036.8 1063.1 1064.1 1096.3 1107.7 13304.5 13709.9 14525.3 14716.4 15019.0 656179.0 660821.0 661232.0 662408.0 664403.0 54133.0 54592.7 54728.7 54747.5 54861.7 1334.7 1358.0 1386.4 1386.6 1386.9 23398.0 28603.3 29001.6 29030.0 29608.0 46584.0 47288.8 47404.0 47461.8 47570.3 583519.0 587696.0 589381.0 589500.0 592069.0 25241.5 25472.4 25472.9 25637.7 25677.9 43266.4 43578.8 43658.3 44865.0 44968.9 37049.6 37112.0 37118.6 37363.3 38231.6 36808.3 36998.1 38114.8 38168.2 38195.0 35766.0 35776.8 36439.8 36585.6 36742.4 31647.7 32953.0 33221.0 33221.2 33245.3 22712.2 23233.3 24415.9 24862.5 25295.9 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:29357.42 Median:1584.90 stddev:75819.74 (4783.9%) stddev-sans-first:76001.05 08:36:15 INFO - PROCESS | 1636 | Values: 302.8 372.3 378.2 384.6 404.5 15791.9 16747.3 19302.3 19547.0 19575.6 11390.4 17537.1 17699.6 18276.3 18320.0 5248.1 5466.8 5491.8 5493.7 5502.9 5217.3 5272.0 5329.3 5411.9 5504.6 5314.0 5316.8 5319.1 5319.4 5325.4 5098.8 5296.0 5304.4 5322.6 5409.7 5231.3 5275.2 5280.3 5286.3 5292.6 12738.9 14267.1 20387.0 22484.0 23402.3 1999.8 2150.1 2268.9 2430.9 2867.0 7939.6 9748.4 10153.3 10164.0 13502.7 1630.3 1779.8 1865.5 1923.0 1951.1 91008.5 112050.0 119257.8 119726.0 120166.4 11498.3 11683.6 11683.7 11793.2 11822.9 11522.2 12101.7 14600.0 14626.7 14628.0 7915.8 8029.3 8137.4 8173.3 8216.1 8446.8 8465.0 8550.2 8589.0 8613.7 3799.8 3913.2 3917.5 3955.8 3970.8 1928.0 1959.4 1961.4 1961.9 1969.2 844.5 908.9 938.5 944.9 974.6 19796.6 20420.1 20465.9 20582.5 20982.2 913.4 930.5 990.3 1001.3 1003.5 9693.8 10750.0 10781.7 10782.1 10844.6 387727.0 388759.0 392041.0 487680.0 546838.0 95133.6 124506.8 125749.0 126101.2 131570.0 949.9 969.7 1002.5 1006.3 1009.3 17977.2 18312.7 18443.9 18458.4 18529.4 34684.0 44671.0 51189.0 51900.5 53986.2 61757.0 71161.0 75529.0 77964.6 78955.0 6297.4 7371.0 8033.9 8050.7 8092.2 10384.0 12404.9 12455.0 12528.1 12586.2 8245.9 9653.5 10232.2 10670.8 10955.9 10058.3 10470.5 10671.0 10735.1 11004.2 5516.2 8915.7 10520.5 10796.3 10833.8 6752.6 7229.5 7393.3 7749.7 8407.0 10726.3 10773.1 10880.9 11022.4 11149.2 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5435.44 Median:5234.82 stddev:2974.19 (56.8%) stddev-sans-first:2967.25 08:36:15 INFO - PROCESS | 1636 | Values: 1422.9 1505.9 1686.5 1800.6 1865.9 7443.1 7499.8 7876.5 8078.6 8545.6 6980.5 8009.6 8333.0 8451.8 8461.2 1833.6 2262.5 2262.8 2263.9 2271.9 2329.2 2375.9 2375.9 2384.3 2398.7 1921.4 1944.7 2300.0 2316.3 2343.4 2291.7 2302.6 2316.1 2337.4 2338.3 2287.2 2314.0 2321.2 2327.0 2336.8 8469.1 8481.0 8538.6 8568.1 8594.2 5070.3 5230.7 5234.2 5237.4 5240.9 3191.8 3219.9 3244.6 3310.9 3481.9 1035.1 1055.9 1085.6 1103.7 1110.7 10748.9 10757.9 10817.8 10918.6 10934.7 4506.4 4650.1 4738.2 4753.7 4756.5 9450.1 9546.3 9564.9 9570.8 9611.0 5235.5 5240.6 5249.6 5254.9 5264.2 4095.1 4751.6 4796.1 4811.0 4816.2 3798.1 3812.4 3911.3 3924.9 3926.0 1142.0 1266.3 1284.7 1293.1 1300.2 880.0 892.1 902.1 903.0 907.3 5519.3 5717.8 5806.4 5833.1 5878.3 916.9 918.9 920.6 934.0 978.3 3719.8 3837.5 3849.8 3850.3 3866.5 9929.3 10248.0 10342.4 10381.4 10383.3 8854.6 10219.0 10232.2 10249.1 10350.0 6892.6 7781.0 7894.8 7925.6 7934.1 5592.6 5662.8 5677.2 5775.1 5808.0 7251.7 8517.9 9311.1 9477.7 9628.0 7876.8 9512.1 9700.7 9733.1 9796.9 6647.9 6888.3 7171.4 7302.6 7329.0 7743.5 7936.7 7980.2 8079.6 8090.6 6865.1 7067.5 7085.3 7107.7 7126.0 7051.5 7087.9 7121.3 7149.1 7177.9 6579.0 6618.4 6659.1 6699.0 6738.7 4013.9 4743.7 4784.6 4804.3 4888.3 4721.1 4820.0 4827.5 4859.0 4920.3 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4622.74 Median:5263.45 stddev:1461.70 (27.8%) stddev-sans-first:1429.12 08:36:15 INFO - PROCESS | 1636 | Values: 287.4 308.2 315.3 316.1 318.8 5326.4 5478.8 5511.8 5520.5 5573.5 4307.7 5154.8 5444.7 5460.5 5460.5 3423.6 3960.8 3964.8 4085.3 4150.7 3441.0 4132.5 4159.8 4164.4 4168.3 4113.7 4137.0 4151.8 4171.9 4198.9 3127.5 4118.7 4152.9 4194.7 4200.9 3250.7 3511.9 3528.0 3531.0 3531.9 4017.8 4583.6 4792.4 5316.4 5356.3 3896.9 4477.4 4710.6 4743.9 4744.0 5051.0 5093.6 5356.6 5741.7 5781.5 3324.9 3790.4 3915.7 3917.3 3955.5 5138.2 5557.1 6040.2 6067.5 6094.4 3365.0 3399.9 3475.0 3647.0 3868.5 3920.4 3986.2 3991.2 4014.9 4026.3 4502.2 4671.9 4672.9 4682.0 4686.4 4858.9 4884.2 5582.8 5820.4 5902.4 1287.8 1295.9 1301.6 1302.3 1311.6 820.8 834.4 873.9 876.5 890.6 4999.3 5248.6 5378.8 5455.9 5472.4 5014.7 5250.2 5925.9 5940.4 5941.8 4659.4 4670.5 5473.5 5478.3 5499.8 2684.9 2925.1 2960.5 2969.9 3010.6 5024.4 5162.7 5576.9 5711.3 5972.9 5221.4 5730.7 5805.8 5885.7 6214.5 6196.5 6225.7 6233.8 6275.3 6295.8 5392.1 5613.6 5969.1 6053.3 6079.4 5408.3 5557.2 5926.9 5939.5 5940.5 5524.6 6177.4 6178.2 6291.5 6333.0 3731.6 3919.0 3919.5 3925.6 3961.7 5881.0 5890.0 5905.4 5912.0 5935.0 5441.2 5751.7 5761.5 5794.8 5816.9 5712.8 5782.9 5786.0 5837.6 5869.5 4341.6 4793.9 5641.3 5652.2 5716.1 5276.7 5500.6 5656.2 5676.4 5794.9 5446.5 5627.4 5643.4 5667.8 5667.9 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20958.09 Median:4216.39 stddev:31497.12 (747.0%) stddev-sans-first:31548.58 08:36:15 INFO - PROCESS | 1636 | Values: 652.9 655.9 747.3 772.4 774.6 11233.3 11312.7 12845.8 15368.9 16203.8 14644.3 15044.0 15323.2 15328.2 15410.3 795.2 822.6 825.1 831.6 831.6 661.1 678.2 804.6 811.5 828.4 852.0 858.2 859.6 862.1 864.4 851.9 858.2 858.6 860.6 862.2 638.4 640.4 643.6 644.3 644.7 13750.3 14267.0 14275.1 14279.3 14294.4 13121.3 13182.3 13340.5 13395.2 13446.0 10897.7 11010.1 11266.9 11273.5 11565.5 3523.7 3620.8 3726.7 3759.5 3766.4 72939.0 84613.2 85686.6 90179.0 90915.0 10192.9 10344.1 10392.5 10418.0 10463.9 19980.3 20135.0 20156.3 20349.7 20404.9 7520.9 7522.7 7524.3 7552.2 7643.4 3712.2 4123.1 4183.4 4198.0 4234.8 2908.0 3391.3 3483.3 3490.7 3496.1 616.9 652.5 655.5 656.3 672.1 597.7 640.9 646.5 646.9 658.5 7525.6 8379.7 9011.1 9086.8 9370.7 547.7 557.4 598.4 616.3 628.9 4470.3 4470.9 4471.6 4478.5 4521.7 118791.0 120095.0 120765.2 121824.0 124685.0 77235.2 96281.0 107524.9 108871.5 109863.9 69282.7 94182.5 94260.6 95671.5 96039.0 8522.3 8746.0 8757.9 8779.7 8874.1 47921.3 51041.5 52003.5 60092.7 60311.7 50086.7 72224.0 76102.0 78867.2 81112.6 11846.3 12270.6 12532.0 12615.6 12916.3 13801.5 13979.5 14271.4 14786.6 14837.1 13158.5 13210.7 13571.8 13706.5 13726.9 13082.5 13175.1 13214.6 13220.5 13318.0 12081.9 12329.2 12416.9 12683.9 12762.2 10506.8 10837.2 11206.2 11453.0 11588.9 8007.7 10775.2 11423.3 11584.1 11637.6 08:36:15 INFO - PROCESS | 1636 | -------- Summary: end -------- 08:36:15 INFO - PROCESS | 1636 | 08:36:15 INFO - TEST-INFO | 1636: exit 0 08:36:15 INFO - TEST-OK | dromaeo_css | took 1116723ms 08:36:15 INFO - TEST-START | kraken 08:36:15 INFO - operating with platform_type : mac_ 08:36:15 INFO - Initialising browser for kraken test... 08:36:15 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmppSis7H/profile http://localhost:49242/getInfo.html) 08:36:18 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:36:18 INFO - PROCESS | 1649 | colorDepth:24 08:36:18 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:36:18 INFO - PROCESS | 1649 | __metrics 08:36:18 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:36:19 INFO - TEST-INFO | 1649: exit 0 08:36:19 INFO - Browser initialized. 08:36:19 INFO - Running cycle 1/1 for kraken test... 08:36:19 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmppSis7H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:31 INFO - PROCESS | 1651 | RSS: Main: 229634048 08:36:31 INFO - PROCESS | 1651 | 08:36:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:35 INFO - PROCESS | 1651 | RSS: Main: 241664000 08:36:35 INFO - PROCESS | 1651 | 08:36:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 08:36:39 INFO - PROCESS | 1651 | RSS: Main: 249249792 08:36:39 INFO - PROCESS | 1651 | 08:36:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 08:36:42 INFO - PROCESS | 1651 | RSS: Main: 253501440 08:36:42 INFO - PROCESS | 1651 | 08:36:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 08:36:45 INFO - PROCESS | 1651 | RSS: Main: 253423616 08:36:45 INFO - PROCESS | 1651 | 08:36:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:48 INFO - PROCESS | 1651 | RSS: Main: 253280256 08:36:48 INFO - PROCESS | 1651 | 08:36:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:51 INFO - PROCESS | 1651 | RSS: Main: 257273856 08:36:51 INFO - PROCESS | 1651 | 08:36:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:55 INFO - PROCESS | 1651 | RSS: Main: 256507904 08:36:55 INFO - PROCESS | 1651 | 08:36:58 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 08:36:58 INFO - PROCESS | 1651 | RSS: Main: 256790528 08:36:58 INFO - PROCESS | 1651 | 08:37:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:01 INFO - PROCESS | 1651 | RSS: Main: 257249280 08:37:01 INFO - PROCESS | 1651 | 08:37:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:03 INFO - PROCESS | 1651 | RSS: Main: 257224704 08:37:03 INFO - PROCESS | 1651 | 08:37:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:06 INFO - PROCESS | 1651 | RSS: Main: 257056768 08:37:06 INFO - PROCESS | 1651 | 08:37:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:10 INFO - PROCESS | 1651 | RSS: Main: 257347584 08:37:10 INFO - PROCESS | 1651 | 08:37:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:14 INFO - PROCESS | 1651 | RSS: Main: 257495040 08:37:14 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 08:37:16 INFO - PROCESS | 1651 | RSS: Main: 259158016 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | __start_tp_report 08:37:16 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:37:16 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:37:16 INFO - PROCESS | 1651 | |i|pagename|runs| 08:37:16 INFO - PROCESS | 1651 | |0;ai-astar;106;119;120;120;119;117;122;118;119;119 08:37:16 INFO - PROCESS | 1651 | |1;audio-beat-detection;156;144;119;146;137;131;115;117;139;115 08:37:16 INFO - PROCESS | 1651 | |2;audio-dft;195;198;197;200;196;194;192;201;201;194 08:37:16 INFO - PROCESS | 1651 | |3;audio-fft;80;60;61;87;63;57;57;63;106;87 08:37:16 INFO - PROCESS | 1651 | |4;audio-oscillator;82;71;91;73;72;74;71;85;94;125 08:37:16 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;87;90;85;88;84;132;133;138;87 08:37:16 INFO - PROCESS | 1651 | |6;imaging-darkroom;98;99;96;134;147;172;99;162;101;116 08:37:16 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;90;85;88;89;89;91;90;87;107 08:37:16 INFO - PROCESS | 1651 | |8;json-parse-financial;57;56;58;56;60;70;69;92;93;90 08:37:16 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;68;73;72;84;76;72;67;65;72;70 08:37:16 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;90;71;102;79;98;103;107;88;86;92 08:37:16 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;148;164;146;153;174;168;179;167;228;177 08:37:16 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;174;172;179;213;199;224;182;177;215;174 08:37:16 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;68;71;79;99;88;88;85;68;67 08:37:16 INFO - PROCESS | 1651 | __end_tp_report 08:37:16 INFO - PROCESS | 1651 | __start_cc_report 08:37:16 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,971 08:37:16 INFO - PROCESS | 1651 | __end_cc_report 08:37:16 INFO - PROCESS | 1651 | __startTimestamp1480351036393__endTimestamp 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:37:16 INFO - PROCESS | 1651 | Number of tests: 14 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:117.90 Median:119.00 stddev:4.38 (3.7%) stddev-sans-first:1.39 08:37:16 INFO - PROCESS | 1651 | Values: 106.0 119.0 120.0 120.0 119.0 117.0 122.0 118.0 119.0 119.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:138.00 stddev:14.77 (10.7%) stddev-sans-first:12.83 08:37:16 INFO - PROCESS | 1651 | Values: 156.0 144.0 119.0 146.0 137.0 131.0 115.0 117.0 139.0 115.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:196.80 Median:197.50 stddev:3.16 (1.6%) stddev-sans-first:3.28 08:37:16 INFO - PROCESS | 1651 | Values: 195.0 198.0 197.0 200.0 196.0 194.0 192.0 201.0 201.0 194.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:72.10 Median:63.00 stddev:16.82 (26.7%) stddev-sans-first:17.60 08:37:16 INFO - PROCESS | 1651 | Values: 80.0 60.0 61.0 87.0 63.0 57.0 57.0 63.0 106.0 87.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:78.00 stddev:16.79 (21.5%) stddev-sans-first:17.80 08:37:16 INFO - PROCESS | 1651 | Values: 82.0 71.0 91.0 73.0 72.0 74.0 71.0 85.0 94.0 125.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:87.00 stddev:22.85 (26.3%) stddev-sans-first:23.86 08:37:16 INFO - PROCESS | 1651 | Values: 90.0 87.0 90.0 85.0 88.0 84.0 132.0 133.0 138.0 87.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:122.40 Median:134.00 stddev:29.16 (21.8%) stddev-sans-first:29.57 08:37:16 INFO - PROCESS | 1651 | Values: 98.0 99.0 96.0 134.0 147.0 172.0 99.0 162.0 101.0 116.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:90.20 Median:89.00 stddev:6.20 (7.0%) stddev-sans-first:6.38 08:37:16 INFO - PROCESS | 1651 | Values: 86.0 90.0 85.0 88.0 89.0 89.0 91.0 90.0 87.0 107.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:70.10 Median:69.50 stddev:15.70 (22.6%) stddev-sans-first:15.92 08:37:16 INFO - PROCESS | 1651 | Values: 57.0 56.0 58.0 56.0 60.0 70.0 69.0 92.0 93.0 90.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:5.32 (7.4%) stddev-sans-first:5.45 08:37:16 INFO - PROCESS | 1651 | Values: 68.0 73.0 72.0 84.0 76.0 72.0 67.0 65.0 72.0 70.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:87.00 stddev:11.29 (13.0%) stddev-sans-first:11.96 08:37:16 INFO - PROCESS | 1651 | Values: 90.0 71.0 102.0 79.0 98.0 103.0 107.0 88.0 86.0 92.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:170.40 Median:171.00 stddev:23.35 (13.7%) stddev-sans-first:23.32 08:37:16 INFO - PROCESS | 1651 | Values: 148.0 164.0 146.0 153.0 174.0 168.0 179.0 167.0 228.0 177.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:190.50 stddev:19.92 (10.5%) stddev-sans-first:20.17 08:37:16 INFO - PROCESS | 1651 | Values: 174.0 172.0 179.0 213.0 199.0 224.0 182.0 177.0 215.0 174.0 08:37:16 INFO - PROCESS | 1651 | 08:37:16 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:82.00 stddev:11.57 (14.1%) stddev-sans-first:11.44 08:37:16 INFO - PROCESS | 1651 | Values: 66.0 68.0 71.0 79.0 99.0 88.0 88.0 85.0 68.0 67.0 08:37:16 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:37:16 INFO - PROCESS | 1651 | 08:37:17 INFO - TEST-INFO | 1651: exit 0 08:37:17 INFO - TEST-OK | kraken | took 61577ms 08:37:17 INFO - SUITE-END | took 1178s 08:37:17 INFO - Completed test suite (00:19:38) 08:37:17 INFO - javascript benchmark 08:37:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7119.534786607474, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2920.649522057353, 3400.8809691660795, 3408.965910340896, 3432.6052503962037, 3471.1148657092444, 5735.770569177228, 5775.364709881909, 5780.0751879699255, 5793.362730099691, 5813.651180929147, 5767.279090113736, 5831.008728516152, 5840.299164100304, 5862.618929769562, 5880.3237627672725, 5288.968651113025, 5298.311219541473, 5315.495027972336, 5318.202269659562, 5336.519713225809, 5369.060414427479, 5375.354957405117, 5376.274202982606, 5382.8923421531545, 5397.892042159155, 5213.921791173117, 5239.685618862862, 5369.0, 5369.4362091980365, 5375.462453754632, 5316.096263635172, 5332.92000619991, 5338.786448542053, 5350.705711185883, 5351.545118664918, 5166.61250406221, 5240.213967904807, 5260.289860868772, 5302.2841916341185, 5309.203619457074, 5876.794312199053, 5903.380145084747, 5941.494972927307, 5961.850953726192, 5984.97007514964, 6077.513798896078, 6260.9999999999545, 6290.559660823744, 6297.181366422382, 6299.346379100111, 6218.9378106219265, 6241.407066328691, 6270.341614130496, 6297.87404251917, 6299.37006299371, 4784.449788274358, 5956.434138756811, 5967.791127310524, 5988.041913293896, 6019.909701354527, 5259.395169555473, 6303.905441418291, 6307.400796924285, 6356.650384228819, 6360.173177486897, 5999.190109335271, 6066.757329706762, 6225.221847269091, 6241.656708881055, 6259.6870156492, 6137.4689182037, 6171.938280617136, 6185.536084793658, 6210.596311239845, 6225.564210505312, 6095.512359011268, 6118.816435506942, 6122.908156377658, 6136.140940268366, 6188.845278868064, 6110.892920173631, 6144.78493252734, 6150.154575278875, 6193.256809182927, 6200.596961197508, 4915.18899381598, 4918.975405123023, 4922.630802689812, 4973.477784832613, 4990.8752281193265, 4405.449318835145, 4451.354553589711, 4456.9331460028125, 4465.866024019285, 4498.347739577743, 5699.857503562361, 5925.822225333247, 5949.9107513387335, 5970.820875373745, 5976.551758618121, 5480.0, 6207.441330280297, 6252.656103914328, 6276.372362763778, 6288.276848162428, 5763.538916886639, 6004.819855404345, 6018.879622407528, 6050.152978582913, 6057.939420605826, 4963.925541116886, 5327.38735045467, 5391.622586418992, 5427.810026649048, 5467.617266791366, 4950.232713929347, 6302.653354065479, 6313.463355614824, 6335.049742538656, 6346.238451385863, 6238.656873871981, 6244.843878902882, 6286.622802631857, 6300.905486417616, 6312.684365781784, 6326.588771729823, 6351.777687780906, 6361.427471527585, 6368.395002474757, 6402.295747467681, 5339.652922560022, 6272.905906411499, 6273.404026617464, 6275.466585340298, 6284.937150628618, 5188.818391356284, 6101.969490152521, 6219.813405597839, 6224.346443623354, 6268.467180289544, 6160.383961603804, 6182.28903676083, 6192.349803270592, 6211.627302361872, 6231.345708700521, 6147.231596050494, 6159.076138579249, 6186.876262474635, 6200.658963757037, 6252.468540174136, 5873.471387575139, 5924.4667979882015, 5938.960681880567, 5949.137375080676, 5978.581499295182, 5951.732172052181, 6062.939370606237, 6109.34393638171, 6126.295476020315, 6143.235544005126, 5880.882382352414, 5894.528437725057, 5926.703664816828, 5944.078667806497, 5959.28488581373], "value": 5726.359727883302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.33202859767545, 454.9818007279709, 512.0067069884424, 521.3769545393255, 544.9972051425376, 30068.699313006862, 31148.90978815739, 37376.0, 38783.0, 38848.0, 35423.4686479703, 38570.4571817127, 39911.800440997824, 40350.39474407886, 40383.798081009554, 9166.312526560501, 9344.0, 9348.626054957793, 9376.8593471098, 9379.0, 9138.543072846363, 9232.953835230814, 9234.86147707785, 9239.307051971095, 9255.305852061088, 9212.769680757967, 9219.032001639833, 9235.861462078074, 9257.39826911252, 9257.490838003907, 8053.0, 8310.667573297062, 9089.68186113486, 9211.723648290563, 9232.030636783109, 9194.724158275263, 9260.305477089178, 9271.582778774971, 9275.979642239348, 9303.069693030642, 37515.24969500622, 37717.05707357311, 37763.81118094392, 37771.0, 37849.0, 3056.9847150764103, 3272.2637406583567, 3288.408086544421, 3297.5878015248095, 3317.20387107095, 28289.0, 28455.146345609457, 29076.0, 29763.80944762207, 30333.24166895823, 2537.3022418834785, 2761.4753196892525, 3173.2066983254185, 3179.157523256339, 3194.6645602211665, 415592.9220353879, 481763.0, 482312.0, 486101.5694921538, 486440.7033894459, 58777.70611146917, 59017.704911475164, 59131.74775387309, 59248.0, 59418.811623768146, 50338.0, 51798.48201517937, 51923.0, 53848.0, 56426.71786641041, 16078.839211607969, 16316.26576804023, 16332.510024699279, 16364.67270654604, 16370.263338149813, 12533.686657833627, 12603.117781755189, 12610.936945315214, 12628.747425051632, 12641.557545486048, 14926.40294388234, 17821.7326740099, 18023.72964405509, 18061.548461288574, 18177.72733409, 6513.609183449008, 6684.732610695615, 7592.81017974544, 7775.22247775218, 7844.450888437868, 834.5201509132273, 869.9473636899296, 898.5372533145435, 937.3438592984937, 986.6645340584236, 29347.972820951163, 29457.852710736308, 29509.704902951125, 29665.851670741507, 29830.70169298279, 1036.7719101797593, 1063.1388575254068, 1064.1005804638683, 1096.3367162866512, 1107.7230692326918, 13304.467821287233, 13709.931450342685, 14525.346359413852, 14716.411343546353, 15019.02376345534, 656179.0, 660821.0, 661232.0, 662408.0, 664403.0, 54133.0, 54592.727036364566, 54728.72635636876, 54747.45252547503, 54861.725691371284, 1334.739725753488, 1357.9660508487366, 1386.4038463460606, 1386.5770939863237, 1386.8890488760876, 23398.0, 28603.28491787722, 29001.56497652579, 29029.98395056163, 29608.0, 46584.0, 47288.763556182, 47404.0, 47461.762691186326, 47570.286445704034, 583519.0, 587696.0, 589381.0, 589500.0, 592069.0, 25241.495170096863, 25472.363190920376, 25472.872635637446, 25637.74362256428, 25677.87161064183, 43266.35100473558, 43578.78210608927, 43658.25366985412, 44865.0, 44968.8757781045, 37049.629503704615, 37112.0, 37118.628813712596, 37363.2527349446, 38231.617683822806, 36808.26383472369, 36998.07504812401, 38114.809425953805, 38168.236635266585, 38195.0, 35766.0, 35776.82111589425, 36439.817800911886, 36585.63414365822, 36742.44886326761, 31647.683523165393, 32953.0, 33221.00336989894, 33221.16947076342, 33245.33509329848, 22712.205072822373, 23233.30300091, 24415.877920610284, 24862.50274994454, 25295.873520632278], "value": 19089.505341687607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.8394950676142, 372.2945019188636, 378.2265267527905, 384.6057790764467, 404.54286656078625, 15791.921040394796, 16747.33010679573, 19302.324418645334, 19547.0, 19575.608487830235, 11390.430478476084, 17537.123143842822, 17699.55751106223, 18276.268949242014, 18320.0, 5248.0553500369915, 5466.835994920159, 5491.780328786864, 5493.725313734298, 5502.9174562381595, 5217.34783152106, 5271.973640131794, 5329.333833270841, 5411.864703382427, 5504.559635229172, 5313.9734301328435, 5316.813911513098, 5319.148936170213, 5319.414864364917, 5325.4142044375085, 5098.821541246039, 5295.973520132394, 5304.389995150549, 5322.600804939645, 5409.702466364349, 5231.3199284092825, 5275.155975044013, 5280.339957505312, 5286.286351342596, 5292.603054770908, 12738.87261127386, 14267.07264027835, 20386.98065096754, 22484.0, 23402.297931062094, 1999.7600287965538, 2150.0754675489534, 2268.943276418086, 2430.902763889442, 2866.967891559037, 7939.64271607779, 9748.415095094246, 10153.28926975112, 10164.0, 13502.729945401135, 1630.2745278351138, 1779.7508348831175, 1865.4590168851016, 1922.9615407691908, 1951.1317463728647, 91008.54495727479, 112050.0, 119257.80742192554, 119726.0, 120166.39916800447, 11498.310101393943, 11683.591074312359, 11683.707907302385, 11793.174477786473, 11822.88177118235, 11522.193446458667, 12101.697457563456, 14599.978001540003, 14626.707465850623, 14628.0, 7915.802104947423, 8029.317508011768, 8137.389695772841, 8173.346132309401, 8216.09622941476, 8446.831063378699, 8464.957675211585, 8550.230479256772, 8588.969323681198, 8613.741587752378, 3799.8290076946605, 3913.1977944521304, 3917.5494818096286, 3955.8417663293144, 3970.82131304092, 1928.0, 1959.3730006397816, 1961.3527535913115, 1961.8724782889067, 1969.222157247879, 844.50174397106, 908.909109089099, 938.5401153434768, 944.900785417535, 974.5858010345574, 19796.60406791856, 20420.0810963507, 20465.89767051185, 20582.485437864172, 20982.160713571593, 913.3789023464108, 930.4835816121982, 990.2721499697716, 1001.3241062283075, 1003.533356988989, 9693.806123877483, 10749.998759348273, 10781.676549703521, 10782.137429005661, 10844.620438284623, 387727.0, 388759.0, 392041.0, 487680.0, 546838.0, 95133.57299640511, 124506.75493245132, 125749.0, 126101.15412418639, 131570.0, 949.886013678363, 969.7236287658125, 1002.518790980319, 1006.3056491021318, 1009.2733232072895, 17977.191026403583, 18312.72530912011, 18443.907780461548, 18458.35395761142, 18529.44411667652, 34684.0, 44671.0, 51189.0, 51900.480995189566, 53986.19020714771, 61757.0, 71161.0, 75529.0, 77964.61017694876, 78955.0, 6297.433231009231, 7370.96314518424, 8033.919660803317, 8050.6779728812535, 8092.231238032377, 10384.0, 12404.937975310066, 12455.0, 12528.060395470558, 12586.24482531051, 8245.917540824516, 9653.455447128426, 10232.23258255619, 10670.786584268426, 10955.890441095806, 10058.34620749649, 10470.528826202992, 10671.039606435457, 10735.141188704729, 11004.22970392097, 5516.172574113915, 8915.73252802417, 10520.473976301308, 10796.298240614335, 10833.783324333312, 6752.5948443093575, 7229.457790665616, 7393.297636724503, 7749.7287594933905, 8407.0, 10726.302790318605, 10773.138148947908, 10880.891191087987, 11022.393768342497, 11149.219554631098], "value": 8939.16623743319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.9359678814453, 1505.9096454212747, 1686.5362025443, 1800.6398720255952, 1865.899119519484, 7443.106827180733, 7499.762539181035, 7876.527408355502, 8078.636461359239, 8545.572721363938, 6980.511364204508, 8009.59952002399, 8332.958335208315, 8451.788705282372, 8461.196186362302, 1833.6241070580531, 2262.536180083079, 2262.7737226277404, 2263.8868056597103, 2271.9091236350528, 2329.23135365329, 2375.893084811179, 2375.9168429104984, 2384.3204686664303, 2398.724146723123, 1921.3851567498407, 1944.6985717213854, 2300.0339857259905, 2316.293530473205, 2343.3907184132077, 2291.690621766057, 2302.6315789473606, 2316.06199489208, 2337.415646088478, 2338.3452633262714, 2287.176616418088, 2313.976860231393, 2321.1875843454823, 2326.953460930772, 2336.7896889280046, 8469.11074337198, 8481.02468216157, 8538.615762290712, 8568.143185681445, 8594.226519613203, 5070.315507406527, 5230.712310822903, 5234.18870075139, 5237.371515418136, 5240.868978275574, 3191.776575639706, 3219.919502012445, 3244.5944256967878, 3310.9006729798143, 3481.9129521761906, 1035.1098055672117, 1055.8680164979378, 1085.6037546295624, 1103.6535426779317, 1110.7167672243527, 10748.892511074946, 10757.892421075767, 10817.83773243402, 10918.563257469772, 10934.726631834188, 4506.369108324837, 4650.093231819763, 4738.19450693383, 4753.6910100844025, 4756.500567440369, 9450.149486546106, 9546.284028697875, 9564.90435095654, 9570.808583828284, 9611.0, 5235.450277720861, 5240.580753539708, 5249.580033597303, 5254.947450525522, 5264.236685680555, 4095.1400205957084, 4751.572358487683, 4796.136695394793, 4810.95189048112, 4816.229403295456, 3798.1264309208486, 3812.390017597171, 3911.2959667260166, 3924.941125883114, 3925.9988702881155, 1141.9828702569469, 1266.2972050511871, 1284.7237843863613, 1293.140061858872, 1300.219868079164, 880.0275695356539, 892.1346294094718, 902.120432578231, 902.9819403611891, 907.3376435202339, 5519.31008623922, 5717.799877004368, 5806.4193580641595, 5833.095870140135, 5878.3239927408895, 916.9174774270215, 918.93108016899, 920.5535315372039, 933.9579718912665, 978.3151793744407, 3719.776813391205, 3837.4819399380726, 3849.846006159722, 3850.306944749972, 3866.4586957825927, 9929.255305851946, 10248.026437488426, 10342.37945723259, 10381.377117372831, 10383.273170878118, 8854.64581416749, 10218.978102189722, 10232.181425485944, 10249.12882405004, 10350.016748408889, 6892.586444813327, 7780.961095194601, 7894.763157105296, 7925.564093974886, 7934.127246002935, 5592.608517403743, 5662.7734890603915, 5677.233573467529, 5775.075987841925, 5807.970960145172, 7251.746188883364, 8517.892673952594, 9311.068893110634, 9477.668281610111, 9627.989061148479, 7876.84246315059, 9512.1439070484, 9700.708978730649, 9733.124018838338, 9796.85304720444, 6647.867042659216, 6888.276730943179, 7171.42628589722, 7302.56184628924, 7329.0, 7743.45795794289, 7936.722214722457, 7980.241877021674, 8079.636416361395, 8090.555019473985, 6865.107536020485, 7067.540609860343, 7085.326893945067, 7107.680154393168, 7126.0, 7051.471139664443, 7087.893681594677, 7121.323474269936, 7149.0706208192605, 7177.928220717726, 6579.046038324512, 6618.437432818265, 6659.134312539532, 6698.966505167443, 6738.66306684654, 4013.8884731658386, 4743.739094349844, 4784.593309568587, 4804.25534042224, 4888.291197776373, 4721.079389519011, 4819.975900120618, 4827.541383568555, 4858.975705121452, 4920.286558449076], "value": 4415.27094021306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.44236181807304, 308.19407250041144, 315.3016069406265, 316.06287357983575, 318.8437665543884, 5326.360836699591, 5478.835634930949, 5511.779528818853, 5520.530754885829, 5573.526250268727, 4307.67692423068, 5154.819581314655, 5444.6932736143335, 5460.481254280847, 5460.535854452376, 3423.623401425841, 3960.8019599020076, 3964.801759912007, 4085.305498065336, 4150.667946564267, 3440.9827950860335, 4132.462779838616, 4159.812808423628, 4164.396162556428, 4168.291000689718, 4113.670906327501, 4136.97931510342, 4151.83392664293, 4171.895702607429, 4198.895027624319, 3127.4526957782296, 4118.670506359514, 4152.875413737593, 4194.664426845845, 4200.928763165389, 3250.6586808385014, 3511.877084302063, 3527.9647203527893, 3531.0, 3531.8587256509963, 4017.7589344639123, 4583.587477127041, 4792.400949881265, 5316.415194328621, 5356.276902618175, 3896.8636097736444, 4477.395551600524, 4710.646701497401, 4743.857684269477, 4744.0, 5050.964552266813, 5093.643444958854, 5356.643356643357, 5741.736817900055, 5781.4507621775865, 3324.85292574064, 3790.4124860646643, 3915.7063220258597, 3917.334053210961, 3955.5055618047745, 5138.152204886189, 5557.054760976689, 6040.154378387029, 6067.544934129958, 6094.360092190301, 3364.966350336514, 3399.8810041648917, 3474.974882409695, 3646.978845923146, 3868.516435445569, 3920.3923391874305, 3986.1828325193264, 3991.2416640838146, 4014.9397759033636, 4026.315526360467, 4502.16709908668, 4671.906561868744, 4672.906541869143, 4681.976590117096, 4686.437627484655, 4858.854234372974, 4884.169691152441, 5582.7766889323975, 5820.447057529528, 5902.409759024149, 1287.7810772168755, 1295.8898493627958, 1301.5965050834272, 1302.257713103541, 1311.567182829664, 820.8481430935177, 834.3658819297377, 873.899501557329, 876.5354362187923, 890.617034675096, 4999.275105109738, 5248.60635452335, 5378.78484860609, 5455.863603409946, 5472.425395333433, 5014.749262536931, 5250.164910948121, 5925.881482370414, 5940.405959404112, 5941.8211256978175, 4659.4175728034, 4670.462896766848, 5473.452654734574, 5478.342598888159, 5499.807506737325, 2684.919452416392, 2925.1224632610133, 2960.4967155583604, 2969.9257518561776, 3010.6086208792717, 5024.422191447957, 5162.716050617252, 5576.9163462548095, 5711.315162027212, 5972.880542389128, 5221.373435187802, 5730.736359138117, 5805.767769289181, 5885.705714714247, 6214.502839772807, 6196.47329976948, 6225.719842607094, 6233.781817636361, 6275.309715931244, 6295.811125666238, 5392.110301800159, 5613.621375327251, 5969.1495636352865, 6053.334133245427, 6079.361667024898, 5408.323959505062, 5557.193617223438, 5926.911096333472, 5939.46544810969, 5940.46535811779, 5524.613277070566, 6177.444030037318, 6178.158047298293, 6291.496680265659, 6333.018382150774, 3731.645493678096, 3918.9804050979565, 3919.4904662393706, 3925.5681874994298, 3961.6632586230494, 5880.970595146997, 5889.970550147222, 5905.40945905406, 5912.0, 5934.961381758261, 5441.204402547229, 5751.705866180076, 5761.5102716269585, 5794.82615521535, 5816.912746308724, 5712.800051998326, 5782.913256301074, 5786.0, 5837.620554663933, 5869.532616845789, 4341.587549182823, 4793.9041219176115, 5641.294838145232, 5652.2086907833755, 5716.056850619601, 5276.7310056676, 5500.614956952975, 5656.236408084856, 5676.403977582459, 5794.884102318014, 5446.455354464521, 5627.352854421794, 5643.435656434488, 5667.829965101054, 5667.8866422672145], "value": 4152.2746991620415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.8661624367004, 655.9442447391972, 747.3012733094554, 772.370518027807, 774.6243072110029, 11233.326000439969, 11312.717182070452, 12845.807312890302, 15368.923155384235, 16203.83796162038, 14644.267786610653, 15044.0, 15323.233838308068, 15328.15695136767, 15410.30653620587, 795.2445177081767, 822.6257053040852, 825.1130035212141, 831.5883637599396, 831.5966756123275, 661.1438187547114, 678.1895634716516, 804.6499772598909, 811.4644334739044, 828.4325237212529, 851.953142577158, 858.2318824651933, 859.6002858670716, 862.0732712334235, 864.3733293362325, 851.8594431918726, 858.2447446247294, 858.5792961448908, 860.6084231674573, 862.2498426369068, 638.4381744065239, 640.4236187431303, 643.5559463969846, 644.3427703742203, 644.6776611694153, 13750.312484375741, 14267.0, 14275.14349139055, 14279.286035698278, 14294.428222871073, 13121.343932803322, 13182.340882955814, 13340.466381344831, 13395.19628822264, 13446.0, 10897.67306980792, 11010.084475463418, 11266.943665281704, 11273.549058037668, 11565.479553420117, 3523.6652518010746, 3620.7827530348, 3726.739128261023, 3759.473673685686, 3766.3785475396526, 72939.0, 84613.15386846176, 85686.57156714177, 90179.0, 90915.0, 10192.949035254924, 10344.120749736358, 10392.532336044897, 10418.0, 10463.947680261703, 19980.3006894758, 20134.993250337717, 20156.29452969139, 20349.694754578693, 20404.897975510026, 7520.887186692204, 7522.6614802334025, 7524.322810947041, 7552.207018263003, 7643.4267429942975, 3712.1647629283193, 4123.113530590937, 4183.414321994923, 4198.0, 4234.788260586958, 2908.0, 3391.3047825195777, 3483.26851361217, 3490.7381946354126, 3496.056064862473, 616.8889599872066, 652.5138771615177, 655.4559715436177, 656.3272645538361, 672.0893189727848, 597.7071235094859, 640.8814369341686, 646.5344951634816, 646.8609249011486, 658.4732214228694, 7525.623718814038, 8379.748607541784, 9011.143941325563, 9086.772830679285, 9370.718878433658, 547.7015026810398, 557.3701717059697, 598.3776872053103, 616.2851092732499, 628.9339619339995, 4470.329450582439, 4470.9105817883465, 4471.619912307425, 4478.462584489817, 4521.728696278234, 118791.0, 120095.0, 120765.18852217223, 121824.0, 124685.0, 77235.2276477228, 96281.0, 107524.9247507515, 108871.45564272128, 109863.90136098697, 69282.65358673174, 94182.52908735412, 94260.64348391345, 95671.52164239273, 96039.0, 8522.318214542945, 8746.0, 8757.861478007819, 8779.692710755093, 8874.112588741074, 47921.28118078162, 51041.48958510367, 52003.47996519986, 60092.69953650204, 60311.69844150751, 50086.749566251936, 72224.0, 76102.0, 78867.21132788599, 81112.5944370298, 11846.348450834943, 12270.570530031406, 12532.0, 12615.621531354074, 12916.289604071866, 13801.51694690681, 13979.510717124851, 14271.357788899317, 14786.63033424173, 14837.109773413198, 13158.539451119164, 13210.669733256746, 13571.79642305386, 13706.520271790838, 13726.86273137256, 13082.476700932237, 13175.07774455779, 13214.603561893158, 13220.537281195497, 13318.0, 12081.879181208427, 12329.198602090835, 12416.875831241934, 12683.936580317039, 12762.17045892014, 10506.789864202827, 10837.188983101407, 11206.159538034517, 11453.0, 11588.88411115878, 8007.719729809429, 10775.191860610643, 11423.257488263236, 11584.073274138218, 11637.592684256011], "value": 7268.621981692675, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 120.0, 120.0, 119.0, 117.0, 122.0, 118.0, 119.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 144.0, 119.0, 146.0, 137.0, 131.0, 115.0, 117.0, 139.0, 115.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 197.0, 200.0, 196.0, 194.0, 192.0, 201.0, 201.0, 194.0], "value": 196.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 61.0, 87.0, 63.0, 57.0, 57.0, 63.0, 106.0, 87.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 91.0, 73.0, 72.0, 74.0, 71.0, 85.0, 94.0, 125.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 85.0, 88.0, 84.0, 132.0, 133.0, 138.0, 87.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 96.0, 134.0, 147.0, 172.0, 99.0, 162.0, 101.0, 116.0], "value": 122.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 85.0, 88.0, 89.0, 89.0, 91.0, 90.0, 87.0, 107.0], "value": 90.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 56.0, 60.0, 70.0, 69.0, 92.0, 93.0, 90.0], "value": 70.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 72.0, 84.0, 76.0, 72.0, 67.0, 65.0, 72.0, 70.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 102.0, 79.0, 98.0, 103.0, 107.0, 88.0, 86.0, 92.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 164.0, 146.0, 153.0, 174.0, 168.0, 179.0, 167.0, 228.0, 177.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 179.0, 213.0, 199.0, 224.0, 182.0, 177.0, 215.0, 174.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 71.0, 79.0, 99.0, 88.0, 88.0, 85.0, 68.0, 67.0], "value": 77.9, "unit": "score"}]}]} 08:37:17 INFO - Return code: 0 08:37:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:17 ERROR - # TBPL SUCCESS # 08:37:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:37:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:37:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:37:17 INFO - 2016-11-28 08:37:17.722 screenresolution[1656:10591] starting screenresolution argv=screenresolution get 08:37:17 INFO - 2016-11-28 08:37:17.725 screenresolution[1656:10591] Display 0: 1600x1200x32@60 08:37:17 INFO - 2016-11-28 08:37:17.731 screenresolution[1657:10594] starting screenresolution argv=screenresolution list 08:37:17 INFO - Available Modes on Display 0 08:37:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:37:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:37:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:37:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:37:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:37:17 INFO - Intel Iris: 08:37:17 INFO - Chipset Model: Intel Iris 08:37:17 INFO - Type: GPU 08:37:17 INFO - Bus: Built-In 08:37:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:37:17 INFO - Vendor: Intel (0x8086) 08:37:17 INFO - Device ID: 0x0a2e 08:37:17 INFO - Revision ID: 0x0009 08:37:17 INFO - Displays: 08:37:17 INFO - Display: 08:37:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:37:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:37:17 INFO - Display Serial Number: 1600x1200 60 08:37:17 INFO - Main Display: Yes 08:37:17 INFO - Mirror: Off 08:37:17 INFO - Online: Yes 08:37:17 INFO - Rotation: Supported 08:37:17 INFO - Return code: 0 08:37:17 INFO - Running post-action listener: _resource_record_post_action 08:37:17 INFO - [mozharness: 2016-11-28 16:37:17.972644Z] Finished run-tests step (success) 08:37:17 INFO - Running post-run listener: _resource_record_post_run 08:37:18 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38552576; Write bytes: 659249152; Read time: 379; Write time: 2052 08:37:18 INFO - TinderboxPrint: CPU usage
54.3% 08:37:18 INFO - TinderboxPrint: I/O read bytes / time
38,552,576 / 379 08:37:18 INFO - TinderboxPrint: I/O write bytes / time
659,249,152 / 2,052 08:37:18 INFO - TinderboxPrint: CPU idle
2,214.0 (45.7%) 08:37:18 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 08:37:18 INFO - TinderboxPrint: CPU user
1,650.1 (34.1%) 08:37:18 INFO - TinderboxPrint: Swap in / out
387,379,200 / 0 08:37:18 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345592320; Write bytes: 345106432; Read time: 26724; Write time: 666 08:37:18 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36451328; Write bytes: 306958336; Read time: 356; Write time: 1358 08:37:18 INFO - Running post-run listener: _upload_blobber_files 08:37:18 INFO - Blob upload gear active. 08:37:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:37:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:20 INFO - (blobuploader) - INFO - Done attempting. 08:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:21 INFO - (blobuploader) - INFO - Done attempting. 08:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:23 INFO - (blobuploader) - INFO - Done attempting. 08:37:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:23 INFO - Return code: 0 08:37:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/976727919e296fe36cc48817b71c785912244a0be0f2f891ad4c09df643c3db50380da18069d2040690f73508a60ee5c9f6a73f9615431a12de0c997bd4433c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed92261e5bf9f9789ffb5ee8a14df35df984ac903295e21cb8be892e98fc59910fc55bf330a14c63cac05185ddb407ea8ee91aa64b0aa36291147ac996d41265", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/791621a1b8f5e3dd3c8d834bfab45b086f075fac62af9649fc81b52fd3e8ef688815d2f835ce2f00b8ea665cb5a39658bdea99a8f896df77c11c413c6bac2ee6"} 08:37:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:23 INFO - Contents: 08:37:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/976727919e296fe36cc48817b71c785912244a0be0f2f891ad4c09df643c3db50380da18069d2040690f73508a60ee5c9f6a73f9615431a12de0c997bd4433c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed92261e5bf9f9789ffb5ee8a14df35df984ac903295e21cb8be892e98fc59910fc55bf330a14c63cac05185ddb407ea8ee91aa64b0aa36291147ac996d41265", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/791621a1b8f5e3dd3c8d834bfab45b086f075fac62af9649fc81b52fd3e8ef688815d2f835ce2f00b8ea665cb5a39658bdea99a8f896df77c11c413c6bac2ee6"} 08:37:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:23 INFO - Copying logs to upload dir... 08:37:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.031240 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-28 08:37:23.531890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 08:37:23.534985) ========= 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.OaqqePW4gr/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.xYNWvUZvVd/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/976727919e296fe36cc48817b71c785912244a0be0f2f891ad4c09df643c3db50380da18069d2040690f73508a60ee5c9f6a73f9615431a12de0c997bd4433c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed92261e5bf9f9789ffb5ee8a14df35df984ac903295e21cb8be892e98fc59910fc55bf330a14c63cac05185ddb407ea8ee91aa64b0aa36291147ac996d41265", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/791621a1b8f5e3dd3c8d834bfab45b086f075fac62af9649fc81b52fd3e8ef688815d2f835ce2f00b8ea665cb5a39658bdea99a8f896df77c11c413c6bac2ee6"} build_url:https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010741 build_url: 'https://queue.taskcluster.net/v1/task/LeZCSdjQSaawYMsB8P8MUA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/976727919e296fe36cc48817b71c785912244a0be0f2f891ad4c09df643c3db50380da18069d2040690f73508a60ee5c9f6a73f9615431a12de0c997bd4433c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed92261e5bf9f9789ffb5ee8a14df35df984ac903295e21cb8be892e98fc59910fc55bf330a14c63cac05185ddb407ea8ee91aa64b0aa36291147ac996d41265", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/791621a1b8f5e3dd3c8d834bfab45b086f075fac62af9649fc81b52fd3e8ef688815d2f835ce2f00b8ea665cb5a39658bdea99a8f896df77c11c413c6bac2ee6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 08:37:23.568125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:37:23.568436) ========= 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.OaqqePW4gr/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.xYNWvUZvVd/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.005151 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:37:23.616497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 08:37:23.616812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 08:37:23.617122) ========= ========= Total master_lag: 0.18 =========