builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0107 starttime: 1477515431.97 results: success (0) buildid: 20161011025846 builduid: 5120a331d5884b248fd298482f4fffa2 revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:11.974854) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:11.975274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:11.975541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:12.001470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:12.001829) ========= 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.G32zHdK66b/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.XwqiLEC6e1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-26 13:57:12-- 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% 16.2M=0.001s 2016-10-26 13:57:12 (16.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:12.169764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:12.170108) ========= 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.G32zHdK66b/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.XwqiLEC6e1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.027525 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:12.218896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:57:12.219249) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45052ddb03a448606ca6ce33f4893a559edebf72 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 45052ddb03a448606ca6ce33f4893a559edebf72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G32zHdK66b/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.XwqiLEC6e1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-26 13:57:12,294 truncating revision to first 12 chars 2016-10-26 13:57:12,294 Setting DEBUG logging. 2016-10-26 13:57:12,294 attempt 1/10 2016-10-26 13:57:12,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45052ddb03a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:57:13,662 unpacking tar archive at: mozilla-central-45052ddb03a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.645349 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:57:13.887320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:13.887639) ========= script_repo_revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:13.888098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:13.888379) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:57:13.907337) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 13:57:13.907737) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G32zHdK66b/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.XwqiLEC6e1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57:14 INFO - MultiFileLogger online at 20161026 13:57:14 in /builds/slave/test 13:57:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:57:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:57:14 INFO - {'append_to_log': False, 13:57:14 INFO - 'base_work_dir': '/builds/slave/test', 13:57:14 INFO - 'blob_upload_branch': 'Firefox', 13:57:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:57:14 INFO - 'branch': 'Firefox', 13:57:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:57:14 INFO - 'config_files': ('talos/mac_config.py',), 13:57:14 INFO - 'default_actions': ('clobber', 13:57:14 INFO - 'read-buildbot-config', 13:57:14 INFO - 'download-and-extract', 13:57:14 INFO - 'populate-webroot', 13:57:14 INFO - 'create-virtualenv', 13:57:14 INFO - 'install', 13:57:14 INFO - 'run-tests'), 13:57:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:57:14 INFO - 'download_minidump_stackwalk': True, 13:57:14 INFO - 'download_symbols': 'ondemand', 13:57:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:57:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:57:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:57:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:57:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:57:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:57:14 INFO - 'installer_path': 'installer.exe', 13:57:14 INFO - 'log_level': 'info', 13:57:14 INFO - 'log_name': 'talos', 13:57:14 INFO - 'log_to_console': True, 13:57:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:57:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:57:14 INFO - 'opt_config_files': (), 13:57:14 INFO - 'pip_index': False, 13:57:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:57:14 INFO - 'cmd': ('bash', 13:57:14 INFO - '-c', 13:57:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:57:14 INFO - 'enabled': True, 13:57:14 INFO - 'halt_on_failure': False, 13:57:14 INFO - 'name': 'check_screen_resolution'},), 13:57:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:57:14 INFO - 'cmd': ('bash', 13:57:14 INFO - '-c', 13:57:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:57:14 INFO - 'enabled': True, 13:57:14 INFO - 'halt_on_failure': False, 13:57:14 INFO - 'name': 'check_screen_resolution'},), 13:57:14 INFO - 'run_cmd_checks_enabled': True, 13:57:14 INFO - 'sps_profile': False, 13:57:14 INFO - 'sps_profile_interval': 0, 13:57:14 INFO - 'suite': 'dromaeojs', 13:57:14 INFO - 'system_bits': '32', 13:57:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:57:14 INFO - 'title': 't-yosemite-r7-0107', 13:57:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:57:14 INFO - 'use_talos_json': True, 13:57:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:57:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:57:14 INFO - 'work_dir': 'build'} 13:57:14 INFO - [mozharness: 2016-10-26 20:57:14.109660Z] Running clobber step. 13:57:14 INFO - Running pre-action listener: _resource_record_pre_action 13:57:14 INFO - Running main action method: clobber 13:57:14 INFO - rmtree: /builds/slave/test/build 13:57:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:57:16 INFO - Running post-action listener: _resource_record_post_action 13:57:16 INFO - [mozharness: 2016-10-26 20:57:16.356047Z] Finished clobber step (success) 13:57:16 INFO - [mozharness: 2016-10-26 20:57:16.356211Z] Running read-buildbot-config step. 13:57:16 INFO - Running pre-action listener: _resource_record_pre_action 13:57:16 INFO - Running main action method: read_buildbot_config 13:57:16 INFO - Using buildbot properties: 13:57:16 INFO - { 13:57:16 INFO - "project": "", 13:57:16 INFO - "product": "firefox", 13:57:16 INFO - "script_repo_revision": "production", 13:57:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:57:16 INFO - "repository": "", 13:57:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:57:16 INFO - "buildid": "20161011025846", 13:57:16 INFO - "pgo_build": "False", 13:57:16 INFO - "basedir": "/builds/slave/test", 13:57:16 INFO - "buildnumber": 59, 13:57:16 INFO - "slavename": "t-yosemite-r7-0107", 13:57:16 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:57:16 INFO - "platform": "yosemite_r7", 13:57:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:57:16 INFO - "branch": "mozilla-central", 13:57:16 INFO - "repo_path": "mozilla-central", 13:57:16 INFO - "revision": "45052ddb03a448606ca6ce33f4893a559edebf72", 13:57:16 INFO - "stage_platform": "macosx64", 13:57:16 INFO - "builduid": "5120a331d5884b248fd298482f4fffa2", 13:57:16 INFO - "slavebuilddir": "test" 13:57:16 INFO - } 13:57:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:57:16 INFO - Running post-action listener: _resource_record_post_action 13:57:16 INFO - [mozharness: 2016-10-26 20:57:16.359197Z] Finished read-buildbot-config step (success) 13:57:16 INFO - [mozharness: 2016-10-26 20:57:16.359302Z] Running download-and-extract step. 13:57:16 INFO - Running pre-action listener: _resource_record_pre_action 13:57:16 INFO - Running main action method: download_and_extract 13:57:16 INFO - mkdir: /builds/slave/test/build/tests 13:57:16 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')]} 13:57:16 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:57:16 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:57:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:57:17 INFO - Downloaded 1199 bytes. 13:57:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:57:17 INFO - Using the following test package requirements: 13:57:17 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:57:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:57:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:57:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'jsshell-mac.zip'], 13:57:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:57:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:57:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:57:17 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:57:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:57:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:57:17 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:57:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:57:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:57:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:57:17 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:57:18 INFO - Http code: 200 13:57:18 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 13:57:18 INFO - x-amz-cf-id: sYVaUj8kLNusE_evZ0troSk5nlonOjYznW-Th5jQyTOpLLz-nYsIVg== 13:57:18 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:57:18 INFO - Expected file size: 16508481 13:57:18 INFO - Obtained file size: 16508481 13:57:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:57:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:57:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:57:25 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:57:26 INFO - Http code: 200 13:57:26 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:57:26 INFO - x-amz-cf-id: 8XJrpi4ylbuxEYOX7IISMZJ85YrUKGF4CLlzzYdaA8k1ZzR5f-FRNg== 13:57:26 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:57:26 INFO - Expected file size: 16508481 13:57:26 INFO - Obtained file size: 16508481 13:57:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:57:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:57:32 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:57:33 INFO - Http code: 200 13:57:33 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 13:57:33 INFO - x-amz-cf-id: Z69ohnU5hSUlzjb3IGrpZzDuNyS2Y0vJfLWJVkG-ldwDg8U9LpMktQ== 13:57:33 INFO - x-amz-version-id: h7oaKNhRQzyZtP5vdBlaq4n0FwksjilO 13:57:33 INFO - Expected file size: 14409006 13:57:33 INFO - Obtained file size: 14409006 13:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:34 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:57:34 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:57:36 INFO - Downloaded 111738529 bytes. 13:57:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:57:36 INFO - mkdir: /builds/slave/test/properties 13:57:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:57:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:57:36 INFO - Contents: 13:57:36 INFO - build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:57:37 INFO - Running post-action listener: _resource_record_post_action 13:57:37 INFO - Running post-action listener: set_extra_try_arguments 13:57:37 INFO - [mozharness: 2016-10-26 20:57:37.582281Z] Finished download-and-extract step (success) 13:57:37 INFO - [mozharness: 2016-10-26 20:57:37.582433Z] Running populate-webroot step. 13:57:37 INFO - Running pre-action listener: _resource_record_pre_action 13:57:37 INFO - Running main action method: populate_webroot 13:57:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:57:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:57:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:57:37 INFO - '--tppagecycles', 13:57:37 INFO - '7'], 13:57:37 INFO - 'tests': ['tsvgm']}}, 13:57:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:57:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:57:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:57:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:57:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['damp', 'tps']}, 13:57:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'tests': ['damp', 'tps']}, 13:57:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['dromaeo_dom']}, 13:57:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:57:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['basic_compositor_video']}, 13:57:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:57:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['a11yr', 13:57:37 INFO - 'ts_paint', 13:57:37 INFO - 'tpaint', 13:57:37 INFO - 'sessionrestore', 13:57:37 INFO - 'sessionrestore_no_auto_restore', 13:57:37 INFO - 'tabpaint']}, 13:57:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:57:37 INFO - 'ts_paint', 13:57:37 INFO - 'tpaint', 13:57:37 INFO - 'sessionrestore', 13:57:37 INFO - 'sessionrestore_no_auto_restore', 13:57:37 INFO - 'tabpaint']}, 13:57:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:57:37 INFO - 'ts_paint', 13:57:37 INFO - 'tpaint', 13:57:37 INFO - 'sessionrestore', 13:57:37 INFO - 'sessionrestore_no_auto_restore', 13:57:37 INFO - 'tabpaint']}, 13:57:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:57:37 INFO - 'ts_paint', 13:57:37 INFO - 'tpaint', 13:57:37 INFO - 'sessionrestore', 13:57:37 INFO - 'sessionrestore_no_auto_restore', 13:57:37 INFO - 'tabpaint']}, 13:57:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['a11yr', 13:57:37 INFO - 'ts_paint', 13:57:37 INFO - 'tpaint', 13:57:37 INFO - 'sessionrestore', 13:57:37 INFO - 'sessionrestore_no_auto_restore', 13:57:37 INFO - 'tabpaint']}, 13:57:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['a11yr', 13:57:37 INFO - 'ts_paint', 13:57:37 INFO - 'tpaint', 13:57:37 INFO - 'sessionrestore', 13:57:37 INFO - 'sessionrestore_no_auto_restore', 13:57:37 INFO - 'tabpaint']}, 13:57:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['tsvgx', 13:57:37 INFO - 'tsvgr_opacity', 13:57:37 INFO - 'tart', 13:57:37 INFO - 'tscrollx', 13:57:37 INFO - 'cart']}, 13:57:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:57:37 INFO - 'tsvgr_opacity', 13:57:37 INFO - 'tart', 13:57:37 INFO - 'tscrollx', 13:57:37 INFO - 'cart']}, 13:57:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'talos_options': ['--disable-e10s'], 13:57:37 INFO - 'tests': ['tp5o']}, 13:57:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'tests': ['tp5o']}, 13:57:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'talos_options': ['--disable-e10s', 13:57:37 INFO - '--xperf_path', 13:57:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:37 INFO - 'tests': ['tp5n']}, 13:57:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:57:37 INFO - 'talos_options': ['--xperf_path', 13:57:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:37 INFO - 'tests': ['tp5n']}}, 13:57:37 INFO - 'talos.zip': {'path': '', 13:57:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:57:37 INFO - Running post-action listener: _resource_record_post_action 13:57:37 INFO - [mozharness: 2016-10-26 20:57:37.601671Z] Finished populate-webroot step (success) 13:57:37 INFO - [mozharness: 2016-10-26 20:57:37.601784Z] Running create-virtualenv step. 13:57:37 INFO - Running pre-action listener: _resource_record_pre_action 13:57:37 INFO - Running main action method: create_virtualenv 13:57:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:57:37 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 13:57:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:57:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:57:37 INFO - Using real prefix '/tools/python27' 13:57:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:57:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:57:41 INFO - Installing pip.................done. 13:57:41 INFO - Return code: 0 13:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:57:41 INFO - Reading from file tmpfile_stdout 13:57:41 INFO - Output received: 13:57:41 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) 13:57:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:57:41 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')]} 13:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:41 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')]} 13:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:41 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57:41 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 13:57:41 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 13:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:41 INFO - 'HOME': '/Users/cltbld', 13:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:41 INFO - 'LOGNAME': 'cltbld', 13:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:41 INFO - 'MOZ_NO_REMOTE': '1', 13:57:41 INFO - 'NO_EM_RESTART': '1', 13:57:41 INFO - 'PAGER': '/bin/cat', 13:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:41 INFO - 'PWD': '/builds/slave/test', 13:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:41 INFO - 'SHELL': '/bin/bash', 13:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:57:41 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:41 INFO - 'USER': 'cltbld', 13:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:41 INFO - 'XPC_FLAGS': '0x0', 13:57:41 INFO - 'XPC_SERVICE_NAME': '0', 13:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:41 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 13:57:41 INFO - Cleaning up... 13:57:41 INFO - Return code: 0 13:57:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:57:41 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')]} 13:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:41 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')]} 13:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:41 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57:41 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 13:57:41 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 13:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:41 INFO - 'HOME': '/Users/cltbld', 13:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:41 INFO - 'LOGNAME': 'cltbld', 13:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:41 INFO - 'MOZ_NO_REMOTE': '1', 13:57:41 INFO - 'NO_EM_RESTART': '1', 13:57:41 INFO - 'PAGER': '/bin/cat', 13:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:41 INFO - 'PWD': '/builds/slave/test', 13:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:41 INFO - 'SHELL': '/bin/bash', 13:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:57:41 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:41 INFO - 'USER': 'cltbld', 13:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:41 INFO - 'XPC_FLAGS': '0x0', 13:57:41 INFO - 'XPC_SERVICE_NAME': '0', 13:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:42 INFO - Downloading/unpacking psutil>=3.1.1 13:57:42 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 13:57:42 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 13:57:42 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 13:57:42 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 13:57:42 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 13:57:42 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 13:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:57:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:45 INFO - Installing collected packages: psutil 13:57:45 INFO - Running setup.py install for psutil 13:57:45 INFO - building 'psutil._psutil_osx' extension 13:57:45 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 13:57:46 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 13:57:46 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 13:57:46 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 13:57:46 INFO - building 'psutil._psutil_posix' extension 13:57:46 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 13:57:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:57:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:57:46 INFO - ^ 13:57:46 INFO - 1 warning generated. 13:57:46 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 13:57:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:46 INFO - Successfully installed psutil 13:57:46 INFO - Cleaning up... 13:57:46 INFO - Return code: 0 13:57:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:57: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 mozsystemmonitor==0.3 13:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:46 INFO - 'HOME': '/Users/cltbld', 13:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:46 INFO - 'LOGNAME': 'cltbld', 13:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:46 INFO - 'MOZ_NO_REMOTE': '1', 13:57:46 INFO - 'NO_EM_RESTART': '1', 13:57:46 INFO - 'PAGER': '/bin/cat', 13:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:46 INFO - 'PWD': '/builds/slave/test', 13:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:46 INFO - 'SHELL': '/bin/bash', 13:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:57:46 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:46 INFO - 'USER': 'cltbld', 13:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:46 INFO - 'XPC_FLAGS': '0x0', 13:57:46 INFO - 'XPC_SERVICE_NAME': '0', 13:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:57:49 INFO - Installing collected packages: mozsystemmonitor 13:57:49 INFO - Running setup.py install for mozsystemmonitor 13:57:49 INFO - Successfully installed mozsystemmonitor 13:57:49 INFO - Cleaning up... 13:57:49 INFO - Return code: 0 13:57:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:57:49 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')]} 13:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:49 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')]} 13:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:49 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57:49 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 13:57:49 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 13:57:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:57:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:49 INFO - 'HOME': '/Users/cltbld', 13:57:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:49 INFO - 'LOGNAME': 'cltbld', 13:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:49 INFO - 'MOZ_NO_REMOTE': '1', 13:57:49 INFO - 'NO_EM_RESTART': '1', 13:57:49 INFO - 'PAGER': '/bin/cat', 13:57:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:49 INFO - 'PWD': '/builds/slave/test', 13:57:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:49 INFO - 'SHELL': '/bin/bash', 13:57:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:57:49 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:57:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:49 INFO - 'USER': 'cltbld', 13:57:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:49 INFO - 'XPC_FLAGS': '0x0', 13:57:49 INFO - 'XPC_SERVICE_NAME': '0', 13:57:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:50 INFO - Downloading/unpacking jsonschema==2.5.1 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:57:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:57:53 INFO - warning: no files found matching '*.txt' 13:57:53 INFO - no previously-included directories found matching 'build' 13:57:53 INFO - no previously-included directories found matching 'dist' 13:57:53 INFO - no previously-included directories found matching '.git*' 13:57:53 INFO - Installing collected packages: jsonschema, functools32 13:57:53 INFO - Running setup.py install for functools32 13:57:53 INFO - warning: no files found matching '*.txt' 13:57:53 INFO - no previously-included directories found matching 'build' 13:57:53 INFO - no previously-included directories found matching 'dist' 13:57:53 INFO - no previously-included directories found matching '.git*' 13:57:53 INFO - Successfully installed jsonschema functools32 13:57:53 INFO - Cleaning up... 13:57:53 INFO - Return code: 0 13:57:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57:53 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 13:57:53 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 13:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:53 INFO - 'HOME': '/Users/cltbld', 13:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:53 INFO - 'LOGNAME': 'cltbld', 13:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:53 INFO - 'MOZ_NO_REMOTE': '1', 13:57:53 INFO - 'NO_EM_RESTART': '1', 13:57:53 INFO - 'PAGER': '/bin/cat', 13:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:53 INFO - 'PWD': '/builds/slave/test', 13:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:53 INFO - 'SHELL': '/bin/bash', 13:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:57:53 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:53 INFO - 'USER': 'cltbld', 13:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:53 INFO - 'XPC_FLAGS': '0x0', 13:57:53 INFO - 'XPC_SERVICE_NAME': '0', 13:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:57:53 INFO - Cleaning up... 13:57:53 INFO - Return code: 0 13:57:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:53 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57:53 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 13:57:53 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 13:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:53 INFO - 'HOME': '/Users/cltbld', 13:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:53 INFO - 'LOGNAME': 'cltbld', 13:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:53 INFO - 'MOZ_NO_REMOTE': '1', 13:57:53 INFO - 'NO_EM_RESTART': '1', 13:57:53 INFO - 'PAGER': '/bin/cat', 13:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:53 INFO - 'PWD': '/builds/slave/test', 13:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:53 INFO - 'SHELL': '/bin/bash', 13:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:57:53 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:53 INFO - 'USER': 'cltbld', 13:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:53 INFO - 'XPC_FLAGS': '0x0', 13:57:53 INFO - 'XPC_SERVICE_NAME': '0', 13:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57: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 13:57:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:56 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 13:57:56 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 13:57:56 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 13:57:56 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 13:57:56 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 13:57:56 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 13:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:57:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:57 INFO - Downloading docopt-0.6.1.tar.gz 13:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:57 INFO - Running setup.py install for blobuploader 13:57:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:57:57 INFO - Running setup.py install for requests 13:57:58 INFO - Running setup.py install for docopt 13:57:58 INFO - Successfully installed blobuploader requests docopt 13:57:58 INFO - Cleaning up... 13:57:58 INFO - Return code: 0 13:57:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:58 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:57:58 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 13:57:58 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 13:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:58 INFO - 'HOME': '/Users/cltbld', 13:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:58 INFO - 'LOGNAME': 'cltbld', 13:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:58 INFO - 'MOZ_NO_REMOTE': '1', 13:57:58 INFO - 'NO_EM_RESTART': '1', 13:57:58 INFO - 'PAGER': '/bin/cat', 13:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:58 INFO - 'PWD': '/builds/slave/test', 13:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:58 INFO - 'SHELL': '/bin/bash', 13:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:57:58 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:58 INFO - 'USER': 'cltbld', 13:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:58 INFO - 'XPC_FLAGS': '0x0', 13:57:58 INFO - 'XPC_SERVICE_NAME': '0', 13:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:58 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-NhBjbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-9orj4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-fcLEba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-n4DgNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-YLpohn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-GthKer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-lP1qM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ahcsc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-8Pac6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-yIReq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:59 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-jOSlEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:00 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-bygdQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:00 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-DwZ9BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:00 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Fdoqxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:00 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-B6FAza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:00 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-LlVzlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:00 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-4MVfby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:00 INFO - Running setup.py install for manifestparser 13:58:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:58:00 INFO - Running setup.py install for mozcrash 13:58:01 INFO - Running setup.py install for mozdebug 13:58:01 INFO - Running setup.py install for mozdevice 13:58:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Running setup.py install for mozfile 13:58:01 INFO - Running setup.py install for mozhttpd 13:58:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Running setup.py install for mozinfo 13:58:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Running setup.py install for mozInstall 13:58:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:58:01 INFO - Running setup.py install for mozleak 13:58:02 INFO - Running setup.py install for mozlog 13:58:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:58:02 INFO - Running setup.py install for moznetwork 13:58:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:58:02 INFO - Running setup.py install for mozprocess 13:58:02 INFO - Running setup.py install for mozprofile 13:58:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:58:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:58:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:58:02 INFO - Running setup.py install for mozrunner 13:58:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:58:02 INFO - Running setup.py install for mozscreenshot 13:58:02 INFO - Running setup.py install for moztest 13:58:03 INFO - Running setup.py install for mozversion 13:58:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:58:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:03 INFO - Cleaning up... 13:58:03 INFO - Return code: 0 13:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:03 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:58:03 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 13:58:03 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 13:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:03 INFO - 'HOME': '/Users/cltbld', 13:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:03 INFO - 'LOGNAME': 'cltbld', 13:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:03 INFO - 'MOZ_NO_REMOTE': '1', 13:58:03 INFO - 'NO_EM_RESTART': '1', 13:58:03 INFO - 'PAGER': '/bin/cat', 13:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:03 INFO - 'PWD': '/builds/slave/test', 13:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:03 INFO - 'SHELL': '/bin/bash', 13:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:58:03 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:03 INFO - 'USER': 'cltbld', 13:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:03 INFO - 'XPC_FLAGS': '0x0', 13:58:03 INFO - 'XPC_SERVICE_NAME': '0', 13:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-VztBdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:03 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)) 13:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ptRYII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-xXWCD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:03 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)) 13:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:03 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-J4FqS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:03 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)) 13:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-7CCtG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-bO42lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-A_qN55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-_drI7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-OawldU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-n0VWnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Gh0XfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-9LQb20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-uYLAFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:04 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)) 13:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:04 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-1SDGFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:05 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-78Tcoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:05 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)) 13:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:05 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-NXi1aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:05 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)) 13:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:05 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ZbFVLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:05 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)) 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:05 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)) 13:58:05 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)) 13:58:05 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)) 13:58:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:05 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 13:58:05 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 13:58:05 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 13:58:05 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 13:58:05 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 13:58:05 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 13:58:08 INFO - Downloading blessings-1.6.tar.gz 13:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:08 INFO - Installing collected packages: blessings 13:58:08 INFO - Running setup.py install for blessings 13:58:08 INFO - Successfully installed blessings 13:58:08 INFO - Cleaning up... 13:58:08 INFO - Return code: 0 13:58:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:08 INFO - Reading from file tmpfile_stdout 13:58:08 INFO - Current package versions: 13:58:08 INFO - blessings == 1.6 13:58:08 INFO - blobuploader == 1.2.4 13:58:08 INFO - docopt == 0.6.1 13:58:08 INFO - functools32 == 3.2.3-2 13:58:08 INFO - jsonschema == 2.5.1 13:58:08 INFO - manifestparser == 1.1 13:58:08 INFO - mozInstall == 1.12 13:58:08 INFO - mozcrash == 0.17 13:58:08 INFO - mozdebug == 0.1 13:58:08 INFO - mozdevice == 0.48 13:58:08 INFO - mozfile == 1.2 13:58:08 INFO - mozhttpd == 0.7 13:58:08 INFO - mozinfo == 0.9 13:58:08 INFO - mozleak == 0.1 13:58:08 INFO - mozlog == 3.4 13:58:08 INFO - moznetwork == 0.27 13:58:08 INFO - mozprocess == 0.23 13:58:08 INFO - mozprofile == 0.28 13:58:08 INFO - mozrunner == 6.12 13:58:08 INFO - mozscreenshot == 0.1 13:58:08 INFO - mozsystemmonitor == 0.3 13:58:08 INFO - moztest == 0.7 13:58:08 INFO - mozversion == 1.4 13:58:08 INFO - psutil == 3.1.1 13:58:08 INFO - requests == 1.2.3 13:58:08 INFO - wsgiref == 0.1.2 13:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:09 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')]} 13:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:09 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:58:09 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 13:58:09 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 13:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:09 INFO - 'HOME': '/Users/cltbld', 13:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:09 INFO - 'LOGNAME': 'cltbld', 13:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:09 INFO - 'MOZ_NO_REMOTE': '1', 13:58:09 INFO - 'NO_EM_RESTART': '1', 13:58:09 INFO - 'PAGER': '/bin/cat', 13:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:09 INFO - 'PWD': '/builds/slave/test', 13:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:09 INFO - 'SHELL': '/bin/bash', 13:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:58:09 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:09 INFO - 'USER': 'cltbld', 13:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:09 INFO - 'XPC_FLAGS': '0x0', 13:58:09 INFO - 'XPC_SERVICE_NAME': '0', 13:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 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)) 13:58:09 INFO - Cleaning up... 13:58:09 INFO - Return code: 0 13:58:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:58:09 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')]} 13:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:09 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')]} 13:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:09 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 0x106059490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105fcf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2a8cabe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, '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.G32zHdK66b/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.XwqiLEC6e1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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 13:58:09 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 13:58:09 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 13:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:09 INFO - 'HOME': '/Users/cltbld', 13:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:09 INFO - 'LOGNAME': 'cltbld', 13:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:09 INFO - 'MOZ_NO_REMOTE': '1', 13:58:09 INFO - 'NO_EM_RESTART': '1', 13:58:09 INFO - 'PAGER': '/bin/cat', 13:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:09 INFO - 'PWD': '/builds/slave/test', 13:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:09 INFO - 'SHELL': '/bin/bash', 13:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:58:09 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:09 INFO - 'USER': 'cltbld', 13:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:09 INFO - 'XPC_FLAGS': '0x0', 13:58:09 INFO - 'XPC_SERVICE_NAME': '0', 13:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:58:09 INFO - Cleaning up... 13:58:09 INFO - Return code: 0 13:58:09 INFO - Running post-action listener: _resource_record_post_action 13:58:09 INFO - Running post-action listener: _start_resource_monitoring 13:58:09 INFO - Starting resource monitoring. 13:58:09 INFO - [mozharness: 2016-10-26 20:58:09.728677Z] Finished create-virtualenv step (success) 13:58:09 INFO - [mozharness: 2016-10-26 20:58:09.729650Z] Running install step. 13:58:09 INFO - Running pre-action listener: _resource_record_pre_action 13:58:09 INFO - Running main action method: install 13:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:09 INFO - Reading from file tmpfile_stdout 13:58:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:58:10 INFO - Reading from file tmpfile_stdout 13:58:10 INFO - Output received: 13:58:10 INFO - Usage: mozinstall [options] installer 13:58:10 INFO - Options: 13:58:10 INFO - -h, --help show this help message and exit 13:58:10 INFO - -d DEST, --destination=DEST 13:58:10 INFO - Directory to install application into. [default: 13:58:10 INFO - "/builds/slave/test"] 13:58:10 INFO - --app=APP Application being installed. [default: firefox] 13:58:10 INFO - mkdir: /builds/slave/test/build/application 13:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:58:43 INFO - Reading from file tmpfile_stdout 13:58:43 INFO - Output received: 13:58:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:58:43 INFO - Running post-action listener: _resource_record_post_action 13:58:43 INFO - [mozharness: 2016-10-26 20:58:43.936552Z] Finished install step (success) 13:58:43 INFO - [mozharness: 2016-10-26 20:58:43.936691Z] Running run-tests step. 13:58:43 INFO - Running pre-action listener: _resource_record_pre_action 13:58:43 INFO - Running main action method: run_tests 13:58:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:58:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:58:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:58:43 INFO - 2016-10-26 13:58:43.951 screenresolution[1644:7582] starting screenresolution argv=screenresolution get 13:58:43 INFO - 2016-10-26 13:58:43.953 screenresolution[1644:7582] Display 0: 1600x1200x32@60 13:58:43 INFO - 2016-10-26 13:58:43.959 screenresolution[1645:7584] starting screenresolution argv=screenresolution list 13:58:43 INFO - Available Modes on Display 0 13:58:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:58:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:58:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:58:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:58:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:58:44 INFO - Intel Iris: 13:58:44 INFO - Chipset Model: Intel Iris 13:58:44 INFO - Type: GPU 13:58:44 INFO - Bus: Built-In 13:58:44 INFO - VRAM (Dynamic, Max): 1536 MB 13:58:44 INFO - Vendor: Intel (0x8086) 13:58:44 INFO - Device ID: 0x0a2e 13:58:44 INFO - Revision ID: 0x0009 13:58:44 INFO - Displays: 13:58:44 INFO - Display: 13:58:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:58:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:58:44 INFO - Display Serial Number: 1600x1200 60 13:58:44 INFO - Main Display: Yes 13:58:44 INFO - Mirror: Off 13:58:44 INFO - Online: Yes 13:58:44 INFO - Rotation: Supported 13:58:44 INFO - Return code: 0 13:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:58:44 INFO - Python 2.7.3 13:58:44 INFO - Return code: 0 13:58:44 INFO - grabbing minidump binary from tooltool 13:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:44 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 0x105e6dd30>, '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 0x105c93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e65b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:58:44 INFO - Return code: 0 13:58:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:58:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:58:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:58:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:58:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G32zHdK66b/Render', 13:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:44 INFO - 'HOME': '/Users/cltbld', 13:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:44 INFO - 'LOGNAME': 'cltbld', 13:58:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:58:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:44 INFO - 'MOZ_NO_REMOTE': '1', 13:58:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:58:44 INFO - 'NO_EM_RESTART': '1', 13:58:44 INFO - 'PAGER': '/bin/cat', 13:58:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:44 INFO - 'PWD': '/builds/slave/test', 13:58:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:44 INFO - 'SHELL': '/bin/bash', 13:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XwqiLEC6e1/Listeners', 13:58:44 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 13:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:44 INFO - 'USER': 'cltbld', 13:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:44 INFO - 'XPC_FLAGS': '0x0', 13:58:44 INFO - 'XPC_SERVICE_NAME': '0', 13:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:58:44 INFO - mozversion application_buildid: 20161011025846 13:58:44 INFO - mozversion application_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:58:44 INFO - mozversion application_display_name: Nightly 13:58:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:58:44 INFO - mozversion application_name: Firefox 13:58:44 INFO - mozversion application_remotingname: firefox 13:58:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:58:44 INFO - mozversion application_vendor: Mozilla 13:58:44 INFO - mozversion application_version: 52.0a1 13:58:44 INFO - mozversion platform_buildid: 20161011025846 13:58:44 INFO - mozversion platform_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:58:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:58:44 INFO - mozversion platform_version: 52.0a1 13:58:44 INFO - using testdate: 1477515524 13:58:44 INFO - actual date: 1477515524 13:58:44 INFO - starting webserver on 'localhost:49270' 13:58:44 INFO - SUITE-START | Running 2 tests 13:58:44 INFO - TEST-START | dromaeo_css 13:58:44 INFO - operating with platform_type : mac_ 13:58:44 INFO - Initialising browser for dromaeo_css test... 13:58:44 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmp8Ljw0j/profile http://localhost:49270/getInfo.html) 13:58:46 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 13:58:46 INFO - PROCESS | 1655 | colorDepth:24 13:58:46 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 13:58:46 INFO - PROCESS | 1655 | __metrics 13:58:46 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:58:46 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:47 INFO - TEST-INFO | 1655: exit 0 13:58:47 INFO - Browser initialized. 13:58:47 INFO - Running cycle 1/1 for dromaeo_css test... 13:58:47 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmp8Ljw0j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:59 INFO - PROCESS | 1657 | RSS: Main: 234733568 13:58:59 INFO - PROCESS | 1657 | 13:59:50 INFO - PROCESS | 1657 | 1477515590831 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] 14:02:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 14:02:05 INFO - PROCESS | 1657 | RSS: Main: 389103616 14:02:05 INFO - PROCESS | 1657 | 14:05:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 14:05:08 INFO - PROCESS | 1657 | RSS: Main: 383971328 14:05:08 INFO - PROCESS | 1657 | 14:08:11 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 14:08:11 INFO - PROCESS | 1657 | RSS: Main: 347893760 14:08:11 INFO - PROCESS | 1657 | 14:11:14 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 14:11:14 INFO - PROCESS | 1657 | RSS: Main: 341913600 14:11:14 INFO - PROCESS | 1657 | 14:14:18 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 14:14:18 INFO - PROCESS | 1657 | RSS: Main: 333844480 14:14:18 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:17:22 INFO - PROCESS | 1657 | RSS: Main: 440311808 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | __start_tp_report 14:17:22 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 14:17:22 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 14:17:22 INFO - PROCESS | 1657 | |i|pagename|runs| 14:17:22 INFO - PROCESS | 1657 | |0;dojo.html;3267.248532837448;3274.4433446314124;3276.0499455157997;3319.8340082995846;3342.314825460781;5389.541888939435;5466.262054622624;5495.368032676243;5548.889022219559;5566.499015088636;5436.184572314155;5494.203340515623;5518;5595.328560572727;5604.327480702311;4987.650864439491;5076.162433198518;5079.161938280179;5124.6668966517245;5142.023015627019;5055.368078990126;5062.2406639004075;5139.8458046258675;5151.407588127376;5184.1186998210205;5115.974420127913;5128.948710512903;5132.8460146195675;5160.612954028444;5216.895662086756;4992.975035124801;5031.22016087507;5053.722045287508;5069.290299358093;5098.566621837148;5014.498550144993;5024.321716568253;5026.748662566857;5057.140286151326;5101.387833459971;5443.074677304868;5546.084895992157;5581.6371935824045;5581.6371935824445;5589.944100559023;5831.620944638585;5926.881462370771;5950.345461999176;6036.637801731867;6079.665618390986;5051.9494805051845;6021.5182785377065;6026.457618814284;6108.251008765826;6135.147011824827;5581.469760372758;5595.160725891149;5595.412481689364;5600.943990560083;5619.353774315965;4792.257200133985;6037.426444487766;6192.380761923771;6209.316975132731;6211.81364559064;5770.221020162308;5778.219940308005;5829.154772557956;5830.038043722823;5883;5989.932134019144;6058.818235452944;6065.968785306509;6106.236720409949;6111.54163437744;5879.235699359141;5934.495567876693;5961.731722072517;5970.76116955317;5971.880562388728;5770.19217309577;5843.2695913010875;5864.648121112747;5988.880222395528;6027.30685971119;4766.998930224622;4768.546988036201;4779.784909679072;4780.808767649255;4786.234202527648;4247.5964783345535;4280.636145927631;4345.9348109778375;4354.368616550582;4368.344748287782;5422.5119739223655;5496.917546236809;5516.393196748354;5519.558435325244;5549.944500555023;6055.969720151371;6101.023836186278;6110.786122485781;6133.1413602095745;6136.018237082046;5573.41479144692;5577.163425486209;5580.804671836548;5586;5591.384947655754;5141.126008578476;5205.115130427836;5206.323177986837;5232.2413250078525;5246.029484545371;4629.421322334708;6248.562600618004;6249.375062493714;6301.0863424804065;6326.4622507087415;5939.940600593939;6059.339116931195;6072.332043475126;6073.392660733891;6121.418465245794;6171.722272497838;6246.937530624636;6271.247450305992;6305.873882522232;6326.557141000086;5117.02776472469;5687.317521897234;5844.853878652898;5921.644701317935;5985.940140598713;6063.5452341073715;6078.209832721718;6079.817605471843;6094.11635312886;6094.847628809315;5675;5852.4440178183;5859.707014649336;5865.384134665798;5867.618604790675;5667.121596152603;5774.422557744192;5780.075187969905;5781.68200748946;5785;5628.60599758013;5646.830595082154;5699.116636921284;5699.51554117888;5749.396313387034;5764;5866.970665146647;5882.23530940975;5892.823215303548;5923.289205295392;5632.88734225305;5666.518345940642;5688.63023903445;5710.314762228559;5711.457411545896 14:17:22 INFO - PROCESS | 1657 | |1;ext.html;490.74481269739715;490.95581397674204;541.4071591607188;544.9836504904849;563.4900415124313;27610.861945690267;39657.40513892294;39659.60340396595;39662.8016859916;39742.99999999996;40805.795971020176;41178.58821411785;41380.17239655212;41397.96505087367;41694.54069107582;8678.435901666404;8927.018028016913;9499.857502137473;9671.951640241788;9725.416475011487;11690.941545292304;11980.820287695691;12077.335746533938;12169.269843809356;12194.756104877897;11890.702732431715;11961.222520536137;11973.580924667638;11984.460699268553;11995.820062699024;8790.780230494289;9018.36871419001;11716.882831171664;11992.340421276826;12051.276923384581;11577.363245021605;11781.352025638587;11807.645770626896;11810;11846;39802.60197398047;40021;40042.599574004176;40129.598704012875;40221.59778402208;2864.785141114404;3222.4360736870954;3241.5137729340554;3259.9837000815082;3272.721818645418;31274.687253127406;31369.686303136903;31407.528887066714;31411.685883141334;31475.84262078675;3182.7612929030415;3331.68349006844;3345.631980482145;3379.3917094922904;3381.8309084545676;478649;483941;488924.5553772244;489405;490819;63002;64396.356036439036;64417;64441.58921723968;64570;68626.9705954411;69103.65448172727;69122.61754764877;69246.96129558061;69250.65374673196;16118.838811611968;16311.34754609826;16487;16524.339026439047;16526.421575244807;11104.777904441866;11315.434228288717;11379.658610241706;12533.498660053496;12632.557860474839;19397.89396557269;19734.802651973296;19746.802531974783;19793.01034948247;19817.603647927248;6640.767573135014;7894.079190699478;8060.274575288252;8147.103818579952;8178.631961561744;891.6255172827427;929.1359036096495;947.4552132523827;947.6920000999703;956.583886009588;29334.379937004836;29932.551011734842;29946.90124824315;29959.550606740915;30045.110984972893;1031.3090229546222;1062.4687656171914;1077.8922107789315;1128.1820680007093;1146.6158836789768;15317.693646127238;15343.693126137414;15434;15609.765853512206;15725.292361843745;670546;675267;675502;676319;677076;55717.442825572034;56283;56425;56515.30454086384;56700.149497757564;1210.2012671636853;1216.0757824053605;1328.4221363706818;1352.263016655925;1376.745302119111;30307.545386818776;30486.695133048386;31048.91328803481;31621.841890790398;31891.883784067446;47708;53315.46684533105;55118.41730287518;55270;57838.7108064457;420214;596715;601488;602008;604012;26091.869540652177;26765.598516022666;26889.865550672905;41658.58341416547;42282;45247.773761130986;45315.32027019663;46079;46267.843303917674;46624;33667.49498757472;36721.63278367289;37415;37492.62507374891;38224.23551528898;32187.839060804545;32561.837190813894;35350.93947181589;36558;37549.81225093966;37163.6992705254;37516;37723.81138094292;37749.86750397492;37754.8112259437;31507.527387088754;33787.66212337845;33801.83099084489;33911.83044084764;37230.8138459306;30718.385632286783;31440.371192576476;31971;32014;32605.673943261212 14:17:22 INFO - PROCESS | 1657 | |2;jquery.html;354.9378858699727;364.70276724469556;367.2434784344251;374.0853612916419;396.9523657161141;15212.391504339826;15385.461508847178;16457.259423325948;20998.475038124056;21449.892750536226;20147.09338079786;20498;21019;21115.57768844622;21422.82174480403;4688.601468875149;5907.527397808176;6225.128482012522;6236.376362363772;6239;6017.157597936292;6205.014395393476;6214.316425193225;6218.160548325986;6219.751209951596;5953.821385358447;5957.940420595782;6079.726412311435;6165;6175.62946223228;5992.730327135289;6065.120557519179;6070.423309785585;6078.209832721762;6078.635281883101;5083.567896728782;5242.659227150223;5382.6232163748555;5446.509814116709;5488.9725551372385;12820.743585128244;13064.934675326562;13082.476700931951;16388.590285242844;24906.50186996268;2465.778079972793;2622.318197268705;2775.1951933939135;2891.3060865392363;2900.492413827593;9546.236301095896;9661.661841835503;9682.75793105178;9835.31152819303;10145.949270253675;1585.952421427359;1724.9995002898415;1803.6392721455761;1876.80293569176;1876.8873867567854;116945.83054169519;127705;128732.35633821771;129595;132276.33861830726;11176.105911527058;11375.089992800557;11452.96923276909;11530.654080377602;11713.472893719803;14494.710105797825;14501.564953051426;14528.055676381002;14542.418303267963;14543.490977815938;8253.33973282136;8385.203405676451;8394.160583941557;8408.621612027351;8540.14598540141;8217.178282171855;8245.257926786619;8246.587670616445;8378.204070613281;8434.915650843535;4474.664400169935;4478.395416618715;4518.299663552155;4543.659225558096;4581.9541804582195;1831.5878927241265;1883.52911772057;1888.4240306706586;1888.518427800902;1898.8291053805224;714.4106112457243;725.0031207090251;871.3769654696922;912.6851236323457;929.6235024814961;17919;20596.38210853647;20696.896515517325;21496.89251553732;21569.13723451076;776.7747353267489;934.495372498843;935.8175155844681;952.3999880075509;983.9212862970945;10803.621873234399;11350.637923449074;11392.544298228144;11427.257228280136;11445.656630301104;553121;589864;593049;608496;608723;87120.1287987112;104409.26039013673;121818;128349.35825320813;132135;896.5293221058996;943.0852073488705;971.7667759737612;972.9562169702239;973.2894986659636;19306.71039934374;19621.215151393786;19827;19888.90055549771;20012.799872001095;51656.74171629118;52186.21720674269;52896.677583059194;53103.468965309854;54230.18654720261;71660.28339716536;71712;72302;74910.62544687242;74977;6818.28408017151;7381.372583330477;7419.96290018568;7548.735794247175;7634.007579014693;12646.683832904251;13091.803622945854;13625.046246762631;13665.316734163052;13700.588982330546;5439.292891924025;5489.917651235155;11230.831537527107;11251.704690208368;11852.76294474123;9585.712428627152;11309.773804524028;11618.593349232737;11737.413129343327;11754;11440.942795286302;11549.307041577533;12002.579909703118;12037.578684745991;12129;7327.780166595011;7360.889586656312;7497.212792656911;7697.345725613385;7716.112647045662;10809.837852432378;11271;11564.653060408202;11668.649940501798;11688.298702077562 14:17:22 INFO - PROCESS | 1657 | |3;mootools.html;1376.1742954227461;1493.7369884624795;1602.511234073607;1664.4008157063456;1871.5882505848708;8142.552159631218;8872.600732967016;8875.778105547357;8876.64493420264;8879.156480134385;7696.923030769691;8000.639971201295;8309.83380332393;8603.268722158624;8621.224089831914;2069.317125348639;2299.2872209615075;2317.5249073939885;2329.871857047862;2337.2871274261342;2289.9313020609407;2304.3662992677064;2330.568844763716;2332.11379675723;2333.894974726133;2030.7461567304088;2103.547737236494;2106.936791896238;2233.9664905026357;2322.280093171122;2297.0467256088705;2313.595120853852;2314.3751187179537;2323.3262353917344;2324.3840382298704;2276.9089236430523;2279.190887235024;2310.8960096795686;2323.802476789475;2324.372419446757;8790.252828509585;8816.8677469838;8823.77940551485;8838.55807209637;8848.115188481164;5139.820106296262;5311.521963023308;5325.520703136697;5329.973350133263;5330.786768529293;3378.814165220912;3484.52958850557;3628.0567052566257;3628.2924829658227;3629.9274014519824;1067.7417262489855;1076.5747529725716;1076.6985244131656;1096.0573906440454;1097.018168738982;11426.714332141762;11591.536338546448;11615.128865335133;11635.243709158878;11647.242929209575;4461.04087621163;4525.321201819687;4697.224957881979;4716.504766999485;4724.102420540086;9902.257330700226;9917.15704165154;9930.05664461875;9939;9940.25448091396;5275.340582427197;5278.841634750886;5279.1817268323475;5282.52457278839;5288.497592728761;4668.229742092517;4720.881977950578;4829.95170048302;4830.396200474941;4831.178699621073;3813.5423749149722;3830.482884810515;3861.1698484825897;3899.200663863901;4005.098852758106;1235.6354875311624;1239.6714870559308;1243.9813402798966;1251.69333513288;1256.2525297448003;616.7348040342696;753.3370633842184;788.9171636978035;898.078943716415;915.6108653822099;5576.358718747315;5780.884382312414;5993.910091348634;6042.732530624662;6078.483328917003;864.4510735682886;868.3617541107282;907.2560500389617;924.246738907788;953.909378609031;3192.425363434604;3958.960410395917;3971.841126354971;3974.5627980922077;4072.3687828386646;10181.440020798927;10575.101116405192;10626.096781773482;10627.202959778047;10627.468626568641;10476.0571548561;10561.788764224826;10573.682789516326;10593.311434756715;10599.735006624896;8105;8174.713885013996;8184.304334131665;8186.2632363087605;8187.140350263256;4850.733209673502;5396.78412863481;5822.2140011099655;5828.970855145697;5884.676342801015;9462.243020558477;9717.465539395402;9734.172595329477;9781.559829807533;9876.802463950824;9768;9993.700188994342;10075.647352342632;10084.042016008467;10112.089911907964;7327.63361831917;7331.963340183478;7351.889721654286;7412.0364352633815;7433.591152486665;8239.876401854097;8288.544130072903;8289.502629842229;8289.668413263402;8314.70898518573;7258.927410726036;7359.852802944019;7385.2644628513335;7433.182349941394;7495.213002634645;7229.204787473479;7264.055672762718;7279.344858962719;7305.2329505403295;7387.1135463744695;6138.877222455437;6665.366790154928;6761.898571521333;6931.68807403658;6959.0605268290155;4592.471865735483;4977.4524802271;5010.849674509771;5041.319421878;5156.819511317236;4789.568938795525;4849.3210950466255;4887.462379138221;5004.649674522749;5044.520770526794 14:17:22 INFO - PROCESS | 1657 | |4;prototype.html;280.4602731006772;286.54007830105604;301.4618905254121;312.1976520342719;317.5522513256309;4477.373167756513;5013.674111182775;5180.404253510847;5193.63644544882;5212.947870521293;4462.352958820969;4573.902263456771;4591.908161836761;4997;5171.224316352549;3742.7754334739866;3793.2413517296513;3907.081835768592;4002.7598344099447;4009.6591789697763;3948.368261078228;3950.2297052074855;3956.2197011344865;4007.8797636070817;4019.658329042035;3461.0482117417787;3903.70722195835;3922.5486569969153;3930.3711406174875;3950.20995800841;3362.747793915466;3430.022443603586;3640.872569460056;3923.234969181011;3960.1683646434426;3411.795292282446;3419.6834218825684;3434.6050204226585;3436.8453419596176;3472.378354342455;4968.826091086831;4995.550400463976;5039.44566097729;5051.9494805051845;5074.898502029976;3687.8893633191046;4409.2283850326385;4494.348334482671;4501.4598248210095;4514.300283456069;4775.594074503671;4960.759810047488;5367.362954298937;5381.892362152735;5388.326459192601;3673.265346930598;3695.316366472211;3698.7041036716996;3709.5733990591157;3716.0709822544363;4969.403671559436;5556.472135147154;5714.257146570961;5781.19063331134;5787.971060144714;3404.9785064481052;3711.7958512282084;3742.642135454646;3751.9249615007548;3756.4553139794575;3398.728101751854;3781.7352785305316;3781.9810900945317;3789.2232092420986;3840.558335791364;4223.387608796768;4440.2007638625355;4464.553544645574;4474.731516109044;4497.268551607654;5183.688978661293;5217.165253559412;5462.726863656881;5484.396716361197;5560.36055853582;1065.142560239015;1158.1140427572914;1202.9534305154398;1239.4546399584153;1254.2850575172065;651.5406638319973;660.8149718078946;795.327947884037;798.5408390175672;808.6132283134452;4137.213929353413;4472.948857018598;4556.931646025312;4752.334673145762;4989.950100498949;5345.866353341197;5521.309836270466;5581.972090139523;5584.246126772915;5606.85982850432;4806.8798280043275;5045.646804723634;5086.567641750418;5097.8215762448135;5109.693418394908;2292.5185711000545;2538.4796116796015;2851.957220641692;2941.294089418524;2945.278406790307;4894.800773810368;5830.912536311958;5852.590318677737;5868.911966320508;5872.29532456108;4859.927101093486;5057.570106540912;5139.331886854685;5315.4885265550165;5671.943280567224;4741.241401375763;4828.95171048292;5788.27646544182;5825.427134673614;5849.590528662953;5055.443901170942;5278.4721527846905;5432.402435732145;5568.9443105568425;5620.662760234399;4828.179209534458;5184.196449550326;5481.314835645544;5554.416786237549;5582.665040097607;4318.805653745651;5246.501582349671;5366.543843773166;5595.629070877661;5791.53667706574;3173.6987834988468;3212.5663035490843;3258.1203075169096;3630.909227269339;3736.346139425644;5164.457731938092;5354.170103633943;5521.907731670278;5588.469095435927;5608.943910560843;4539.477960034638;5392.622516423813;5395.3525576931015;5453.318335208099;5459.153831156177;5190.390978796585;5318.0959236930585;5477.726113694379;5481.725913704378;5492.450754924475;5065.910829171598;5236.973815131052;5261.184516399964;5305.416404195458;5315.3621565412395;4041.6766658667825;5097.439281678938;5287.070219369979;5354.759035843318;5388.649737767033;4660.091282199938;5030.522100400456;5234.382808595702;5296.232046353334;5377.284471341947 14:17:22 INFO - PROCESS | 1657 | |5;yui.html;560.7084316155599;722.9746958856441;727.3163226567029;758.4311766175368;770.9746037769766;14335.78496322556;14943.402263909458;14967.625809354771;14970.850291497081;15280.847191528095;14087.788683169761;14276;14276.857231427683;14285.857141428583;14339.71320573588;666.3270097201837;690.1373283395756;818.1532114261755;829.3862541719114;852.3096292003497;847.9364047696416;853.8078932240259;863.9308855291562;866.2074202105066;867.9392442529025;909.636145541782;910.644848509082;910.9908900910972;911.2300106410106;911.2846415563783;696.07074555468;900.9774755631096;901.4861528928514;902.5261737587754;903.6972614174259;538.3512866995261;652.6736631684158;663.4857985061568;673.737242475435;684.3635419060272;14802.555923322318;14946;14946.028508146936;14949.925250373679;14964.401423943029;13639.318034098256;14105;14308.49920252786;14321.35553900077;14534.781978270334;12764.106512544126;12857.67855803603;12897.935510322483;13037.21776693392;13163.276019818906;4532.138893610237;4536.523665015159;4630.930536041962;4655.580997710188;4687.20317546018;123089.38455307666;124179;124476;124716.37641811823;125084;11039.491511915096;11082.058025067798;11083.279586826991;11154.274972126786;11458.083353331713;22545.661815072788;22611.20860769898;22681.659775103388;22696;22794.65808012881;7616.7334143304715;7669.7315593953945;7695.653695583712;7697.961510192526;7746.767596971987;4090.9590904091174;4152.5432202458305;4169.4366993778685;4200.075983283673;4294.89262768427;3521.2429327694667;3607.981960090183;3640.2719456108885;3663.505426767352;3864.652181303696;723.616483263871;723.8081908294306;724.5254358395259;735.2280105888796;743.2604558464362;596.3887015808743;604.8276241271217;663.873863965845;672.2101530701407;682.3827528756877;8740.169683880022;9048;9285.860712089325;9420.90579094214;9766.902330976742;581.2356750872674;591.4794980417205;636.700750647195;641.9486441084701;646.253577118429;3455.671711187433;4636.976815115903;4708.4349878014855;4882.536159064884;5082.382572974921;150047;158702;159017;160269.19865400597;165264.17367913082;133502.33248833695;134434;137492;139149;142798.2860085693;82865;112105.99999999837;115169;118228;118810;9701;9916.454594997056;9950.45272510019;9952.303338766507;9962.551685174329;62994.685026574574;64215.71568568509;64844.67577662082;66238.66880665565;66392.45675254364;73489.42787002643;79368;94624.52687736518;102407;104680.14898882767;11046.226764126755;13026.153300035467;13030.348482576022;13275.933620331836;13908.791368129283;12409.52012153341;14710.117392956457;14779.113253204841;15299.923500382427;15477.303521341792;13446.529371471952;13691;13871.72256554843;13923.512677056255;14058.367373468423;13445.193288402335;13702.588922332347;13704.3833027516;13721.519746808814;13861.584152475441;13385.66535836612;13599.134600525358;13879.861201387857;13980.930095349866;13992.720145596828;11342.20604557673;11426;11527.423628818358;11876.465559050037;11911.40442977865;9938.90672026091;10241.544937845303;11436.142289328167;11465.656030319104;11642.825357619811 14:17:22 INFO - PROCESS | 1657 | __end_tp_report 14:17:22 INFO - PROCESS | 1657 | __start_cc_report 14:17:22 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2082 14:17:22 INFO - PROCESS | 1657 | __end_cc_report 14:17:22 INFO - PROCESS | 1657 | __startTimestamp1477516642450__endTimestamp 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | ------- Summary: start ------- 14:17:22 INFO - PROCESS | 1657 | Number of tests: 6 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5537.26 Median:5666.52 stddev:611.52 (10.8%) stddev-sans-first:586.89 14:17:22 INFO - PROCESS | 1657 | Values: 3267.2 3274.4 3276.0 3319.8 3342.3 5389.5 5466.3 5495.4 5548.9 5566.5 5436.2 5494.2 5518.0 5595.3 5604.3 4987.7 5076.2 5079.2 5124.7 5142.0 5055.4 5062.2 5139.8 5151.4 5184.1 5116.0 5128.9 5132.8 5160.6 5216.9 4993.0 5031.2 5053.7 5069.3 5098.6 5014.5 5024.3 5026.7 5057.1 5101.4 5443.1 5546.1 5581.6 5581.6 5589.9 5831.6 5926.9 5950.3 6036.6 6079.7 5051.9 6021.5 6026.5 6108.3 6135.1 5581.5 5595.2 5595.4 5600.9 5619.4 4792.3 6037.4 6192.4 6209.3 6211.8 5770.2 5778.2 5829.2 5830.0 5883.0 5989.9 6058.8 6066.0 6106.2 6111.5 5879.2 5934.5 5961.7 5970.8 5971.9 5770.2 5843.3 5864.6 5988.9 6027.3 4767.0 4768.5 4779.8 4780.8 4786.2 4247.6 4280.6 4345.9 4354.4 4368.3 5422.5 5496.9 5516.4 5519.6 5549.9 6056.0 6101.0 6110.8 6133.1 6136.0 5573.4 5577.2 5580.8 5586.0 5591.4 5141.1 5205.1 5206.3 5232.2 5246.0 4629.4 6248.6 6249.4 6301.1 6326.5 5939.9 6059.3 6072.3 6073.4 6121.4 6171.7 6246.9 6271.2 6305.9 6326.6 5117.0 5687.3 5844.9 5921.6 5985.9 6063.5 6078.2 6079.8 6094.1 6094.8 5675.0 5852.4 5859.7 5865.4 5867.6 5667.1 5774.4 5780.1 5781.7 5785.0 5628.6 5646.8 5699.1 5699.5 5749.4 5764.0 5867.0 5882.2 5892.8 5923.3 5632.9 5666.5 5688.6 5710.3 5711.5 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:71425.73 Median:36639.82 stddev:155572.35 (424.6%) stddev-sans-first:155917.60 14:17:22 INFO - PROCESS | 1657 | Values: 490.7 491.0 541.4 545.0 563.5 27610.9 39657.4 39659.6 39662.8 39743.0 40805.8 41178.6 41380.2 41398.0 41694.5 8678.4 8927.0 9499.9 9672.0 9725.4 11690.9 11980.8 12077.3 12169.3 12194.8 11890.7 11961.2 11973.6 11984.5 11995.8 8790.8 9018.4 11716.9 11992.3 12051.3 11577.4 11781.4 11807.6 11810.0 11846.0 39802.6 40021.0 40042.6 40129.6 40221.6 2864.8 3222.4 3241.5 3260.0 3272.7 31274.7 31369.7 31407.5 31411.7 31475.8 3182.8 3331.7 3345.6 3379.4 3381.8 478649.0 483941.0 488924.6 489405.0 490819.0 63002.0 64396.4 64417.0 64441.6 64570.0 68627.0 69103.7 69122.6 69247.0 69250.7 16118.8 16311.3 16487.0 16524.3 16526.4 11104.8 11315.4 11379.7 12533.5 12632.6 19397.9 19734.8 19746.8 19793.0 19817.6 6640.8 7894.1 8060.3 8147.1 8178.6 891.6 929.1 947.5 947.7 956.6 29334.4 29932.6 29946.9 29959.6 30045.1 1031.3 1062.5 1077.9 1128.2 1146.6 15317.7 15343.7 15434.0 15609.8 15725.3 670546.0 675267.0 675502.0 676319.0 677076.0 55717.4 56283.0 56425.0 56515.3 56700.1 1210.2 1216.1 1328.4 1352.3 1376.7 30307.5 30486.7 31048.9 31621.8 31891.9 47708.0 53315.5 55118.4 55270.0 57838.7 420214.0 596715.0 601488.0 602008.0 604012.0 26091.9 26765.6 26889.9 41658.6 42282.0 45247.8 45315.3 46079.0 46267.8 46624.0 33667.5 36721.6 37415.0 37492.6 38224.2 32187.8 32561.8 35350.9 36558.0 37549.8 37163.7 37516.0 37723.8 37749.9 37754.8 31507.5 33787.7 33801.8 33911.8 37230.8 30718.4 31440.4 31971.0 32014.0 32605.7 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34229.95 Median:385.52 stddev:98650.57 (25589.0%) stddev-sans-first:98894.52 14:17:22 INFO - PROCESS | 1657 | Values: 354.9 364.7 367.2 374.1 397.0 15212.4 15385.5 16457.3 20998.5 21449.9 20147.1 20498.0 21019.0 21115.6 21422.8 4688.6 5907.5 6225.1 6236.4 6239.0 6017.2 6205.0 6214.3 6218.2 6219.8 5953.8 5957.9 6079.7 6165.0 6175.6 5992.7 6065.1 6070.4 6078.2 6078.6 5083.6 5242.7 5382.6 5446.5 5489.0 12820.7 13064.9 13082.5 16388.6 24906.5 2465.8 2622.3 2775.2 2891.3 2900.5 9546.2 9661.7 9682.8 9835.3 10145.9 1586.0 1725.0 1803.6 1876.8 1876.9 116945.8 127705.0 128732.4 129595.0 132276.3 11176.1 11375.1 11453.0 11530.7 11713.5 14494.7 14501.6 14528.1 14542.4 14543.5 8253.3 8385.2 8394.2 8408.6 8540.1 8217.2 8245.3 8246.6 8378.2 8434.9 4474.7 4478.4 4518.3 4543.7 4582.0 1831.6 1883.5 1888.4 1888.5 1898.8 714.4 725.0 871.4 912.7 929.6 17919.0 20596.4 20696.9 21496.9 21569.1 776.8 934.5 935.8 952.4 983.9 10803.6 11350.6 11392.5 11427.3 11445.7 553121.0 589864.0 593049.0 608496.0 608723.0 87120.1 104409.3 121818.0 128349.4 132135.0 896.5 943.1 971.8 973.0 973.3 19306.7 19621.2 19827.0 19888.9 20012.8 51656.7 52186.2 52896.7 53103.5 54230.2 71660.3 71712.0 72302.0 74910.6 74977.0 6818.3 7381.4 7420.0 7548.7 7634.0 12646.7 13091.8 13625.0 13665.3 13700.6 5439.3 5489.9 11230.8 11251.7 11852.8 9585.7 11309.8 11618.6 11737.4 11754.0 11440.9 11549.3 12002.6 12037.6 12129.0 7327.8 7360.9 7497.2 7697.3 7716.1 10809.8 11271.0 11564.7 11668.6 11688.3 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5635.09 Median:5026.08 stddev:3174.79 (63.2%) stddev-sans-first:3167.56 14:17:22 INFO - PROCESS | 1657 | Values: 1376.2 1493.7 1602.5 1664.4 1871.6 8142.6 8872.6 8875.8 8876.6 8879.2 7696.9 8000.6 8309.8 8603.3 8621.2 2069.3 2299.3 2317.5 2329.9 2337.3 2289.9 2304.4 2330.6 2332.1 2333.9 2030.7 2103.5 2106.9 2234.0 2322.3 2297.0 2313.6 2314.4 2323.3 2324.4 2276.9 2279.2 2310.9 2323.8 2324.4 8790.3 8816.9 8823.8 8838.6 8848.1 5139.8 5311.5 5325.5 5330.0 5330.8 3378.8 3484.5 3628.1 3628.3 3629.9 1067.7 1076.6 1076.7 1096.1 1097.0 11426.7 11591.5 11615.1 11635.2 11647.2 4461.0 4525.3 4697.2 4716.5 4724.1 9902.3 9917.2 9930.1 9939.0 9940.3 5275.3 5278.8 5279.2 5282.5 5288.5 4668.2 4720.9 4830.0 4830.4 4831.2 3813.5 3830.5 3861.2 3899.2 4005.1 1235.6 1239.7 1244.0 1251.7 1256.3 616.7 753.3 788.9 898.1 915.6 5576.4 5780.9 5993.9 6042.7 6078.5 864.5 868.4 907.3 924.2 953.9 3192.4 3959.0 3971.8 3974.6 4072.4 10181.4 10575.1 10626.1 10627.2 10627.5 10476.1 10561.8 10573.7 10593.3 10599.7 8105.0 8174.7 8184.3 8186.3 8187.1 4850.7 5396.8 5822.2 5829.0 5884.7 9462.2 9717.5 9734.2 9781.6 9876.8 9768.0 9993.7 10075.6 10084.0 10112.1 7327.6 7332.0 7351.9 7412.0 7433.6 8239.9 8288.5 8289.5 8289.7 8314.7 7258.9 7359.9 7385.3 7433.2 7495.2 7229.2 7264.1 7279.3 7305.2 7387.1 6138.9 6665.4 6761.9 6931.7 6959.1 4592.5 4977.5 5010.8 5041.3 5156.8 4789.6 4849.3 4887.5 5004.6 5044.5 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4354.78 Median:4969.11 stddev:1357.85 (27.3%) stddev-sans-first:1326.78 14:17:22 INFO - PROCESS | 1657 | Values: 280.5 286.5 301.5 312.2 317.6 4477.4 5013.7 5180.4 5193.6 5212.9 4462.4 4573.9 4591.9 4997.0 5171.2 3742.8 3793.2 3907.1 4002.8 4009.7 3948.4 3950.2 3956.2 4007.9 4019.7 3461.0 3903.7 3922.5 3930.4 3950.2 3362.7 3430.0 3640.9 3923.2 3960.2 3411.8 3419.7 3434.6 3436.8 3472.4 4968.8 4995.6 5039.4 5051.9 5074.9 3687.9 4409.2 4494.3 4501.5 4514.3 4775.6 4960.8 5367.4 5381.9 5388.3 3673.3 3695.3 3698.7 3709.6 3716.1 4969.4 5556.5 5714.3 5781.2 5788.0 3405.0 3711.8 3742.6 3751.9 3756.5 3398.7 3781.7 3782.0 3789.2 3840.6 4223.4 4440.2 4464.6 4474.7 4497.3 5183.7 5217.2 5462.7 5484.4 5560.4 1065.1 1158.1 1203.0 1239.5 1254.3 651.5 660.8 795.3 798.5 808.6 4137.2 4472.9 4556.9 4752.3 4990.0 5345.9 5521.3 5582.0 5584.2 5606.9 4806.9 5045.6 5086.6 5097.8 5109.7 2292.5 2538.5 2852.0 2941.3 2945.3 4894.8 5830.9 5852.6 5868.9 5872.3 4859.9 5057.6 5139.3 5315.5 5671.9 4741.2 4829.0 5788.3 5825.4 5849.6 5055.4 5278.5 5432.4 5568.9 5620.7 4828.2 5184.2 5481.3 5554.4 5582.7 4318.8 5246.5 5366.5 5595.6 5791.5 3173.7 3212.6 3258.1 3630.9 3736.3 5164.5 5354.2 5521.9 5588.5 5608.9 4539.5 5392.6 5395.4 5453.3 5459.2 5190.4 5318.1 5477.7 5481.7 5492.5 5065.9 5237.0 5261.2 5305.4 5315.4 4041.7 5097.4 5287.1 5354.8 5388.6 4660.1 5030.5 5234.4 5296.2 5377.3 14:17:22 INFO - PROCESS | 1657 | 14:17:22 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:25904.22 Median:3488.46 stddev:42075.39 (1206.1%) stddev-sans-first:42150.39 14:17:22 INFO - PROCESS | 1657 | Values: 560.7 723.0 727.3 758.4 771.0 14335.8 14943.4 14967.6 14970.9 15280.8 14087.8 14276.0 14276.9 14285.9 14339.7 666.3 690.1 818.2 829.4 852.3 847.9 853.8 863.9 866.2 867.9 909.6 910.6 911.0 911.2 911.3 696.1 901.0 901.5 902.5 903.7 538.4 652.7 663.5 673.7 684.4 14802.6 14946.0 14946.0 14949.9 14964.4 13639.3 14105.0 14308.5 14321.4 14534.8 12764.1 12857.7 12897.9 13037.2 13163.3 4532.1 4536.5 4630.9 4655.6 4687.2 123089.4 124179.0 124476.0 124716.4 125084.0 11039.5 11082.1 11083.3 11154.3 11458.1 22545.7 22611.2 22681.7 22696.0 22794.7 7616.7 7669.7 7695.7 7698.0 7746.8 4091.0 4152.5 4169.4 4200.1 4294.9 3521.2 3608.0 3640.3 3663.5 3864.7 723.6 723.8 724.5 735.2 743.3 596.4 604.8 663.9 672.2 682.4 8740.2 9048.0 9285.9 9420.9 9766.9 581.2 591.5 636.7 641.9 646.3 3455.7 4637.0 4708.4 4882.5 5082.4 150047.0 158702.0 159017.0 160269.2 165264.2 133502.3 134434.0 137492.0 139149.0 142798.3 82865.0 112106.0 115169.0 118228.0 118810.0 9701.0 9916.5 9950.5 9952.3 9962.6 62994.7 64215.7 64844.7 66238.7 66392.5 73489.4 79368.0 94624.5 102407.0 104680.1 11046.2 13026.2 13030.3 13275.9 13908.8 12409.5 14710.1 14779.1 15299.9 15477.3 13446.5 13691.0 13871.7 13923.5 14058.4 13445.2 13702.6 13704.4 13721.5 13861.6 13385.7 13599.1 13879.9 13980.9 13992.7 11342.2 11426.0 11527.4 11876.5 11911.4 9938.9 10241.5 11436.1 11465.7 11642.8 14:17:22 INFO - PROCESS | 1657 | -------- Summary: end -------- 14:17:22 INFO - PROCESS | 1657 | 14:17:23 INFO - TEST-INFO | 1657: exit 0 14:17:23 INFO - TEST-OK | dromaeo_css | took 1118561ms 14:17:23 INFO - TEST-START | kraken 14:17:23 INFO - operating with platform_type : mac_ 14:17:23 INFO - Initialising browser for kraken test... 14:17:23 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpX2z9z6/profile http://localhost:49270/getInfo.html) 14:17:25 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 14:17:25 INFO - PROCESS | 1667 | colorDepth:24 14:17:25 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 14:17:25 INFO - PROCESS | 1667 | __metrics 14:17:25 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:17:25 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:26 INFO - TEST-INFO | 1667: exit 0 14:17:26 INFO - Browser initialized. 14:17:26 INFO - Running cycle 1/1 for kraken test... 14:17:26 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpX2z9z6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:37 INFO - PROCESS | 1668 | RSS: Main: 235044864 14:17:37 INFO - PROCESS | 1668 | 14:17:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 14:17:41 INFO - PROCESS | 1668 | RSS: Main: 293470208 14:17:41 INFO - PROCESS | 1668 | 14:17:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 14:17:44 INFO - PROCESS | 1668 | RSS: Main: 293376000 14:17:44 INFO - PROCESS | 1668 | 14:17:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 14:17:48 INFO - PROCESS | 1668 | RSS: Main: 382021632 14:17:48 INFO - PROCESS | 1668 | 14:17:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 14:17:51 INFO - PROCESS | 1668 | RSS: Main: 286576640 14:17:51 INFO - PROCESS | 1668 | 14:17:53 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:54 INFO - PROCESS | 1668 | RSS: Main: 288223232 14:17:54 INFO - PROCESS | 1668 | 14:17:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 14:17:57 INFO - PROCESS | 1668 | RSS: Main: 326336512 14:17:57 INFO - PROCESS | 1668 | 14:18:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:01 INFO - PROCESS | 1668 | RSS: Main: 328228864 14:18:01 INFO - PROCESS | 1668 | 14:18:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 14:18:04 INFO - PROCESS | 1668 | RSS: Main: 324849664 14:18:04 INFO - PROCESS | 1668 | 14:18:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:06 INFO - PROCESS | 1668 | RSS: Main: 300359680 14:18:06 INFO - PROCESS | 1668 | 14:18:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:09 INFO - PROCESS | 1668 | RSS: Main: 303575040 14:18:09 INFO - PROCESS | 1668 | 14:18:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:12 INFO - PROCESS | 1668 | RSS: Main: 315736064 14:18:12 INFO - PROCESS | 1668 | 14:18:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:18:16 INFO - PROCESS | 1668 | RSS: Main: 318812160 14:18:16 INFO - PROCESS | 1668 | 14:18:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:19 INFO - PROCESS | 1668 | RSS: Main: 317628416 14:18:19 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 14:18:21 INFO - PROCESS | 1668 | RSS: Main: 361791488 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | __start_tp_report 14:18:21 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 14:18:21 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 14:18:21 INFO - PROCESS | 1668 | |i|pagename|runs| 14:18:21 INFO - PROCESS | 1668 | |0;ai-astar;113;113;112;111;114;113;112;114;113;113 14:18:21 INFO - PROCESS | 1668 | |1;audio-beat-detection;150;114;115;149;116;114;112;114;143;111 14:18:21 INFO - PROCESS | 1668 | |2;audio-dft;181;184;182;182;183;185;184;183;182;183 14:18:21 INFO - PROCESS | 1668 | |3;audio-fft;80;58;60;88;76;83;80;81;72;81 14:18:21 INFO - PROCESS | 1668 | |4;audio-oscillator;84;71;94;71;54;63;106;97;100;124 14:18:21 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;118;131;86;84;87;84;89;85;90;84 14:18:21 INFO - PROCESS | 1668 | |6;imaging-darkroom;95;95;96;95;95;94;95;95;95;95 14:18:21 INFO - PROCESS | 1668 | |7;imaging-desaturate;84;85;86;85;84;85;84;85;85;85 14:18:21 INFO - PROCESS | 1668 | |8;json-parse-financial;57;56;52;52;53;55;54;53;54;54 14:18:21 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;70;68;76;74;71;68;68;70;69;70 14:18:21 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;88;85;86;90;86;89;85;88;90;91 14:18:21 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;156;164;142;131;154;154;156;153;207;179 14:18:21 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;181;171;171;170;171;169;169;170;172;172 14:18:21 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;69;69;70;68;69;68;69;68;69;68 14:18:21 INFO - PROCESS | 1668 | __end_tp_report 14:18:21 INFO - PROCESS | 1668 | __start_cc_report 14:18:21 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2069 14:18:21 INFO - PROCESS | 1668 | __end_cc_report 14:18:21 INFO - PROCESS | 1668 | __startTimestamp1477516701589__endTimestamp 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | ------- Summary: start ------- 14:18:21 INFO - PROCESS | 1668 | Number of tests: 14 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 14:18:21 INFO - PROCESS | 1668 | Values: 113.0 113.0 112.0 111.0 114.0 113.0 112.0 114.0 113.0 113.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:115.50 stddev:16.40 (14.2%) stddev-sans-first:14.39 14:18:21 INFO - PROCESS | 1668 | Values: 150.0 114.0 115.0 149.0 116.0 114.0 112.0 114.0 143.0 111.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:1.20 (0.7%) stddev-sans-first:1.05 14:18:21 INFO - PROCESS | 1668 | Values: 181.0 184.0 182.0 182.0 183.0 185.0 184.0 183.0 182.0 183.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:75.90 Median:80.50 stddev:9.84 (12.2%) stddev-sans-first:10.32 14:18:21 INFO - PROCESS | 1668 | Values: 80.0 58.0 60.0 88.0 76.0 83.0 80.0 81.0 72.0 81.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:71.00 stddev:21.68 (30.5%) stddev-sans-first:22.98 14:18:21 INFO - PROCESS | 1668 | Values: 84.0 71.0 94.0 71.0 54.0 63.0 106.0 97.0 100.0 124.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:93.80 Median:85.50 stddev:16.60 (19.4%) stddev-sans-first:15.12 14:18:21 INFO - PROCESS | 1668 | Values: 118.0 131.0 86.0 84.0 87.0 84.0 89.0 85.0 90.0 84.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:18:21 INFO - PROCESS | 1668 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:18:21 INFO - PROCESS | 1668 | Values: 84.0 85.0 86.0 85.0 84.0 85.0 84.0 85.0 85.0 85.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.63 (3.0%) stddev-sans-first:1.32 14:18:21 INFO - PROCESS | 1668 | Values: 57.0 56.0 52.0 52.0 53.0 55.0 54.0 53.0 54.0 54.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:2.67 (3.8%) stddev-sans-first:2.83 14:18:21 INFO - PROCESS | 1668 | Values: 70.0 68.0 76.0 74.0 71.0 68.0 68.0 70.0 69.0 70.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.50 stddev:2.20 (2.5%) stddev-sans-first:2.33 14:18:21 INFO - PROCESS | 1668 | Values: 88.0 85.0 86.0 90.0 86.0 89.0 85.0 88.0 90.0 91.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:159.60 Median:156.00 stddev:20.82 (13.3%) stddev-sans-first:22.05 14:18:21 INFO - PROCESS | 1668 | Values: 156.0 164.0 142.0 131.0 154.0 154.0 156.0 153.0 207.0 179.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.00 stddev:3.47 (2.0%) stddev-sans-first:1.13 14:18:21 INFO - PROCESS | 1668 | Values: 181.0 171.0 171.0 170.0 171.0 169.0 169.0 170.0 172.0 172.0 14:18:21 INFO - PROCESS | 1668 | 14:18:21 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:18:21 INFO - PROCESS | 1668 | Values: 69.0 69.0 70.0 68.0 69.0 68.0 69.0 68.0 69.0 68.0 14:18:21 INFO - PROCESS | 1668 | -------- Summary: end -------- 14:18:21 INFO - PROCESS | 1668 | 14:18:22 INFO - TEST-INFO | 1668: exit 0 14:18:22 INFO - TEST-OK | kraken | took 59424ms 14:18:22 INFO - SUITE-END | took 1177s 14:18:22 INFO - Completed test suite (00:19:38) 14:18:22 INFO - javascript benchmark 14:18:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.248532837448, 3274.4433446314124, 3276.0499455157997, 3319.8340082995846, 3342.314825460781, 5389.541888939435, 5466.262054622624, 5495.368032676243, 5548.889022219559, 5566.499015088636, 5436.184572314155, 5494.203340515623, 5518.0, 5595.328560572727, 5604.327480702311, 4987.650864439491, 5076.162433198518, 5079.161938280179, 5124.6668966517245, 5142.023015627019, 5055.368078990126, 5062.2406639004075, 5139.8458046258675, 5151.407588127376, 5184.1186998210205, 5115.974420127913, 5128.948710512903, 5132.8460146195675, 5160.612954028444, 5216.895662086756, 4992.975035124801, 5031.22016087507, 5053.722045287508, 5069.290299358093, 5098.566621837148, 5014.498550144993, 5024.321716568253, 5026.748662566857, 5057.140286151326, 5101.387833459971, 5443.074677304868, 5546.084895992157, 5581.6371935824045, 5581.6371935824445, 5589.944100559023, 5831.620944638585, 5926.881462370771, 5950.345461999176, 6036.637801731867, 6079.665618390986, 5051.9494805051845, 6021.5182785377065, 6026.457618814284, 6108.251008765826, 6135.147011824827, 5581.469760372758, 5595.160725891149, 5595.412481689364, 5600.943990560083, 5619.353774315965, 4792.257200133985, 6037.426444487766, 6192.380761923771, 6209.316975132731, 6211.81364559064, 5770.221020162308, 5778.219940308005, 5829.154772557956, 5830.038043722823, 5883.0, 5989.932134019144, 6058.818235452944, 6065.968785306509, 6106.236720409949, 6111.54163437744, 5879.235699359141, 5934.495567876693, 5961.731722072517, 5970.76116955317, 5971.880562388728, 5770.19217309577, 5843.2695913010875, 5864.648121112747, 5988.880222395528, 6027.30685971119, 4766.998930224622, 4768.546988036201, 4779.784909679072, 4780.808767649255, 4786.234202527648, 4247.5964783345535, 4280.636145927631, 4345.9348109778375, 4354.368616550582, 4368.344748287782, 5422.5119739223655, 5496.917546236809, 5516.393196748354, 5519.558435325244, 5549.944500555023, 6055.969720151371, 6101.023836186278, 6110.786122485781, 6133.1413602095745, 6136.018237082046, 5573.41479144692, 5577.163425486209, 5580.804671836548, 5586.0, 5591.384947655754, 5141.126008578476, 5205.115130427836, 5206.323177986837, 5232.2413250078525, 5246.029484545371, 4629.421322334708, 6248.562600618004, 6249.375062493714, 6301.0863424804065, 6326.4622507087415, 5939.940600593939, 6059.339116931195, 6072.332043475126, 6073.392660733891, 6121.418465245794, 6171.722272497838, 6246.937530624636, 6271.247450305992, 6305.873882522232, 6326.557141000086, 5117.02776472469, 5687.317521897234, 5844.853878652898, 5921.644701317935, 5985.940140598713, 6063.5452341073715, 6078.209832721718, 6079.817605471843, 6094.11635312886, 6094.847628809315, 5675.0, 5852.4440178183, 5859.707014649336, 5865.384134665798, 5867.618604790675, 5667.121596152603, 5774.422557744192, 5780.075187969905, 5781.68200748946, 5785.0, 5628.60599758013, 5646.830595082154, 5699.116636921284, 5699.51554117888, 5749.396313387034, 5764.0, 5866.970665146647, 5882.23530940975, 5892.823215303548, 5923.289205295392, 5632.88734225305, 5666.518345940642, 5688.63023903445, 5710.314762228559, 5711.457411545896], "value": 5500.782838730021, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.74481269739715, 490.95581397674204, 541.4071591607188, 544.9836504904849, 563.4900415124313, 27610.861945690267, 39657.40513892294, 39659.60340396595, 39662.8016859916, 39742.99999999996, 40805.795971020176, 41178.58821411785, 41380.17239655212, 41397.96505087367, 41694.54069107582, 8678.435901666404, 8927.018028016913, 9499.857502137473, 9671.951640241788, 9725.416475011487, 11690.941545292304, 11980.820287695691, 12077.335746533938, 12169.269843809356, 12194.756104877897, 11890.702732431715, 11961.222520536137, 11973.580924667638, 11984.460699268553, 11995.820062699024, 8790.780230494289, 9018.36871419001, 11716.882831171664, 11992.340421276826, 12051.276923384581, 11577.363245021605, 11781.352025638587, 11807.645770626896, 11810.0, 11846.0, 39802.60197398047, 40021.0, 40042.599574004176, 40129.598704012875, 40221.59778402208, 2864.785141114404, 3222.4360736870954, 3241.5137729340554, 3259.9837000815082, 3272.721818645418, 31274.687253127406, 31369.686303136903, 31407.528887066714, 31411.685883141334, 31475.84262078675, 3182.7612929030415, 3331.68349006844, 3345.631980482145, 3379.3917094922904, 3381.8309084545676, 478649.0, 483941.0, 488924.5553772244, 489405.0, 490819.0, 63002.0, 64396.356036439036, 64417.0, 64441.58921723968, 64570.0, 68626.9705954411, 69103.65448172727, 69122.61754764877, 69246.96129558061, 69250.65374673196, 16118.838811611968, 16311.34754609826, 16487.0, 16524.339026439047, 16526.421575244807, 11104.777904441866, 11315.434228288717, 11379.658610241706, 12533.498660053496, 12632.557860474839, 19397.89396557269, 19734.802651973296, 19746.802531974783, 19793.01034948247, 19817.603647927248, 6640.767573135014, 7894.079190699478, 8060.274575288252, 8147.103818579952, 8178.631961561744, 891.6255172827427, 929.1359036096495, 947.4552132523827, 947.6920000999703, 956.583886009588, 29334.379937004836, 29932.551011734842, 29946.90124824315, 29959.550606740915, 30045.110984972893, 1031.3090229546222, 1062.4687656171914, 1077.8922107789315, 1128.1820680007093, 1146.6158836789768, 15317.693646127238, 15343.693126137414, 15434.0, 15609.765853512206, 15725.292361843745, 670546.0, 675267.0, 675502.0, 676319.0, 677076.0, 55717.442825572034, 56283.0, 56425.0, 56515.30454086384, 56700.149497757564, 1210.2012671636853, 1216.0757824053605, 1328.4221363706818, 1352.263016655925, 1376.745302119111, 30307.545386818776, 30486.695133048386, 31048.91328803481, 31621.841890790398, 31891.883784067446, 47708.0, 53315.46684533105, 55118.41730287518, 55270.0, 57838.7108064457, 420214.0, 596715.0, 601488.0, 602008.0, 604012.0, 26091.869540652177, 26765.598516022666, 26889.865550672905, 41658.58341416547, 42282.0, 45247.773761130986, 45315.32027019663, 46079.0, 46267.843303917674, 46624.0, 33667.49498757472, 36721.63278367289, 37415.0, 37492.62507374891, 38224.23551528898, 32187.839060804545, 32561.837190813894, 35350.93947181589, 36558.0, 37549.81225093966, 37163.6992705254, 37516.0, 37723.81138094292, 37749.86750397492, 37754.8112259437, 31507.527387088754, 33787.66212337845, 33801.83099084489, 33911.83044084764, 37230.8138459306, 30718.385632286783, 31440.371192576476, 31971.0, 32014.0, 32605.673943261212], "value": 20599.153054990762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9378858699727, 364.70276724469556, 367.2434784344251, 374.0853612916419, 396.9523657161141, 15212.391504339826, 15385.461508847178, 16457.259423325948, 20998.475038124056, 21449.892750536226, 20147.09338079786, 20498.0, 21019.0, 21115.57768844622, 21422.82174480403, 4688.601468875149, 5907.527397808176, 6225.128482012522, 6236.376362363772, 6239.0, 6017.157597936292, 6205.014395393476, 6214.316425193225, 6218.160548325986, 6219.751209951596, 5953.821385358447, 5957.940420595782, 6079.726412311435, 6165.0, 6175.62946223228, 5992.730327135289, 6065.120557519179, 6070.423309785585, 6078.209832721762, 6078.635281883101, 5083.567896728782, 5242.659227150223, 5382.6232163748555, 5446.509814116709, 5488.9725551372385, 12820.743585128244, 13064.934675326562, 13082.476700931951, 16388.590285242844, 24906.50186996268, 2465.778079972793, 2622.318197268705, 2775.1951933939135, 2891.3060865392363, 2900.492413827593, 9546.236301095896, 9661.661841835503, 9682.75793105178, 9835.31152819303, 10145.949270253675, 1585.952421427359, 1724.9995002898415, 1803.6392721455761, 1876.80293569176, 1876.8873867567854, 116945.83054169519, 127705.0, 128732.35633821771, 129595.0, 132276.33861830726, 11176.105911527058, 11375.089992800557, 11452.96923276909, 11530.654080377602, 11713.472893719803, 14494.710105797825, 14501.564953051426, 14528.055676381002, 14542.418303267963, 14543.490977815938, 8253.33973282136, 8385.203405676451, 8394.160583941557, 8408.621612027351, 8540.14598540141, 8217.178282171855, 8245.257926786619, 8246.587670616445, 8378.204070613281, 8434.915650843535, 4474.664400169935, 4478.395416618715, 4518.299663552155, 4543.659225558096, 4581.9541804582195, 1831.5878927241265, 1883.52911772057, 1888.4240306706586, 1888.518427800902, 1898.8291053805224, 714.4106112457243, 725.0031207090251, 871.3769654696922, 912.6851236323457, 929.6235024814961, 17919.0, 20596.38210853647, 20696.896515517325, 21496.89251553732, 21569.13723451076, 776.7747353267489, 934.495372498843, 935.8175155844681, 952.3999880075509, 983.9212862970945, 10803.621873234399, 11350.637923449074, 11392.544298228144, 11427.257228280136, 11445.656630301104, 553121.0, 589864.0, 593049.0, 608496.0, 608723.0, 87120.1287987112, 104409.26039013673, 121818.0, 128349.35825320813, 132135.0, 896.5293221058996, 943.0852073488705, 971.7667759737612, 972.9562169702239, 973.2894986659636, 19306.71039934374, 19621.215151393786, 19827.0, 19888.90055549771, 20012.799872001095, 51656.74171629118, 52186.21720674269, 52896.677583059194, 53103.468965309854, 54230.18654720261, 71660.28339716536, 71712.0, 72302.0, 74910.62544687242, 74977.0, 6818.28408017151, 7381.372583330477, 7419.96290018568, 7548.735794247175, 7634.007579014693, 12646.683832904251, 13091.803622945854, 13625.046246762631, 13665.316734163052, 13700.588982330546, 5439.292891924025, 5489.917651235155, 11230.831537527107, 11251.704690208368, 11852.76294474123, 9585.712428627152, 11309.773804524028, 11618.593349232737, 11737.413129343327, 11754.0, 11440.942795286302, 11549.307041577533, 12002.579909703118, 12037.578684745991, 12129.0, 7327.780166595011, 7360.889586656312, 7497.212792656911, 7697.345725613385, 7716.112647045662, 10809.837852432378, 11271.0, 11564.653060408202, 11668.649940501798, 11688.298702077562], "value": 9328.71146750684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.1742954227461, 1493.7369884624795, 1602.511234073607, 1664.4008157063456, 1871.5882505848708, 8142.552159631218, 8872.600732967016, 8875.778105547357, 8876.64493420264, 8879.156480134385, 7696.923030769691, 8000.639971201295, 8309.83380332393, 8603.268722158624, 8621.224089831914, 2069.317125348639, 2299.2872209615075, 2317.5249073939885, 2329.871857047862, 2337.2871274261342, 2289.9313020609407, 2304.3662992677064, 2330.568844763716, 2332.11379675723, 2333.894974726133, 2030.7461567304088, 2103.547737236494, 2106.936791896238, 2233.9664905026357, 2322.280093171122, 2297.0467256088705, 2313.595120853852, 2314.3751187179537, 2323.3262353917344, 2324.3840382298704, 2276.9089236430523, 2279.190887235024, 2310.8960096795686, 2323.802476789475, 2324.372419446757, 8790.252828509585, 8816.8677469838, 8823.77940551485, 8838.55807209637, 8848.115188481164, 5139.820106296262, 5311.521963023308, 5325.520703136697, 5329.973350133263, 5330.786768529293, 3378.814165220912, 3484.52958850557, 3628.0567052566257, 3628.2924829658227, 3629.9274014519824, 1067.7417262489855, 1076.5747529725716, 1076.6985244131656, 1096.0573906440454, 1097.018168738982, 11426.714332141762, 11591.536338546448, 11615.128865335133, 11635.243709158878, 11647.242929209575, 4461.04087621163, 4525.321201819687, 4697.224957881979, 4716.504766999485, 4724.102420540086, 9902.257330700226, 9917.15704165154, 9930.05664461875, 9939.0, 9940.25448091396, 5275.340582427197, 5278.841634750886, 5279.1817268323475, 5282.52457278839, 5288.497592728761, 4668.229742092517, 4720.881977950578, 4829.95170048302, 4830.396200474941, 4831.178699621073, 3813.5423749149722, 3830.482884810515, 3861.1698484825897, 3899.200663863901, 4005.098852758106, 1235.6354875311624, 1239.6714870559308, 1243.9813402798966, 1251.69333513288, 1256.2525297448003, 616.7348040342696, 753.3370633842184, 788.9171636978035, 898.078943716415, 915.6108653822099, 5576.358718747315, 5780.884382312414, 5993.910091348634, 6042.732530624662, 6078.483328917003, 864.4510735682886, 868.3617541107282, 907.2560500389617, 924.246738907788, 953.909378609031, 3192.425363434604, 3958.960410395917, 3971.841126354971, 3974.5627980922077, 4072.3687828386646, 10181.440020798927, 10575.101116405192, 10626.096781773482, 10627.202959778047, 10627.468626568641, 10476.0571548561, 10561.788764224826, 10573.682789516326, 10593.311434756715, 10599.735006624896, 8105.0, 8174.713885013996, 8184.304334131665, 8186.2632363087605, 8187.140350263256, 4850.733209673502, 5396.78412863481, 5822.2140011099655, 5828.970855145697, 5884.676342801015, 9462.243020558477, 9717.465539395402, 9734.172595329477, 9781.559829807533, 9876.802463950824, 9768.0, 9993.700188994342, 10075.647352342632, 10084.042016008467, 10112.089911907964, 7327.63361831917, 7331.963340183478, 7351.889721654286, 7412.0364352633815, 7433.591152486665, 8239.876401854097, 8288.544130072903, 8289.502629842229, 8289.668413263402, 8314.70898518573, 7258.927410726036, 7359.852802944019, 7385.2644628513335, 7433.182349941394, 7495.213002634645, 7229.204787473479, 7264.055672762718, 7279.344858962719, 7305.2329505403295, 7387.1135463744695, 6138.877222455437, 6665.366790154928, 6761.898571521333, 6931.68807403658, 6959.0605268290155, 4592.471865735483, 4977.4524802271, 5010.849674509771, 5041.319421878, 5156.819511317236, 4789.568938795525, 4849.3210950466255, 4887.462379138221, 5004.649674522749, 5044.520770526794], "value": 4507.366722842103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.4602731006772, 286.54007830105604, 301.4618905254121, 312.1976520342719, 317.5522513256309, 4477.373167756513, 5013.674111182775, 5180.404253510847, 5193.63644544882, 5212.947870521293, 4462.352958820969, 4573.902263456771, 4591.908161836761, 4997.0, 5171.224316352549, 3742.7754334739866, 3793.2413517296513, 3907.081835768592, 4002.7598344099447, 4009.6591789697763, 3948.368261078228, 3950.2297052074855, 3956.2197011344865, 4007.8797636070817, 4019.658329042035, 3461.0482117417787, 3903.70722195835, 3922.5486569969153, 3930.3711406174875, 3950.20995800841, 3362.747793915466, 3430.022443603586, 3640.872569460056, 3923.234969181011, 3960.1683646434426, 3411.795292282446, 3419.6834218825684, 3434.6050204226585, 3436.8453419596176, 3472.378354342455, 4968.826091086831, 4995.550400463976, 5039.44566097729, 5051.9494805051845, 5074.898502029976, 3687.8893633191046, 4409.2283850326385, 4494.348334482671, 4501.4598248210095, 4514.300283456069, 4775.594074503671, 4960.759810047488, 5367.362954298937, 5381.892362152735, 5388.326459192601, 3673.265346930598, 3695.316366472211, 3698.7041036716996, 3709.5733990591157, 3716.0709822544363, 4969.403671559436, 5556.472135147154, 5714.257146570961, 5781.19063331134, 5787.971060144714, 3404.9785064481052, 3711.7958512282084, 3742.642135454646, 3751.9249615007548, 3756.4553139794575, 3398.728101751854, 3781.7352785305316, 3781.9810900945317, 3789.2232092420986, 3840.558335791364, 4223.387608796768, 4440.2007638625355, 4464.553544645574, 4474.731516109044, 4497.268551607654, 5183.688978661293, 5217.165253559412, 5462.726863656881, 5484.396716361197, 5560.36055853582, 1065.142560239015, 1158.1140427572914, 1202.9534305154398, 1239.4546399584153, 1254.2850575172065, 651.5406638319973, 660.8149718078946, 795.327947884037, 798.5408390175672, 808.6132283134452, 4137.213929353413, 4472.948857018598, 4556.931646025312, 4752.334673145762, 4989.950100498949, 5345.866353341197, 5521.309836270466, 5581.972090139523, 5584.246126772915, 5606.85982850432, 4806.8798280043275, 5045.646804723634, 5086.567641750418, 5097.8215762448135, 5109.693418394908, 2292.5185711000545, 2538.4796116796015, 2851.957220641692, 2941.294089418524, 2945.278406790307, 4894.800773810368, 5830.912536311958, 5852.590318677737, 5868.911966320508, 5872.29532456108, 4859.927101093486, 5057.570106540912, 5139.331886854685, 5315.4885265550165, 5671.943280567224, 4741.241401375763, 4828.95171048292, 5788.27646544182, 5825.427134673614, 5849.590528662953, 5055.443901170942, 5278.4721527846905, 5432.402435732145, 5568.9443105568425, 5620.662760234399, 4828.179209534458, 5184.196449550326, 5481.314835645544, 5554.416786237549, 5582.665040097607, 4318.805653745651, 5246.501582349671, 5366.543843773166, 5595.629070877661, 5791.53667706574, 3173.6987834988468, 3212.5663035490843, 3258.1203075169096, 3630.909227269339, 3736.346139425644, 5164.457731938092, 5354.170103633943, 5521.907731670278, 5588.469095435927, 5608.943910560843, 4539.477960034638, 5392.622516423813, 5395.3525576931015, 5453.318335208099, 5459.153831156177, 5190.390978796585, 5318.0959236930585, 5477.726113694379, 5481.725913704378, 5492.450754924475, 5065.910829171598, 5236.973815131052, 5261.184516399964, 5305.416404195458, 5315.3621565412395, 4041.6766658667825, 5097.439281678938, 5287.070219369979, 5354.759035843318, 5388.649737767033, 4660.091282199938, 5030.522100400456, 5234.382808595702, 5296.232046353334, 5377.284471341947], "value": 3910.413304502645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.7084316155599, 722.9746958856441, 727.3163226567029, 758.4311766175368, 770.9746037769766, 14335.78496322556, 14943.402263909458, 14967.625809354771, 14970.850291497081, 15280.847191528095, 14087.788683169761, 14276.0, 14276.857231427683, 14285.857141428583, 14339.71320573588, 666.3270097201837, 690.1373283395756, 818.1532114261755, 829.3862541719114, 852.3096292003497, 847.9364047696416, 853.8078932240259, 863.9308855291562, 866.2074202105066, 867.9392442529025, 909.636145541782, 910.644848509082, 910.9908900910972, 911.2300106410106, 911.2846415563783, 696.07074555468, 900.9774755631096, 901.4861528928514, 902.5261737587754, 903.6972614174259, 538.3512866995261, 652.6736631684158, 663.4857985061568, 673.737242475435, 684.3635419060272, 14802.555923322318, 14946.0, 14946.028508146936, 14949.925250373679, 14964.401423943029, 13639.318034098256, 14105.0, 14308.49920252786, 14321.35553900077, 14534.781978270334, 12764.106512544126, 12857.67855803603, 12897.935510322483, 13037.21776693392, 13163.276019818906, 4532.138893610237, 4536.523665015159, 4630.930536041962, 4655.580997710188, 4687.20317546018, 123089.38455307666, 124179.0, 124476.0, 124716.37641811823, 125084.0, 11039.491511915096, 11082.058025067798, 11083.279586826991, 11154.274972126786, 11458.083353331713, 22545.661815072788, 22611.20860769898, 22681.659775103388, 22696.0, 22794.65808012881, 7616.7334143304715, 7669.7315593953945, 7695.653695583712, 7697.961510192526, 7746.767596971987, 4090.9590904091174, 4152.5432202458305, 4169.4366993778685, 4200.075983283673, 4294.89262768427, 3521.2429327694667, 3607.981960090183, 3640.2719456108885, 3663.505426767352, 3864.652181303696, 723.616483263871, 723.8081908294306, 724.5254358395259, 735.2280105888796, 743.2604558464362, 596.3887015808743, 604.8276241271217, 663.873863965845, 672.2101530701407, 682.3827528756877, 8740.169683880022, 9048.0, 9285.860712089325, 9420.90579094214, 9766.902330976742, 581.2356750872674, 591.4794980417205, 636.700750647195, 641.9486441084701, 646.253577118429, 3455.671711187433, 4636.976815115903, 4708.4349878014855, 4882.536159064884, 5082.382572974921, 150047.0, 158702.0, 159017.0, 160269.19865400597, 165264.17367913082, 133502.33248833695, 134434.0, 137492.0, 139149.0, 142798.2860085693, 82865.0, 112105.99999999837, 115169.0, 118228.0, 118810.0, 9701.0, 9916.454594997056, 9950.45272510019, 9952.303338766507, 9962.551685174329, 62994.685026574574, 64215.71568568509, 64844.67577662082, 66238.66880665565, 66392.45675254364, 73489.42787002643, 79368.0, 94624.52687736518, 102407.0, 104680.14898882767, 11046.226764126755, 13026.153300035467, 13030.348482576022, 13275.933620331836, 13908.791368129283, 12409.52012153341, 14710.117392956457, 14779.113253204841, 15299.923500382427, 15477.303521341792, 13446.529371471952, 13691.0, 13871.72256554843, 13923.512677056255, 14058.367373468423, 13445.193288402335, 13702.588922332347, 13704.3833027516, 13721.519746808814, 13861.584152475441, 13385.66535836612, 13599.134600525358, 13879.861201387857, 13980.930095349866, 13992.720145596828, 11342.20604557673, 11426.0, 11527.423628818358, 11876.465559050037, 11911.40442977865, 9938.90672026091, 10241.544937845303, 11436.142289328167, 11465.656030319104, 11642.825357619811], "value": 7942.748422716912, "unit": "score"}], "name": "dromaeo_css", "value": 7272.946263321111, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 111.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 115.0, 149.0, 116.0, 114.0, 112.0, 114.0, 143.0, 111.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 182.0, 182.0, 183.0, 185.0, 184.0, 183.0, 182.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 60.0, 88.0, 76.0, 83.0, 80.0, 81.0, 72.0, 81.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 94.0, 71.0, 54.0, 63.0, 106.0, 97.0, 100.0, 124.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 131.0, 86.0, 84.0, 87.0, 84.0, 89.0, 85.0, 90.0, 84.0], "value": 93.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 52.0, 52.0, 53.0, 55.0, 54.0, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 76.0, 74.0, 71.0, 68.0, 68.0, 70.0, 69.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 86.0, 90.0, 86.0, 89.0, 85.0, 88.0, 90.0, 91.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 164.0, 142.0, 131.0, 154.0, 154.0, 156.0, 153.0, 207.0, 179.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 171.0, 171.0, 170.0, 171.0, 169.0, 169.0, 170.0, 172.0, 172.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1467.4999999999998, "alertThreshold": 2.0}]} 14:18:22 INFO - Return code: 0 14:18:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:18:22 INFO - # TBPL SUCCESS # 14:18:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:18:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:18:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:18:22 INFO - 2016-10-26 14:18:22.919 screenresolution[1672:10138] starting screenresolution argv=screenresolution get 14:18:22 INFO - 2016-10-26 14:18:22.922 screenresolution[1672:10138] Display 0: 1600x1200x32@60 14:18:22 INFO - 2016-10-26 14:18:22.928 screenresolution[1673:10141] starting screenresolution argv=screenresolution list 14:18:22 INFO - Available Modes on Display 0 14:18:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:18:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:18:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:18:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:18:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:18:23 INFO - Intel Iris: 14:18:23 INFO - Chipset Model: Intel Iris 14:18:23 INFO - Type: GPU 14:18:23 INFO - Bus: Built-In 14:18:23 INFO - VRAM (Dynamic, Max): 1536 MB 14:18:23 INFO - Vendor: Intel (0x8086) 14:18:23 INFO - Device ID: 0x0a2e 14:18:23 INFO - Revision ID: 0x0009 14:18:23 INFO - Displays: 14:18:23 INFO - Display: 14:18:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:18:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:18:23 INFO - Display Serial Number: 1600x1200 60 14:18:23 INFO - Main Display: Yes 14:18:23 INFO - Mirror: Off 14:18:23 INFO - Online: Yes 14:18:23 INFO - Rotation: Supported 14:18:23 INFO - Return code: 0 14:18:23 INFO - Running post-action listener: _resource_record_post_action 14:18:23 INFO - [mozharness: 2016-10-26 21:18:23.166200Z] Finished run-tests step (success) 14:18:23 INFO - Running post-run listener: _resource_record_post_run 14:18:23 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 36840448; Write bytes: 705902080; Read time: 370; Write time: 1961 14:18:23 INFO - TinderboxPrint: CPU usage
53.3% 14:18:23 INFO - TinderboxPrint: I/O read bytes / time
36,840,448 / 370 14:18:23 INFO - TinderboxPrint: I/O write bytes / time
705,902,080 / 1,961 14:18:23 INFO - TinderboxPrint: CPU idle
2,264.5 (46.7%) 14:18:23 INFO - TinderboxPrint: CPU system
964.6 (19.9%) 14:18:23 INFO - TinderboxPrint: CPU user
1,620.6 (33.4%) 14:18:23 INFO - TinderboxPrint: Swap in / out
444,481,536 / 0 14:18:23 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406286848; Write bytes: 400975872; Read time: 29787; Write time: 828 14:18:23 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 34554880; Write bytes: 293924352; Read time: 344; Write time: 1098 14:18:23 INFO - Running post-run listener: _upload_blobber_files 14:18:23 INFO - Blob upload gear active. 14:18:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:18:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:18:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:18:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:18:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:18:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:25 INFO - (blobuploader) - INFO - Done attempting. 14:18:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:18:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:18:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:26 INFO - (blobuploader) - INFO - Done attempting. 14:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:28 INFO - (blobuploader) - INFO - Done attempting. 14:18:28 INFO - (blobuploader) - INFO - Iteration through files over. 14:18:28 INFO - Return code: 0 14:18:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:18:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:18:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39a35f113f16fb46fe285b7a2c015a6b13c92ae9eec6a458bf6ce810ce3560ab99b3ad349205d439ad17c3747a43c9e16da4292b562b0d45fe805257a72abef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ddd446cd1d14e14b4579c7cf1e8474aa4e9eeab22df7d78a7b847e5896ee1d3c2db5d45928e397e887ce094ba5e51090c7105d00f5fd7dc722181dccd66ce3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67138686fac56bee616505b7001def6ec79cbf83ea9e1751f594b17715fc1c5cd8aecb712fb93a3581d823230667dd9308a53cd37d5cb30700f5328c94c4afeb"} 14:18:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:18:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:18:28 INFO - Contents: 14:18:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39a35f113f16fb46fe285b7a2c015a6b13c92ae9eec6a458bf6ce810ce3560ab99b3ad349205d439ad17c3747a43c9e16da4292b562b0d45fe805257a72abef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ddd446cd1d14e14b4579c7cf1e8474aa4e9eeab22df7d78a7b847e5896ee1d3c2db5d45928e397e887ce094ba5e51090c7105d00f5fd7dc722181dccd66ce3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67138686fac56bee616505b7001def6ec79cbf83ea9e1751f594b17715fc1c5cd8aecb712fb93a3581d823230667dd9308a53cd37d5cb30700f5328c94c4afeb"} 14:18:28 INFO - Running post-run listener: copy_logs_to_upload_dir 14:18:28 INFO - Copying logs to upload dir... 14:18:28 INFO - mkdir: /builds/slave/test/build/upload/logs 14:18:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.757157 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 14:18:28.701705) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:18:28.705476) ========= 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.G32zHdK66b/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.XwqiLEC6e1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39a35f113f16fb46fe285b7a2c015a6b13c92ae9eec6a458bf6ce810ce3560ab99b3ad349205d439ad17c3747a43c9e16da4292b562b0d45fe805257a72abef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ddd446cd1d14e14b4579c7cf1e8474aa4e9eeab22df7d78a7b847e5896ee1d3c2db5d45928e397e887ce094ba5e51090c7105d00f5fd7dc722181dccd66ce3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67138686fac56bee616505b7001def6ec79cbf83ea9e1751f594b17715fc1c5cd8aecb712fb93a3581d823230667dd9308a53cd37d5cb30700f5328c94c4afeb"} build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39a35f113f16fb46fe285b7a2c015a6b13c92ae9eec6a458bf6ce810ce3560ab99b3ad349205d439ad17c3747a43c9e16da4292b562b0d45fe805257a72abef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ddd446cd1d14e14b4579c7cf1e8474aa4e9eeab22df7d78a7b847e5896ee1d3c2db5d45928e397e887ce094ba5e51090c7105d00f5fd7dc722181dccd66ce3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67138686fac56bee616505b7001def6ec79cbf83ea9e1751f594b17715fc1c5cd8aecb712fb93a3581d823230667dd9308a53cd37d5cb30700f5328c94c4afeb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:18:28.738217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:18:28.738537) ========= 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.G32zHdK66b/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.XwqiLEC6e1/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.004965 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:18:28.786843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:18:28.787165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:18:28.787509) ========= ========= Total master_lag: 0.17 =========