builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0346 starttime: 1477468248.98 results: success (0) buildid: 20161025215823 builduid: c7d7fab8923e46ac8cec43be056f1639 revision: 9471b3c49b2ca02466a653de56ff3d4c32d79c38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:48.983275) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:48.983677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:48.983971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:49.084568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:49.084867) ========= 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.5uNaK3m108/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.AAil1shxRY/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:50:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2016-10-26 00:50:49 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.610942 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:49.721947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:49.722277) ========= 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.5uNaK3m108/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.AAil1shxRY/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.019493 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:49.771728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 00:50:49.772057) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9471b3c49b2ca02466a653de56ff3d4c32d79c38 --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 9471b3c49b2ca02466a653de56ff3d4c32d79c38 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5uNaK3m108/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.AAil1shxRY/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:50:49,854 truncating revision to first 12 chars 2016-10-26 00:50:49,854 Setting DEBUG logging. 2016-10-26 00:50:49,854 attempt 1/10 2016-10-26 00:50:49,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9471b3c49b2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 00:50:50,987 unpacking tar archive at: mozilla-central-9471b3c49b2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.401942 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 00:50:51.199327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:51.199599) ========= script_repo_revision: 9471b3c49b2ca02466a653de56ff3d4c32d79c38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:51.200316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:51.200583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 00:50:51.218670) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-26 00:50:51.218932) ========= /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.5uNaK3m108/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.AAil1shxRY/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:50:51 INFO - MultiFileLogger online at 20161026 00:50:51 in /builds/slave/test 00:50:51 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 00:50:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:50:51 INFO - {'append_to_log': False, 00:50:51 INFO - 'base_work_dir': '/builds/slave/test', 00:50:51 INFO - 'blob_upload_branch': 'Firefox', 00:50:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:50:51 INFO - 'branch': 'Firefox', 00:50:51 INFO - 'buildbot_json_path': 'buildprops.json', 00:50:51 INFO - 'config_files': ('talos/mac_config.py',), 00:50:51 INFO - 'default_actions': ('clobber', 00:50:51 INFO - 'read-buildbot-config', 00:50:51 INFO - 'download-and-extract', 00:50:51 INFO - 'populate-webroot', 00:50:51 INFO - 'create-virtualenv', 00:50:51 INFO - 'install', 00:50:51 INFO - 'run-tests'), 00:50:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:50:51 INFO - 'download_minidump_stackwalk': True, 00:50:51 INFO - 'download_symbols': 'ondemand', 00:50:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:50:51 INFO - 'tooltool.py': '/tools/tooltool.py', 00:50:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:50:51 INFO - '/tools/misc-python/virtualenv.py')}, 00:50:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:50:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:50:51 INFO - 'installer_path': 'installer.exe', 00:50:51 INFO - 'log_level': 'info', 00:50:51 INFO - 'log_name': 'talos', 00:50:51 INFO - 'log_to_console': True, 00:50:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:50:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:50:51 INFO - 'opt_config_files': (), 00:50:51 INFO - 'pip_index': False, 00:50:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:50:51 INFO - 'cmd': ('bash', 00:50:51 INFO - '-c', 00:50:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:50:51 INFO - 'enabled': True, 00:50:51 INFO - 'halt_on_failure': False, 00:50:51 INFO - 'name': 'check_screen_resolution'},), 00:50:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:50:51 INFO - 'cmd': ('bash', 00:50:51 INFO - '-c', 00:50:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:50:51 INFO - 'enabled': True, 00:50:51 INFO - 'halt_on_failure': False, 00:50:51 INFO - 'name': 'check_screen_resolution'},), 00:50:51 INFO - 'run_cmd_checks_enabled': True, 00:50:51 INFO - 'sps_profile': False, 00:50:51 INFO - 'sps_profile_interval': 0, 00:50:51 INFO - 'suite': 'dromaeojs', 00:50:51 INFO - 'system_bits': '32', 00:50:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:50:51 INFO - 'title': 't-yosemite-r7-0346', 00:50:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:50:51 INFO - 'use_talos_json': True, 00:50:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:50:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:50:51 INFO - 'work_dir': 'build'} 00:50:51 INFO - [mozharness: 2016-10-26 07:50:51.415382Z] Running clobber step. 00:50:51 INFO - Running pre-action listener: _resource_record_pre_action 00:50:51 INFO - Running main action method: clobber 00:50:51 INFO - rmtree: /builds/slave/test/build 00:50:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:50:53 INFO - Running post-action listener: _resource_record_post_action 00:50:53 INFO - [mozharness: 2016-10-26 07:50:53.186475Z] Finished clobber step (success) 00:50:53 INFO - [mozharness: 2016-10-26 07:50:53.186601Z] Running read-buildbot-config step. 00:50:53 INFO - Running pre-action listener: _resource_record_pre_action 00:50:53 INFO - Running main action method: read_buildbot_config 00:50:53 INFO - Using buildbot properties: 00:50:53 INFO - { 00:50:53 INFO - "project": "", 00:50:53 INFO - "product": "firefox", 00:50:53 INFO - "script_repo_revision": "production", 00:50:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 00:50:53 INFO - "repository": "", 00:50:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 00:50:53 INFO - "buildid": "20161025215823", 00:50:53 INFO - "pgo_build": "False", 00:50:53 INFO - "basedir": "/builds/slave/test", 00:50:53 INFO - "buildnumber": 13, 00:50:53 INFO - "slavename": "t-yosemite-r7-0346", 00:50:53 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 00:50:53 INFO - "platform": "yosemite_r7", 00:50:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 00:50:53 INFO - "branch": "mozilla-central", 00:50:53 INFO - "repo_path": "mozilla-central", 00:50:53 INFO - "revision": "9471b3c49b2ca02466a653de56ff3d4c32d79c38", 00:50:53 INFO - "stage_platform": "macosx64", 00:50:53 INFO - "builduid": "c7d7fab8923e46ac8cec43be056f1639", 00:50:53 INFO - "slavebuilddir": "test" 00:50:53 INFO - } 00:50:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 00:50:53 INFO - Running post-action listener: _resource_record_post_action 00:50:53 INFO - [mozharness: 2016-10-26 07:50:53.189835Z] Finished read-buildbot-config step (success) 00:50:53 INFO - [mozharness: 2016-10-26 07:50:53.189956Z] Running download-and-extract step. 00:50:53 INFO - Running pre-action listener: _resource_record_pre_action 00:50:53 INFO - Running main action method: download_and_extract 00:50:53 INFO - mkdir: /builds/slave/test/build/tests 00:50: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')]} 00:50:53 INFO - trying https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 00:50:53 INFO - Downloading https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/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 00:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/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 00:50:54 INFO - Downloaded 1199 bytes. 00:50:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:50:54 INFO - Using the following test package requirements: 00:50:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:50:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 00:50:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 00:50:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'jsshell-mac.zip'], 00:50:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 00:50:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:50:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 00:50:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 00:50:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 00:50:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:50:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 00:50:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:50:54 INFO - Http code: 200 00:50:54 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 00:50:54 INFO - x-amz-cf-id: b880RU1NpAdLhNQSbn53FVFbTaIB3nHDka1ieIa_l1J_4DKCbwRdzQ== 00:50:54 INFO - x-amz-version-id: BIRVzzM0CFJcXYofulLuHAGDXYypw.rm 00:50:55 INFO - Expected file size: 16423394 00:50:55 INFO - Obtained file size: 16423394 00:51:01 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 00:51:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:51:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:51:01 INFO - Fetch https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:51:02 INFO - Http code: 200 00:51:02 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 00:51:02 INFO - x-amz-cf-id: 5nzzBG8TPeLS7wBVcLDW6hefSH1jXsOtYTwVVbKHTfLHEA2F_LDpJA== 00:51:02 INFO - x-amz-version-id: BIRVzzM0CFJcXYofulLuHAGDXYypw.rm 00:51:02 INFO - Expected file size: 16423394 00:51:02 INFO - Obtained file size: 16423394 00:51:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:51:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:51:08 INFO - Fetch https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:51:09 INFO - Http code: 200 00:51:09 INFO - via: 1.1 30bb04916f91d64c600e15c15000042d.cloudfront.net (CloudFront) 00:51:09 INFO - x-amz-cf-id: SdG1JEH-9p38K-OXyWMZ_kCFKA4T-pTJzvUbJrG9QlM4snGsSNRzoQ== 00:51:09 INFO - x-amz-version-id: 3ibdlUCmjXGatKMD5yfsEMm2Gpnwakz0 00:51:09 INFO - Expected file size: 14409028 00:51:09 INFO - Obtained file size: 14409028 00:51: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')]} 00:51:09 INFO - trying https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/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 00:51:16 INFO - Downloaded 111253961 bytes. 00:51:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:51:16 INFO - mkdir: /builds/slave/test/properties 00:51:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:51:16 INFO - Writing to file /builds/slave/test/properties/build_url 00:51:16 INFO - Contents: 00:51:16 INFO - build_url:https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:51:17 INFO - Running post-action listener: _resource_record_post_action 00:51:17 INFO - Running post-action listener: set_extra_try_arguments 00:51:17 INFO - [mozharness: 2016-10-26 07:51:17.342579Z] Finished download-and-extract step (success) 00:51:17 INFO - [mozharness: 2016-10-26 07:51:17.342725Z] Running populate-webroot step. 00:51:17 INFO - Running pre-action listener: _resource_record_pre_action 00:51:17 INFO - Running main action method: populate_webroot 00:51:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:51:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:51:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:51:17 INFO - '--tppagecycles', 00:51:17 INFO - '7'], 00:51:17 INFO - 'tests': ['tsvgm']}}, 00:51:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:51:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:51:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:51:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:51:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['damp', 'tps']}, 00:51:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'tests': ['damp', 'tps']}, 00:51:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['dromaeo_dom']}, 00:51:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:51:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['basic_compositor_video']}, 00:51:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:51:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['a11yr', 00:51:17 INFO - 'ts_paint', 00:51:17 INFO - 'tpaint', 00:51:17 INFO - 'sessionrestore', 00:51:17 INFO - 'sessionrestore_no_auto_restore', 00:51:17 INFO - 'tabpaint']}, 00:51:17 INFO - 'other-e10s': {'tests': ['a11yr', 00:51:17 INFO - 'ts_paint', 00:51:17 INFO - 'tpaint', 00:51:17 INFO - 'sessionrestore', 00:51:17 INFO - 'sessionrestore_no_auto_restore', 00:51:17 INFO - 'tabpaint']}, 00:51:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:51:17 INFO - 'ts_paint', 00:51:17 INFO - 'tpaint', 00:51:17 INFO - 'sessionrestore', 00:51:17 INFO - 'sessionrestore_no_auto_restore', 00:51:17 INFO - 'tabpaint']}, 00:51:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:51:17 INFO - 'ts_paint', 00:51:17 INFO - 'tpaint', 00:51:17 INFO - 'sessionrestore', 00:51:17 INFO - 'sessionrestore_no_auto_restore', 00:51:17 INFO - 'tabpaint']}, 00:51:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['a11yr', 00:51:17 INFO - 'ts_paint', 00:51:17 INFO - 'tpaint', 00:51:17 INFO - 'sessionrestore', 00:51:17 INFO - 'sessionrestore_no_auto_restore', 00:51:17 INFO - 'tabpaint']}, 00:51:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['a11yr', 00:51:17 INFO - 'ts_paint', 00:51:17 INFO - 'tpaint', 00:51:17 INFO - 'sessionrestore', 00:51:17 INFO - 'sessionrestore_no_auto_restore', 00:51:17 INFO - 'tabpaint']}, 00:51:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['tsvgx', 00:51:17 INFO - 'tsvgr_opacity', 00:51:17 INFO - 'tart', 00:51:17 INFO - 'tscrollx', 00:51:17 INFO - 'cart']}, 00:51:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:51:17 INFO - 'tsvgr_opacity', 00:51:17 INFO - 'tart', 00:51:17 INFO - 'tscrollx', 00:51:17 INFO - 'cart']}, 00:51:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'talos_options': ['--disable-e10s'], 00:51:17 INFO - 'tests': ['tp5o']}, 00:51:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'tests': ['tp5o']}, 00:51:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'talos_options': ['--disable-e10s', 00:51:17 INFO - '--xperf_path', 00:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:17 INFO - 'tests': ['tp5n']}, 00:51:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:17 INFO - 'talos_options': ['--xperf_path', 00:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:17 INFO - 'tests': ['tp5n']}}, 00:51:17 INFO - 'talos.zip': {'path': '', 00:51:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:51:17 INFO - Running post-action listener: _resource_record_post_action 00:51:17 INFO - [mozharness: 2016-10-26 07:51:17.361186Z] Finished populate-webroot step (success) 00:51:17 INFO - [mozharness: 2016-10-26 07:51:17.361296Z] Running create-virtualenv step. 00:51:17 INFO - Running pre-action listener: _resource_record_pre_action 00:51:17 INFO - Running main action method: create_virtualenv 00:51:17 INFO - Creating virtualenv /builds/slave/test/build/venv 00:51:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:51:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:51:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:51:17 INFO - Using real prefix '/tools/python27' 00:51:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:51:18 INFO - Installing distribute.............................................................................................................................................................................................done. 00:51:21 INFO - Installing pip.................done. 00:51:21 INFO - Return code: 0 00:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:51:21 INFO - Reading from file tmpfile_stdout 00:51:21 INFO - Output received: 00:51:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:51:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:21 INFO - 'HOME': '/Users/cltbld', 00:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:21 INFO - 'LOGNAME': 'cltbld', 00:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:21 INFO - 'MOZ_NO_REMOTE': '1', 00:51:21 INFO - 'NO_EM_RESTART': '1', 00:51:21 INFO - 'PAGER': '/bin/cat', 00:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:21 INFO - 'PWD': '/builds/slave/test', 00:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:21 INFO - 'SHELL': '/bin/bash', 00:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:21 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:21 INFO - 'USER': 'cltbld', 00:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:21 INFO - 'XPC_FLAGS': '0x0', 00:51:21 INFO - 'XPC_SERVICE_NAME': '0', 00:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:51:21 INFO - Cleaning up... 00:51:21 INFO - Return code: 0 00:51:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:21 INFO - 'HOME': '/Users/cltbld', 00:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:21 INFO - 'LOGNAME': 'cltbld', 00:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:21 INFO - 'MOZ_NO_REMOTE': '1', 00:51:21 INFO - 'NO_EM_RESTART': '1', 00:51:21 INFO - 'PAGER': '/bin/cat', 00:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:21 INFO - 'PWD': '/builds/slave/test', 00:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:21 INFO - 'SHELL': '/bin/bash', 00:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:21 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:21 INFO - 'USER': 'cltbld', 00:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:21 INFO - 'XPC_FLAGS': '0x0', 00:51:21 INFO - 'XPC_SERVICE_NAME': '0', 00:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:21 INFO - Downloading/unpacking psutil>=3.1.1 00:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:25 INFO - Installing collected packages: psutil 00:51:25 INFO - Running setup.py install for psutil 00:51:26 INFO - building 'psutil._psutil_osx' extension 00:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 00:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 00:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 00:51:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 00:51:26 INFO - building 'psutil._psutil_posix' extension 00:51:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 00:51:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:51:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:51:26 INFO - ^ 00:51:26 INFO - 1 warning generated. 00:51:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 00:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:26 INFO - Successfully installed psutil 00:51:26 INFO - Cleaning up... 00:51:26 INFO - Return code: 0 00:51:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:26 INFO - 'HOME': '/Users/cltbld', 00:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:26 INFO - 'LOGNAME': 'cltbld', 00:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:26 INFO - 'MOZ_NO_REMOTE': '1', 00:51:26 INFO - 'NO_EM_RESTART': '1', 00:51:26 INFO - 'PAGER': '/bin/cat', 00:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:26 INFO - 'PWD': '/builds/slave/test', 00:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:26 INFO - 'SHELL': '/bin/bash', 00:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:26 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:26 INFO - 'USER': 'cltbld', 00:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:26 INFO - 'XPC_FLAGS': '0x0', 00:51:26 INFO - 'XPC_SERVICE_NAME': '0', 00:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:51:29 INFO - Installing collected packages: mozsystemmonitor 00:51:29 INFO - Running setup.py install for mozsystemmonitor 00:51:29 INFO - Successfully installed mozsystemmonitor 00:51:29 INFO - Cleaning up... 00:51:29 INFO - Return code: 0 00:51:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:29 INFO - 'HOME': '/Users/cltbld', 00:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:29 INFO - 'LOGNAME': 'cltbld', 00:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:29 INFO - 'MOZ_NO_REMOTE': '1', 00:51:29 INFO - 'NO_EM_RESTART': '1', 00:51:29 INFO - 'PAGER': '/bin/cat', 00:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:29 INFO - 'PWD': '/builds/slave/test', 00:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:29 INFO - 'SHELL': '/bin/bash', 00:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:29 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:29 INFO - 'USER': 'cltbld', 00:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:29 INFO - 'XPC_FLAGS': '0x0', 00:51:29 INFO - 'XPC_SERVICE_NAME': '0', 00:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:30 INFO - Downloading/unpacking jsonschema==2.5.1 00:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:51:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:51:32 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 00:51:32 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 00:51:32 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 00:51:32 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 00:51:32 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 00:51:32 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 00:51:32 INFO - Downloading functools32-3.2.3-2.tar.gz 00:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:51:33 INFO - warning: no files found matching '*.txt' 00:51:33 INFO - no previously-included directories found matching 'build' 00:51:33 INFO - no previously-included directories found matching 'dist' 00:51:33 INFO - no previously-included directories found matching '.git*' 00:51:33 INFO - Installing collected packages: jsonschema, functools32 00:51:33 INFO - Running setup.py install for functools32 00:51:33 INFO - warning: no files found matching '*.txt' 00:51:33 INFO - no previously-included directories found matching 'build' 00:51:33 INFO - no previously-included directories found matching 'dist' 00:51:33 INFO - no previously-included directories found matching '.git*' 00:51:33 INFO - Successfully installed jsonschema functools32 00:51:33 INFO - Cleaning up... 00:51:33 INFO - Return code: 0 00:51:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:51:33 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')]} 00:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:33 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')]} 00:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:33 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 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:33 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 00:51:33 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 00:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:33 INFO - 'HOME': '/Users/cltbld', 00:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:33 INFO - 'LOGNAME': 'cltbld', 00:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:33 INFO - 'MOZ_NO_REMOTE': '1', 00:51:33 INFO - 'NO_EM_RESTART': '1', 00:51:33 INFO - 'PAGER': '/bin/cat', 00:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:33 INFO - 'PWD': '/builds/slave/test', 00:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:33 INFO - 'SHELL': '/bin/bash', 00:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:33 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:33 INFO - 'USER': 'cltbld', 00:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:33 INFO - 'XPC_FLAGS': '0x0', 00:51:33 INFO - 'XPC_SERVICE_NAME': '0', 00:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:51:33 INFO - Cleaning up... 00:51:33 INFO - Return code: 0 00:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:51:33 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')]} 00:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:33 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')]} 00:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:33 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 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:33 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 00:51:33 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 00:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:33 INFO - 'HOME': '/Users/cltbld', 00:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:33 INFO - 'LOGNAME': 'cltbld', 00:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:33 INFO - 'MOZ_NO_REMOTE': '1', 00:51:33 INFO - 'NO_EM_RESTART': '1', 00:51:33 INFO - 'PAGER': '/bin/cat', 00:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:33 INFO - 'PWD': '/builds/slave/test', 00:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:33 INFO - 'SHELL': '/bin/bash', 00:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:33 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:33 INFO - 'USER': 'cltbld', 00:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:33 INFO - 'XPC_FLAGS': '0x0', 00:51:33 INFO - 'XPC_SERVICE_NAME': '0', 00:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:33 INFO - Downloading/unpacking blobuploader==1.2.4 00:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 00:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:51:36 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 00:51:36 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 00:51:36 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 00:51:36 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 00:51:36 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 00:51:36 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 00:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:51:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:51:37 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 00:51:37 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 00:51:37 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 00:51:37 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 00:51:37 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 00:51:37 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 00:51:37 INFO - Downloading docopt-0.6.1.tar.gz 00:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:51:37 INFO - Installing collected packages: blobuploader, requests, docopt 00:51:37 INFO - Running setup.py install for blobuploader 00:51:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:51:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:51:37 INFO - Running setup.py install for requests 00:51:38 INFO - Running setup.py install for docopt 00:51:38 INFO - Successfully installed blobuploader requests docopt 00:51:38 INFO - Cleaning up... 00:51:38 INFO - Return code: 0 00:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:38 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 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:38 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 00:51:38 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 00:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:38 INFO - 'HOME': '/Users/cltbld', 00:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:38 INFO - 'LOGNAME': 'cltbld', 00:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:38 INFO - 'MOZ_NO_REMOTE': '1', 00:51:38 INFO - 'NO_EM_RESTART': '1', 00:51:38 INFO - 'PAGER': '/bin/cat', 00:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:38 INFO - 'PWD': '/builds/slave/test', 00:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:38 INFO - 'SHELL': '/bin/bash', 00:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:38 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:38 INFO - 'USER': 'cltbld', 00:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:38 INFO - 'XPC_FLAGS': '0x0', 00:51:38 INFO - 'XPC_SERVICE_NAME': '0', 00:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:51:38 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-AmTBvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:51:38 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-AdEEN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:51:38 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-81xIqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-LeHJ36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-nROn7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-ZVPlGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-e1J21r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-bWJxNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-NdUYgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-6D0Jrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-PMuGVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:51:39 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-knCkIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:51:40 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-EaCMDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:51:40 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-tfxzHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:40 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-EeP7OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:51:40 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-sDaxJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:51:40 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-XUw0H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:51:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:51:40 INFO - Running setup.py install for manifestparser 00:51:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:51:40 INFO - Running setup.py install for mozcrash 00:51:40 INFO - Running setup.py install for mozdebug 00:51:40 INFO - Running setup.py install for mozdevice 00:51:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Running setup.py install for mozfile 00:51:41 INFO - Running setup.py install for mozhttpd 00:51:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Running setup.py install for mozinfo 00:51:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Running setup.py install for mozInstall 00:51:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:51:41 INFO - Running setup.py install for mozleak 00:51:41 INFO - Running setup.py install for mozlog 00:51:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:51:42 INFO - Running setup.py install for moznetwork 00:51:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:51:42 INFO - Running setup.py install for mozprocess 00:51:42 INFO - Running setup.py install for mozprofile 00:51:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:51:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:51:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:51:42 INFO - Running setup.py install for mozrunner 00:51:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:51:42 INFO - Running setup.py install for mozscreenshot 00:51:42 INFO - Running setup.py install for moztest 00:51:43 INFO - Running setup.py install for mozversion 00:51:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:51:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:51:43 INFO - Cleaning up... 00:51:43 INFO - Return code: 0 00:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:43 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 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:43 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 00:51:43 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 00:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:43 INFO - 'HOME': '/Users/cltbld', 00:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:43 INFO - 'LOGNAME': 'cltbld', 00:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:43 INFO - 'MOZ_NO_REMOTE': '1', 00:51:43 INFO - 'NO_EM_RESTART': '1', 00:51:43 INFO - 'PAGER': '/bin/cat', 00:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:43 INFO - 'PWD': '/builds/slave/test', 00:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:43 INFO - 'SHELL': '/bin/bash', 00:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:43 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:43 INFO - 'USER': 'cltbld', 00:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:43 INFO - 'XPC_FLAGS': '0x0', 00:51:43 INFO - 'XPC_SERVICE_NAME': '0', 00:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:51:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Lef8Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:51:43 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)) 00:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:51:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-iDv8EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:51:43 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)) 00:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:51:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-36fKdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:51:43 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)) 00:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:51:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Flwtc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:51:43 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)) 00:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:51:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Dhusb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:51:43 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)) 00:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:51:43 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-eHhzc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-SUC3Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-cvWkWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-URN7YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-PA58oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-2ti8DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-1zZiVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-DmPriK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-DBXWH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:51:44 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)) 00:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:44 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Y1fLwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:45 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)) 00:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:51:45 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-yYlhuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:51:45 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)) 00:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:51:45 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-hv6roZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:51:45 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)) 00:51:45 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)) 00:51:45 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)) 00:51:45 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)) 00:51:45 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)) 00:51:45 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)) 00:51:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:51:45 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 00:51:45 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 00:51:45 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 00:51:45 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 00:51:45 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 00:51:45 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 00:51:47 INFO - Downloading blessings-1.6.tar.gz 00:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:51:47 INFO - Installing collected packages: blessings 00:51:47 INFO - Running setup.py install for blessings 00:51:48 INFO - Successfully installed blessings 00:51:48 INFO - Cleaning up... 00:51:48 INFO - Return code: 0 00:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:51:48 INFO - Reading from file tmpfile_stdout 00:51:48 INFO - Current package versions: 00:51:48 INFO - blessings == 1.6 00:51:48 INFO - blobuploader == 1.2.4 00:51:48 INFO - docopt == 0.6.1 00:51:48 INFO - functools32 == 3.2.3-2 00:51:48 INFO - jsonschema == 2.5.1 00:51:48 INFO - manifestparser == 1.1 00:51:48 INFO - mozInstall == 1.12 00:51:48 INFO - mozcrash == 0.17 00:51:48 INFO - mozdebug == 0.1 00:51:48 INFO - mozdevice == 0.48 00:51:48 INFO - mozfile == 1.2 00:51:48 INFO - mozhttpd == 0.7 00:51:48 INFO - mozinfo == 0.9 00:51:48 INFO - mozleak == 0.1 00:51:48 INFO - mozlog == 3.4 00:51:48 INFO - moznetwork == 0.27 00:51:48 INFO - mozprocess == 0.23 00:51:48 INFO - mozprofile == 0.28 00:51:48 INFO - mozrunner == 6.12 00:51:48 INFO - mozscreenshot == 0.1 00:51:48 INFO - mozsystemmonitor == 0.3 00:51:48 INFO - moztest == 0.7 00:51:48 INFO - mozversion == 1.4 00:51:48 INFO - psutil == 3.1.1 00:51:48 INFO - requests == 1.2.3 00:51:48 INFO - wsgiref == 0.1.2 00:51:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51:48 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')]} 00:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:48 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')]} 00:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:48 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 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:48 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 00:51:48 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 00:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:48 INFO - 'HOME': '/Users/cltbld', 00:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:48 INFO - 'LOGNAME': 'cltbld', 00:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:48 INFO - 'MOZ_NO_REMOTE': '1', 00:51:48 INFO - 'NO_EM_RESTART': '1', 00:51:48 INFO - 'PAGER': '/bin/cat', 00:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:48 INFO - 'PWD': '/builds/slave/test', 00:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:48 INFO - 'SHELL': '/bin/bash', 00:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:48 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:48 INFO - 'USER': 'cltbld', 00:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:48 INFO - 'XPC_FLAGS': '0x0', 00:51:48 INFO - 'XPC_SERVICE_NAME': '0', 00:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 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)) 00:51:48 INFO - Cleaning up... 00:51:48 INFO - Return code: 0 00:51:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:51:48 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')]} 00:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:48 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')]} 00:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:48 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 0x105724490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10569a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd80d9da00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, '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.5uNaK3m108/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.AAil1shxRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 00:51:48 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 00:51:48 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 00:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:51:48 INFO - 'HOME': '/Users/cltbld', 00:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:51:48 INFO - 'LOGNAME': 'cltbld', 00:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:48 INFO - 'MOZ_NO_REMOTE': '1', 00:51:48 INFO - 'NO_EM_RESTART': '1', 00:51:48 INFO - 'PAGER': '/bin/cat', 00:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:48 INFO - 'PWD': '/builds/slave/test', 00:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:51:48 INFO - 'SHELL': '/bin/bash', 00:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:51:48 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:51:48 INFO - 'USER': 'cltbld', 00:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:48 INFO - 'XPC_FLAGS': '0x0', 00:51:48 INFO - 'XPC_SERVICE_NAME': '0', 00:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:51:48 INFO - Cleaning up... 00:51:48 INFO - Return code: 0 00:51:48 INFO - Running post-action listener: _resource_record_post_action 00:51:48 INFO - Running post-action listener: _start_resource_monitoring 00:51:48 INFO - Starting resource monitoring. 00:51:48 INFO - [mozharness: 2016-10-26 07:51:48.971099Z] Finished create-virtualenv step (success) 00:51:48 INFO - [mozharness: 2016-10-26 07:51:48.972123Z] Running install step. 00:51:48 INFO - Running pre-action listener: _resource_record_pre_action 00:51:48 INFO - Running main action method: install 00:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:51:49 INFO - Reading from file tmpfile_stdout 00:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 00:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:51:49 INFO - Reading from file tmpfile_stdout 00:51:49 INFO - Output received: 00:51:49 INFO - Usage: mozinstall [options] installer 00:51:49 INFO - Options: 00:51:49 INFO - -h, --help show this help message and exit 00:51:49 INFO - -d DEST, --destination=DEST 00:51:49 INFO - Directory to install application into. [default: 00:51:49 INFO - "/builds/slave/test"] 00:51:49 INFO - --app=APP Application being installed. [default: firefox] 00:51:49 INFO - mkdir: /builds/slave/test/build/application 00:51:49 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'] 00:51:49 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 00:52:23 INFO - Reading from file tmpfile_stdout 00:52:23 INFO - Output received: 00:52:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:52:23 INFO - Running post-action listener: _resource_record_post_action 00:52:23 INFO - [mozharness: 2016-10-26 07:52:23.729703Z] Finished install step (success) 00:52:23 INFO - [mozharness: 2016-10-26 07:52:23.729836Z] Running run-tests step. 00:52:23 INFO - Running pre-action listener: _resource_record_pre_action 00:52:23 INFO - Running main action method: run_tests 00:52:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:52:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:52:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:52:23 INFO - 2016-10-26 00:52:23.744 screenresolution[2232:22815] starting screenresolution argv=screenresolution get 00:52:23 INFO - 2016-10-26 00:52:23.747 screenresolution[2232:22815] Display 0: 1600x1200x32@60 00:52:23 INFO - 2016-10-26 00:52:23.753 screenresolution[2233:22817] starting screenresolution argv=screenresolution list 00:52:23 INFO - Available Modes on Display 0 00:52:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:52:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:52:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:52:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:52:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:52:23 INFO - Intel Iris: 00:52:23 INFO - Chipset Model: Intel Iris 00:52:23 INFO - Type: GPU 00:52:23 INFO - Bus: Built-In 00:52:23 INFO - VRAM (Dynamic, Max): 1536 MB 00:52:23 INFO - Vendor: Intel (0x8086) 00:52:23 INFO - Device ID: 0x0a2e 00:52:23 INFO - Revision ID: 0x0009 00:52:23 INFO - Displays: 00:52:23 INFO - Display: 00:52:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:52:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:52:23 INFO - Display Serial Number: 1600x1200 60 00:52:23 INFO - Main Display: Yes 00:52:23 INFO - Mirror: Off 00:52:23 INFO - Online: Yes 00:52:23 INFO - Rotation: Supported 00:52:23 INFO - Return code: 0 00:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:52:23 INFO - Python 2.7.3 00:52:23 INFO - Return code: 0 00:52:23 INFO - grabbing minidump binary from tooltool 00:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:52:23 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 0x105538d30>, '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 0x10535edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105530b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:52:23 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 00:52:23 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 00:52:23 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 00:52:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:52:24 INFO - Return code: 0 00:52:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:52:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:52:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:52:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:52:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:52:24 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/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 00:52:24 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/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0346 --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 00:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5uNaK3m108/Render', 00:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:52:24 INFO - 'HOME': '/Users/cltbld', 00:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:52:24 INFO - 'LOGNAME': 'cltbld', 00:52:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:52:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:24 INFO - 'MOZ_NO_REMOTE': '1', 00:52:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:52:24 INFO - 'NO_EM_RESTART': '1', 00:52:24 INFO - 'PAGER': '/bin/cat', 00:52:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:24 INFO - 'PWD': '/builds/slave/test', 00:52:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:52:24 INFO - 'SHELL': '/bin/bash', 00:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AAil1shxRY/Listeners', 00:52:24 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 00:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:52:24 INFO - 'USER': 'cltbld', 00:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:24 INFO - 'XPC_FLAGS': '0x0', 00:52:24 INFO - 'XPC_SERVICE_NAME': '0', 00:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:52:24 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/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 00:52:24 INFO - mozversion application_buildid: 20161025215823 00:52:24 INFO - mozversion application_changeset: 9471b3c49b2ca02466a653de56ff3d4c32d79c38 00:52:24 INFO - mozversion application_display_name: Nightly 00:52:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:52:24 INFO - mozversion application_name: Firefox 00:52:24 INFO - mozversion application_remotingname: firefox 00:52:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:52:24 INFO - mozversion application_vendor: Mozilla 00:52:24 INFO - mozversion application_version: 52.0a1 00:52:24 INFO - mozversion platform_buildid: 20161025215823 00:52:24 INFO - mozversion platform_changeset: 9471b3c49b2ca02466a653de56ff3d4c32d79c38 00:52:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:52:24 INFO - mozversion platform_version: 52.0a1 00:52:24 INFO - using testdate: 1477468344 00:52:24 INFO - actual date: 1477468344 00:52:24 INFO - starting webserver on 'localhost:53843' 00:52:24 INFO - SUITE-START | Running 2 tests 00:52:24 INFO - TEST-START | dromaeo_css 00:52:24 INFO - operating with platform_type : mac_ 00:52:24 INFO - Initialising browser for dromaeo_css test... 00:52:24 INFO - TEST-INFO | started process 2243 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpKNXGbJ/profile http://localhost:53843/getInfo.html) 00:52:26 INFO - PROCESS | 2243 | __metrics Screen width/height:1600/1200 00:52:26 INFO - PROCESS | 2243 | colorDepth:24 00:52:26 INFO - PROCESS | 2243 | Browser inner width/height: 1024/689 00:52:26 INFO - PROCESS | 2243 | __metrics 00:52:26 INFO - PROCESS | 2243 | 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" 00:52:26 INFO - PROCESS | 2243 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:52:27 INFO - TEST-INFO | 2243: exit 0 00:52:27 INFO - Browser initialized. 00:52:27 INFO - Running cycle 1/1 for dromaeo_css test... 00:52:27 INFO - TEST-INFO | started process 2245 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpKNXGbJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:52:39 INFO - PROCESS | 2245 | RSS: Main: 230146048 00:52:39 INFO - PROCESS | 2245 | 00:53:30 INFO - PROCESS | 2245 | 1477468410835 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] 00:55:43 INFO - PROCESS | 2245 | Cycle 1(1): loaded http://localhost:53843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53843/tests/dromaeo/cssquery-ext.html) 00:55:46 INFO - PROCESS | 2245 | RSS: Main: 425906176 00:55:46 INFO - PROCESS | 2245 | 00:58:49 INFO - PROCESS | 2245 | Cycle 1(1): loaded http://localhost:53843/tests/dromaeo/cssquery-ext.html (next: http://localhost:53843/tests/dromaeo/cssquery-jquery.html) 00:58:49 INFO - PROCESS | 2245 | RSS: Main: 381812736 00:58:49 INFO - PROCESS | 2245 | 01:01:52 INFO - PROCESS | 2245 | Cycle 1(1): loaded http://localhost:53843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53843/tests/dromaeo/cssquery-mootools.html) 01:01:52 INFO - PROCESS | 2245 | RSS: Main: 338583552 01:01:52 INFO - PROCESS | 2245 | 01:04:55 INFO - PROCESS | 2245 | Cycle 1(1): loaded http://localhost:53843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53843/tests/dromaeo/cssquery-prototype.html) 01:04:55 INFO - PROCESS | 2245 | RSS: Main: 338624512 01:04:55 INFO - PROCESS | 2245 | 01:07:59 INFO - PROCESS | 2245 | Cycle 1(1): loaded http://localhost:53843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53843/tests/dromaeo/cssquery-yui.html) 01:07:59 INFO - PROCESS | 2245 | RSS: Main: 325857280 01:07:59 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | Cycle 1(1): loaded http://localhost:53843/tests/dromaeo/cssquery-yui.html (next: http://localhost:53843/tests/dromaeo/cssquery-dojo.html) 01:11:03 INFO - PROCESS | 2245 | RSS: Main: 623169536 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | __start_tp_report 01:11:03 INFO - PROCESS | 2245 | _x_x_mozilla_page_load 01:11:03 INFO - PROCESS | 2245 | _x_x_mozilla_page_load_details 01:11:03 INFO - PROCESS | 2245 | |i|pagename|runs| 01:11:03 INFO - PROCESS | 2245 | |0;dojo.html;3291.226561757987;3292.3086151908115;3294.5222942673304;3346;3358.4290670585997;5502.174673798932;5612.494875461212;5639.069553523669;5642.746076426561;5652.123920792284;5602.1596760485945;5651.40660230676;5723.771049158039;5736.340320863092;5776.277965254343;5055.090083784918;5099.770510327045;5122.948770512303;5156.613254005946;5174.301469301634;5246.68519888806;5278.853118209753;5280.867978300535;5284.603654725892;5287.444818294081;4578.244589642705;5060.721660308682;5221.347331583552;5241.502057304588;5317.787288508455;5126.897462050738;5134.358205224347;5169.663971841818;5172.405173405069;5212.843614691527;5143.717095559743;5182.818601348972;5188.299579556787;5200.037992971313;5233.921491177635;5658.547316214693;5699.202111704365;5709.543236541067;5713.514351280104;5722.885542289131;6096.573239873211;6121.757501469892;6123.740204357149;6123.953766440822;6211.068339749028;6209.099680546341;6211.9068213976825;6241.157443745082;6247.937520624781;6255.781047663356;5784.913226301609;5792.739326730307;5796.217510636095;5813.912791308134;5845.620034697731;6153.815385538441;6165.475934545524;6220.440160385587;6223.937760622426;6228.283747369111;6055.2430946131735;6090.208272924491;6104.368208815833;6124.899720463051;6171.9691401542705;6232.626042437469;6238.438540531283;6238.719257633417;6245.906311405332;6263.091851681481;6158.969205153946;6208.596441231396;6219.626822390671;6225.937740622627;6243.032329988859;6097.451229389376;6122.794608434074;6137.131844484766;6139.829471381323;6175.197224360804;4925.852224433273;4935.3090567320605;4945.67853089548;4956.033573453142;4990.575801056951;4397.714148580332;4439.933400998988;4445.844395446144;4449;4493.236149854532;5559.777608895599;5692.260006199168;5699.5155411790465;5795.275590551181;5827.621204621686;6170.845728856725;6183.350748171377;6209.937900620936;6233.1273621693;6261.186045814015;5776.075827867521;5779.479846813723;5788.507976822018;5796.3913789052385;5820.534357251409;5409.161579955114;5409.377921538995;5430.185472179205;5431.321084864392;5435.211894275308;6115.179495343508;6159.753609855556;6173.32093469727;6234.2830574484515;6246;6239.1577137085915;6268.811935641938;6273.74905003813;6281.874362512815;6287.96856015717;6222.408871157414;6232.158658581034;6252.374762523711;6253.37466253371;6258.687065646791;6028.306744724413;6089.634621922699;6103.5195042504665;6115.4190351916495;6188.288346840171;6162.014077747539;6258.906116408349;6268.623882567061;6271.843203919939;6278.4035516625845;6094.634321940521;6141.1402403664415;6147.600405973776;6147.66187859672;6162;5937.168796368425;5991.910121348096;6068.8786224276155;6096.817095487142;6117.418845209698;5880.353161152356;5904.143899134688;5912.054071348563;6006.099085137264;6073.483753880793;6133.539984501091;6143.017117261216;6152.0156774915795;6166.414190651881;6174.38256174379;5774.04728219839;5776.826695199151;5822.650640961556;5826.70866456684;5891.086881533369 01:11:03 INFO - PROCESS | 2245 | |1;ext.html;456.0127324342798;461.8314315274924;483.5285596543371;491.0400167672201;508.26301862299675;24169.75830241699;39523;40410.39384409232;40528.59471405285;42484.36273455893;41523.58476415235;41915.79042104785;41947;41975;42168.15663686724;8566.143385661446;9412.90587094129;9565.234781217487;9577.473238971854;9582.568784404684;8595.95702021489;11430.5427782889;11751.236169648946;11751.412429378539;11774.882251177463;11566.59516916908;11655.417229138551;11677.70805729855;11682.065434765198;11759.11806614503;8671.739847804576;8869.246114080312;11633.36016519091;11673.007794337535;11715.238509496856;8683.392162548624;8752.8687069694;8774.868376974351;11224.326540407601;11572.784857589915;39844.60155398438;40270.19459610821;40302.798486007385;40303.59696403028;40363.798181008904;3307.371599396107;3430.691237788611;3475.739319551044;3636.581793093775;3947.2894878921784;28022.859885700644;29778.255543611365;30164.84917575398;30351.696483035106;30798.076057718303;3161.65221825599;3164.367126574671;3199.3281410903737;3285.342931413703;3290.6380298167182;425744;489221;490155;490893.54553227365;492614;57282.427175728546;57716.71141644349;57795.422045779844;57824.42175578191;57877.42122578804;59801.401985980454;59858.70070649619;59897.40102598918;59999;60025.79948401007;14989.175595342362;15529.145896975775;15548.455804046804;15555.922220389051;15558.455454059054;10864.185186111074;11038.613648522263;11056.502457389437;12071.517139314328;12192.963598094084;12995.350232488527;13686.52097176594;13715.794263085862;14810.407583696748;15229.695406092038;5073.695578265242;5268.841934741964;6284.905726414107;6297.874042519124;6308.27454842699;760.3423039071164;990.9950450247846;997.3567049253336;1012.4380968562372;1022.4121130350078;29456;29492.705072948997;29779.553306700418;30379.392412151632;30524.69475305263;1007.4056306779036;1053.7892421515728;1063.292910214714;1087.141158484804;1164.6098556983504;14680.706385872223;15167.924160379127;15235.542933712006;15448.459303924308;15585.376584936475;600101;601840;602088;604264;605496.9725151346;55577.722111389994;55807.16289255665;55861.882762344525;55884;56056.71971640116;1333.7199188170594;1368.1996032321006;1380.378829526697;1385.4873696732072;1385.515069725608;29115.41769164647;29154.854225728737;29506;29865.25336866596;30017.249568760082;47874.521254787;48017.75991120022;48082;48093.75953120212;48118;499725;503322;503384;504272;504675;37693.62306376901;38731.03172420712;38836;39062.6093739059;39155.476007159494;34753;46114.538854612365;46117;46606;46650;34912.30175396529;34983.300333993684;36822.26355472822;38530.80734596309;38752;36883.63116368909;37075;37785.433218502294;38188.618113818506;38974.4153837687;37167.44248836324;37255.6960506381;37501.43747843839;38098.80950595229;38222.853314400614;30752.69247307498;32529.02412927616;33540.1614959628;33610.49584256189;33611;24513.264602061965;24692.38269043288;24767.62848557237;24865.62701559442;24954.37614059663 01:11:03 INFO - PROCESS | 2245 | |2;jquery.html;338.95763029621287;351.47279081377934;371.0871256708497;375.6975634614136;395.4108378516012;14785.482508112218;15010.549683509498;15928.761068583952;20247.86158145486;20707.689384659203;19868.50328741782;20076.899615501938;21149;21150.365489035354;21491.892540537316;5541.141123125902;5754.108113242443;6060.181875446802;6064.332923378425;6075.0887366895095;5575.8884822303735;5991.610545314563;6042.607230530023;6048.485878700316;6054.334023257438;5644.153376993443;5888.146218798272;5982.102684597302;5986.191864098357;6012.158297838306;5775.509081728058;5818.44724751148;5842.415758424145;5910.615809972381;5914.674692891889;4887.095887260833;5085.059264036166;5140.922886156711;5145.30538377318;5154.587632989389;24234.909429075735;24716.382090447703;25336.493270134677;25924.092656756922;25930.481390372086;2130.7017017617545;2203.504211552404;2282.109977108929;2464.8538429630307;2805.849601663308;9973.850392244121;10076.193904487624;10208.285420020602;10285.623311558811;10439.217058720626;1734.3887598075614;1764.214924358661;1810.6559753646766;1854.0729635182408;1866.962660746791;89567;105622.4156637651;111956;112485.31272030926;113031;10325.535350909227;10444;11289;11486.446408446434;11703.356315402565;14572.781408278672;14696.632584185481;14721.19033453149;14728.263586820616;14743.11541307525;8201.179882011751;8355.201007662501;8422.115677853737;8537.615807288686;8557.78605534854;8206.671733130608;8233.304989222608;8296.962879640045;8463.830723385621;8498.70254541088;4473.239549276631;4538.160440318552;4541.500434952152;4636.35091087248;4647;1881;1916.549610841451;1922.528980399811;1926.8362189213794;1974.0721860725437;382.7378245901566;389.3614472265487;426.85273580615257;833.6623667414707;900.1088921967205;9205.76985575366;11381.203315767982;11562.07503399726;11908.880911190778;12279.93860030712;429.9398084268205;435.7886425083832;443.17126972561516;833.4078334376281;897.4615230861561;8791.648334066565;10758.946205268923;11163;11198.440077996067;11249.550017999189;585050.0747496235;592218;596516;606778;607591;123027.38486307512;125093;125925;127768.44463110686;127903;988.1699372527112;1010.9039641234071;1024.4621573673733;1027.50679673757;1028.7428142964259;18035.81964180394;18688.626227475102;18767.967761773234;18775.061246937872;18784.812151878854;49765.751171243915;49890;50400.49599504105;52483.73758131185;53356.729706895494;73062.63468682622;82753;84283.73574396266;84478;84913;7700.383969282332;7898.407619428451;7953.244441778022;8094.554799486084;8147.226013528705;9443.338966272295;11997.880021199677;12354.196977196454;12620.810687839506;12650.683732906751;10364.740881478023;10502.52738626779;11066.059384952368;11086.334819910831;11186;8710.651573936972;9225.49259790691;10483.895161048293;10628.681139565826;10877.728056798644;10275.7431064224;11366.772664546497;11413.429328533706;11562.595309164139;11663.941680291544;8128.715494957648;8170.223828736261;8256.422050456651;8276.793080173044;8323.292520135614;9613.90386096158;10820.56717731282;11301.660950171508;11348.375839328915;11457.427128643702 01:11:03 INFO - PROCESS | 2245 | |3;mootools.html;1340.9262490563015;1525.0392252880683;1562.343815597449;1795.578039160797;1960.392278393698;7671.271229233221;8147.633356498957;8380.329573634102;8690.087540808203;8721.476711397321;8483.406161568693;8708.477491350508;8709.172628600272;8717.607707653155;8728.519931403785;2320.7447180810095;2358.6344116661944;2363.515479326734;2364.8462849914786;2366.3965688749345;2309.3764683535437;2358.433975845793;2367.242482405631;2367.2898130560848;2373.1456675596773;2323.500447403808;2348.3189874936247;2361.3152185866165;2361.3978435498925;2366.1127077345996;2307.1348244408346;2342.3090188394294;2343.6484527320868;2343.95312093758;2358.5636657218297;2324.93025209244;2330.196082351586;2331.7318508371413;2334.0780391745334;2350.471143992605;8492.702755403592;8524.74425767228;8693.826123477558;8714.25928796053;8729.825403491895;4724.527547245282;5180.922286165711;5253.0544501989625;5293.258943747878;5385.649932754359;3435.7594968352223;3556.6621170988715;3596;3600.0999750062483;3611.422172452395;1029.6602121299952;1033.405791669793;1033.7622346860264;1042.5412818359973;1070.619929924881;11238.831417528743;11364.545418183345;11467.08263338931;11468;11475.770484590344;4555.908881822345;4636.884077898079;4755.120302744003;4758.524147585283;4763.309320148559;9715.902840971641;9875;9922.454265015493;9939.254555908336;9957.55191016406;5389.83830485086;5392.703401312965;5395.163749618815;5398.1632846908005;5401.3518377794135;4262.914741705211;4317.309230523164;4804.447488538793;4821.951780482221;4823.927641085386;3786.261678972574;3833.7124715646437;3866.8646597368956;3952.0317522207242;3963.9387518490225;1233.2045830439495;1245.4582256718356;1252.3487786351047;1264.1530174782918;1267.6830792301926;857.4983634573845;861.6036623153294;876.4828751036791;895.5566994337714;953.1278879824882;5530.336359636869;5540.4763689985575;5771.192033115367;5878.242078498859;5950.583459157904;851.5486792000249;912.6258234123977;924.8751418558543;939.0984654731534;999.4003597841237;3766.4915236443276;3812.8284227209842;3812.8856134316015;3931.6264954829244;3941.940870886939;9779.8753143388;10087.142592879687;10431.5827366906;10447.791044179074;10461.84307235392;9449;10321.277510574188;10434.634787782543;10446.529906154241;10448.477576121315;7720.343770779435;7967.800804979806;8130.878036829452;8139;8191.631376588068;5762.250907382014;5866.3547009828035;5940.049592065248;5948.1448904525205;5985.610935289193;9338.906610933804;9576.856347154659;9674.806503869742;9706.854397183906;9760.658376956773;9702.9029709702;9760.170385517311;9767.413955162712;9895.752606184902;9939.155171810477;7332.30343117403;7348.301911318416;7475.626218689153;7529.88705169412;7531.510451820614;8069.515829050276;8170.550619715973;8183.222593853575;8189.918100818915;8189.959050204711;6959.652017399008;7304.6347682616715;7327.816804579928;7414.962925185339;7466.925330746841;7073.3987611053635;7230.530015549183;7258.74594389215;7287.672054757442;7317.158526769277;6814.454843612598;6846.726130954706;6853.040574319699;6861.965690171517;6898.827529311607;4848.490908454562;4983.775730092082;4997.1754660482065;5023;5126.53861152498;4928.728919909439;4935.309056732132;5058.48245526348;5093.23601459784;5159.251908473176 01:11:03 INFO - PROCESS | 2245 | |4;prototype.html;278.6405536857454;298.9297515083953;299.37878901279845;307.34995484550177;312.83732459121256;3785.3186426443262;4893.730844803535;5111.6166287528395;5127.66670166439;5203.427622961481;4382.5398333175035;5029.145045342291;5040.42035165956;5052.26742122392;5091.847244582668;3755.061234691327;3908;3924.7628851554628;3970.9205815883665;3995.7802320872343;3876.8836934891856;3901.1807520420743;3981.1241526864187;3985.541662708782;4006.6994975376965;3255.3489302139546;3348.748843836722;3706.6478684524927;3922.529051605648;3957.3866050762035;3245.6754324567473;3687.94468082979;3864.594217607167;3922.5489068756888;3958.9208215835665;3144.7326977206967;3359.193793489545;3453.706434953032;3461;3462.792232466035;5009.747563109223;5033.6224783141415;5045.571126454256;5049.596032317406;5068.619853510964;4327.632151267146;4505.707129036602;4529.048899731028;4543.886402839922;4551.886202844922;4915.1398505261795;5366.792471693877;5393.6763794172475;5400.459954004607;5407.324084489439;3732.9440058399146;3799.4870692456443;3803.6766874815676;3805.315043292206;3805.8858234253016;4787.295178224292;5420.509359926052;5618.550515958755;5688.97155514224;5712.942870571283;3539.0975301298517;3685.2261025184475;3840.8847734568008;3872.2255548890334;3886.319894018592;3727.3535789589696;3922.058705910561;3934.409838524187;3938.330483817758;3947.4276229947072;4022.718409711292;4040.575739547364;4193.559676233952;4197.748135111903;4500.639948804088;5119.257707632447;5371.409144994048;5399.460053994648;5428.809991650273;5464.584634603373;1158.1892675127444;1294.8640392758625;1298.7077907470743;1304.2826445454962;1317.5915466205506;754.4982586579863;855.1790281329993;859.0292968945176;873.7378786364065;894.7539426657721;4994.825181118644;5069.797208111708;5135.820246291362;5165.328507294028;5225.451327610546;4530.388397566352;4602.608778253819;5324.361076670824;5374.193870919394;5556.333240011225;4318.395424640553;5003.3495645565845;5084.237364395371;5094.53571571335;5106.948930510647;2533.6302717385834;2813.268550176928;2860.8140470869325;2927.6486821581548;2935.823850568973;5322.627416080837;5654.660720356792;5709.885802283931;5727.5131613812455;5728.255326807488;4430.6831801837925;4695.81216751333;5599.888002239933;5639.802606908738;5676.460736230051;5204.869878253074;5655.575831812548;5682.971585142048;5687.236956543485;5716.171155182476;4354.782260886879;4878.121938051185;5265.552428043659;5472.425395333592;5555.500024988852;4789.401324834395;5333.7866485340155;5408.5109359230955;5461.890762184814;5471.562275018068;4291.506476755213;4771.618270538279;5627.52166065889;5681.068436731531;5705;3244.3997860395903;3805.657490825839;3851.6340947609933;3855.5951625078965;3868.2456920900154;4662.930056049094;5494.450554944474;5500.944990550203;5531.280933478622;5540.612157148961;4612.4926258112255;5378.811741589026;5395.298611180521;5395.865103372447;5428.348598168245;4814.229723244404;5091.4144873338555;5350.652207606493;5371.946280537145;5446.183072539151;5057.342545469065;5080.974595127001;5209.697575606098;5244.213367994678;5248.685078895279;4532.388127602863;4730.445559397886;4833.73414462208;5493.423190564933;5519.448055194448;5137.5889928806355;5331.840044798507;5364.946350536445;5372.919406208832;5408.702521361363 01:11:03 INFO - PROCESS | 2245 | |5;yui.html;593.60821857574;675.8242856857215;791.3510921044746;817.9550124743139;854.137321305482;12699.047571432133;15010.174440405774;15462.69074618507;15483.612909677264;15679.608009799733;12274.20217685852;13697.178169309824;13785.241811700353;13869.722605547882;13927.37326820293;852.4033176776235;881.5944665453867;882.2016075451694;883.8409086364452;885.8892638420198;882.554310073412;883.8806761087235;884.4516399832113;885.2431171348501;888.524639317965;934.9065093490665;935.6444551070583;936.5691781780355;937.3063932689795;937.6483818568037;931.5481991234246;932.8181004704086;934.22926085979;935.5182081228173;936.180841763457;663.4360793325635;684.8424862281653;692.8302565871394;694.4236283884364;694.9200841903196;14840;14855.331510081964;14873.776893346609;14891.404343826234;14945.850541494554;12918.547850825176;13080.41138148776;13116.672083197996;13263.204207747565;13414.731705365935;12317.815232771516;12338.938305308506;12358.196717213443;12452.252864828139;12490.43793029316;4376.671749618791;4497.842575509874;4521.751303678297;4548.704334218265;4619.9076018479445;44634.107317853784;47042.764786176194;76798;89907;95097;8850.380473366931;10827.187960902964;10833.67498975032;10858.239923205458;11071.114310855111;18235.54411139732;19511.317103901296;20861.68707469389;20884.164633414795;20900.268490602757;7586.355159811367;7795.844083118306;7816.257455541714;7978.880316795253;8053.798655033671;4153.273177193979;4297.183535128315;4396.494403143615;4419.7348159109915;4482.394876691605;3475.913102172466;3494.178867966026;3558.893233203008;3607.603163651996;3613.7831730096277;590.3358721438382;655.1057806094647;666.9166354205724;673.8113328268092;673.9049045301385;541.7020638648728;556.1435389500125;625.343389441085;665.2482694555218;670.7082419147687;7485.0643669541305;8506.89410376647;8656.740297791077;8847.867281990775;8959.148880856308;659.3143131143653;659.4823063894916;666.1373521289844;671.3253180553512;687.8039758668856;4144.334080639761;4303.505096913832;4416.977915110404;4497.977510112429;4559.202139625619;87853;108928;109813;113119;116714;52832;67062.66468667724;76719;93117.60323595151;93395.53302233445;60975;83484.58257708672;83680;84906.57546712227;85285;9156.93463471172;9448.48033358172;9476.57355418994;9523;9697.127258546765;39533.40699889446;48120.27819582639;48721.512784871695;49420.75289623529;52387.47612523826;67090.66454667696;70178;70540;70853;72824.27175728175;12083.214591051905;12187.268763874195;12206.75586488283;12327.69180770488;12410.5656302029;13847.653808654864;13877.375518101508;14280;14305;14614.342354593857;12865.163764355288;12868.742625147257;12925.418356173806;13038.217706937614;13134.802977955147;12641.747165056464;12887.871121288666;13087.934560327138;13191.208527488381;13404.530841420894;12564.434600442819;13201.943844492609;13222.471101155847;13337.599872003855;13337.866621334051;10863;10883.510242038968;10902.022621225857;11008.449577521253;11080.889191107986;8622.223999840044;8876.955615221883;9094.772630684021;10484.895151048697;10843.728906777395 01:11:03 INFO - PROCESS | 2245 | __end_tp_report 01:11:03 INFO - PROCESS | 2245 | __start_cc_report 01:11:03 INFO - PROCESS | 2245 | _x_x_mozilla_cycle_collect,2336 01:11:03 INFO - PROCESS | 2245 | __end_cc_report 01:11:03 INFO - PROCESS | 2245 | __startTimestamp1477469463411__endTimestamp 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | ------- Summary: start ------- 01:11:03 INFO - PROCESS | 2245 | Number of tests: 6 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | [#0] dojo.html Cycles:165 Average:5725.17 Median:5912.05 stddev:636.26 (10.8%) stddev-sans-first:608.88 01:11:03 INFO - PROCESS | 2245 | Values: 3291.2 3292.3 3294.5 3346.0 3358.4 5502.2 5612.5 5639.1 5642.7 5652.1 5602.2 5651.4 5723.8 5736.3 5776.3 5055.1 5099.8 5122.9 5156.6 5174.3 5246.7 5278.9 5280.9 5284.6 5287.4 4578.2 5060.7 5221.3 5241.5 5317.8 5126.9 5134.4 5169.7 5172.4 5212.8 5143.7 5182.8 5188.3 5200.0 5233.9 5658.5 5699.2 5709.5 5713.5 5722.9 6096.6 6121.8 6123.7 6124.0 6211.1 6209.1 6211.9 6241.2 6247.9 6255.8 5784.9 5792.7 5796.2 5813.9 5845.6 6153.8 6165.5 6220.4 6223.9 6228.3 6055.2 6090.2 6104.4 6124.9 6172.0 6232.6 6238.4 6238.7 6245.9 6263.1 6159.0 6208.6 6219.6 6225.9 6243.0 6097.5 6122.8 6137.1 6139.8 6175.2 4925.9 4935.3 4945.7 4956.0 4990.6 4397.7 4439.9 4445.8 4449.0 4493.2 5559.8 5692.3 5699.5 5795.3 5827.6 6170.8 6183.4 6209.9 6233.1 6261.2 5776.1 5779.5 5788.5 5796.4 5820.5 5409.2 5409.4 5430.2 5431.3 5435.2 6115.2 6159.8 6173.3 6234.3 6246.0 6239.2 6268.8 6273.7 6281.9 6288.0 6222.4 6232.2 6252.4 6253.4 6258.7 6028.3 6089.6 6103.5 6115.4 6188.3 6162.0 6258.9 6268.6 6271.8 6278.4 6094.6 6141.1 6147.6 6147.7 6162.0 5937.2 5991.9 6068.9 6096.8 6117.4 5880.4 5904.1 5912.1 6006.1 6073.5 6133.5 6143.0 6152.0 6166.4 6174.4 5774.0 5776.8 5822.7 5826.7 5891.1 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | [#1] ext.html Cycles:180 Average:66430.68 Median:37739.53 stddev:141523.34 (375.0%) stddev-sans-first:141833.67 01:11:03 INFO - PROCESS | 2245 | Values: 456.0 461.8 483.5 491.0 508.3 24169.8 39523.0 40410.4 40528.6 42484.4 41523.6 41915.8 41947.0 41975.0 42168.2 8566.1 9412.9 9565.2 9577.5 9582.6 8596.0 11430.5 11751.2 11751.4 11774.9 11566.6 11655.4 11677.7 11682.1 11759.1 8671.7 8869.2 11633.4 11673.0 11715.2 8683.4 8752.9 8774.9 11224.3 11572.8 39844.6 40270.2 40302.8 40303.6 40363.8 3307.4 3430.7 3475.7 3636.6 3947.3 28022.9 29778.3 30164.8 30351.7 30798.1 3161.7 3164.4 3199.3 3285.3 3290.6 425744.0 489221.0 490155.0 490893.5 492614.0 57282.4 57716.7 57795.4 57824.4 57877.4 59801.4 59858.7 59897.4 59999.0 60025.8 14989.2 15529.1 15548.5 15555.9 15558.5 10864.2 11038.6 11056.5 12071.5 12193.0 12995.4 13686.5 13715.8 14810.4 15229.7 5073.7 5268.8 6284.9 6297.9 6308.3 760.3 991.0 997.4 1012.4 1022.4 29456.0 29492.7 29779.6 30379.4 30524.7 1007.4 1053.8 1063.3 1087.1 1164.6 14680.7 15167.9 15235.5 15448.5 15585.4 600101.0 601840.0 602088.0 604264.0 605497.0 55577.7 55807.2 55861.9 55884.0 56056.7 1333.7 1368.2 1380.4 1385.5 1385.5 29115.4 29154.9 29506.0 29865.3 30017.2 47874.5 48017.8 48082.0 48093.8 48118.0 499725.0 503322.0 503384.0 504272.0 504675.0 37693.6 38731.0 38836.0 39062.6 39155.5 34753.0 46114.5 46117.0 46606.0 46650.0 34912.3 34983.3 36822.3 38530.8 38752.0 36883.6 37075.0 37785.4 38188.6 38974.4 37167.4 37255.7 37501.4 38098.8 38222.9 30752.7 32529.0 33540.2 33610.5 33611.0 24513.3 24692.4 24767.6 24865.6 24954.4 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | [#2] jquery.html Cycles:180 Average:34239.58 Median:1572.40 stddev:99602.25 (6334.4%) stddev-sans-first:99849.13 01:11:03 INFO - PROCESS | 2245 | Values: 339.0 351.5 371.1 375.7 395.4 14785.5 15010.5 15928.8 20247.9 20707.7 19868.5 20076.9 21149.0 21150.4 21491.9 5541.1 5754.1 6060.2 6064.3 6075.1 5575.9 5991.6 6042.6 6048.5 6054.3 5644.2 5888.1 5982.1 5986.2 6012.2 5775.5 5818.4 5842.4 5910.6 5914.7 4887.1 5085.1 5140.9 5145.3 5154.6 24234.9 24716.4 25336.5 25924.1 25930.5 2130.7 2203.5 2282.1 2464.9 2805.8 9973.9 10076.2 10208.3 10285.6 10439.2 1734.4 1764.2 1810.7 1854.1 1867.0 89567.0 105622.4 111956.0 112485.3 113031.0 10325.5 10444.0 11289.0 11486.4 11703.4 14572.8 14696.6 14721.2 14728.3 14743.1 8201.2 8355.2 8422.1 8537.6 8557.8 8206.7 8233.3 8297.0 8463.8 8498.7 4473.2 4538.2 4541.5 4636.4 4647.0 1881.0 1916.5 1922.5 1926.8 1974.1 382.7 389.4 426.9 833.7 900.1 9205.8 11381.2 11562.1 11908.9 12279.9 429.9 435.8 443.2 833.4 897.5 8791.6 10758.9 11163.0 11198.4 11249.6 585050.1 592218.0 596516.0 606778.0 607591.0 123027.4 125093.0 125925.0 127768.4 127903.0 988.2 1010.9 1024.5 1027.5 1028.7 18035.8 18688.6 18768.0 18775.1 18784.8 49765.8 49890.0 50400.5 52483.7 53356.7 73062.6 82753.0 84283.7 84478.0 84913.0 7700.4 7898.4 7953.2 8094.6 8147.2 9443.3 11997.9 12354.2 12620.8 12650.7 10364.7 10502.5 11066.1 11086.3 11186.0 8710.7 9225.5 10483.9 10628.7 10877.7 10275.7 11366.8 11413.4 11562.6 11663.9 8128.7 8170.2 8256.4 8276.8 8323.3 9613.9 10820.6 11301.7 11348.4 11457.4 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | [#3] mootools.html Cycles:180 Average:5614.30 Median:5273.16 stddev:3099.05 (58.8%) stddev-sans-first:3091.10 01:11:03 INFO - PROCESS | 2245 | Values: 1340.9 1525.0 1562.3 1795.6 1960.4 7671.3 8147.6 8380.3 8690.1 8721.5 8483.4 8708.5 8709.2 8717.6 8728.5 2320.7 2358.6 2363.5 2364.8 2366.4 2309.4 2358.4 2367.2 2367.3 2373.1 2323.5 2348.3 2361.3 2361.4 2366.1 2307.1 2342.3 2343.6 2344.0 2358.6 2324.9 2330.2 2331.7 2334.1 2350.5 8492.7 8524.7 8693.8 8714.3 8729.8 4724.5 5180.9 5253.1 5293.3 5385.6 3435.8 3556.7 3596.0 3600.1 3611.4 1029.7 1033.4 1033.8 1042.5 1070.6 11238.8 11364.5 11467.1 11468.0 11475.8 4555.9 4636.9 4755.1 4758.5 4763.3 9715.9 9875.0 9922.5 9939.3 9957.6 5389.8 5392.7 5395.2 5398.2 5401.4 4262.9 4317.3 4804.4 4822.0 4823.9 3786.3 3833.7 3866.9 3952.0 3963.9 1233.2 1245.5 1252.3 1264.2 1267.7 857.5 861.6 876.5 895.6 953.1 5530.3 5540.5 5771.2 5878.2 5950.6 851.5 912.6 924.9 939.1 999.4 3766.5 3812.8 3812.9 3931.6 3941.9 9779.9 10087.1 10431.6 10447.8 10461.8 9449.0 10321.3 10434.6 10446.5 10448.5 7720.3 7967.8 8130.9 8139.0 8191.6 5762.3 5866.4 5940.0 5948.1 5985.6 9338.9 9576.9 9674.8 9706.9 9760.7 9702.9 9760.2 9767.4 9895.8 9939.2 7332.3 7348.3 7475.6 7529.9 7531.5 8069.5 8170.6 8183.2 8189.9 8190.0 6959.7 7304.6 7327.8 7415.0 7466.9 7073.4 7230.5 7258.7 7287.7 7317.2 6814.5 6846.7 6853.0 6862.0 6898.8 4848.5 4983.8 4997.2 5023.0 5126.5 4928.7 4935.3 5058.5 5093.2 5159.3 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | [#4] prototype.html Cycles:180 Average:4362.81 Median:4954.98 stddev:1324.44 (26.7%) stddev-sans-first:1292.19 01:11:03 INFO - PROCESS | 2245 | Values: 278.6 298.9 299.4 307.3 312.8 3785.3 4893.7 5111.6 5127.7 5203.4 4382.5 5029.1 5040.4 5052.3 5091.8 3755.1 3908.0 3924.8 3970.9 3995.8 3876.9 3901.2 3981.1 3985.5 4006.7 3255.3 3348.7 3706.6 3922.5 3957.4 3245.7 3687.9 3864.6 3922.5 3958.9 3144.7 3359.2 3453.7 3461.0 3462.8 5009.7 5033.6 5045.6 5049.6 5068.6 4327.6 4505.7 4529.0 4543.9 4551.9 4915.1 5366.8 5393.7 5400.5 5407.3 3732.9 3799.5 3803.7 3805.3 3805.9 4787.3 5420.5 5618.6 5689.0 5712.9 3539.1 3685.2 3840.9 3872.2 3886.3 3727.4 3922.1 3934.4 3938.3 3947.4 4022.7 4040.6 4193.6 4197.7 4500.6 5119.3 5371.4 5399.5 5428.8 5464.6 1158.2 1294.9 1298.7 1304.3 1317.6 754.5 855.2 859.0 873.7 894.8 4994.8 5069.8 5135.8 5165.3 5225.5 4530.4 4602.6 5324.4 5374.2 5556.3 4318.4 5003.3 5084.2 5094.5 5106.9 2533.6 2813.3 2860.8 2927.6 2935.8 5322.6 5654.7 5709.9 5727.5 5728.3 4430.7 4695.8 5599.9 5639.8 5676.5 5204.9 5655.6 5683.0 5687.2 5716.2 4354.8 4878.1 5265.6 5472.4 5555.5 4789.4 5333.8 5408.5 5461.9 5471.6 4291.5 4771.6 5627.5 5681.1 5705.0 3244.4 3805.7 3851.6 3855.6 3868.2 4662.9 5494.5 5500.9 5531.3 5540.6 4612.5 5378.8 5395.3 5395.9 5428.3 4814.2 5091.4 5350.7 5371.9 5446.2 5057.3 5081.0 5209.7 5244.2 5248.7 4532.4 4730.4 4833.7 5493.4 5519.4 5137.6 5331.8 5364.9 5372.9 5408.7 01:11:03 INFO - PROCESS | 2245 | 01:11:03 INFO - PROCESS | 2245 | [#5] yui.html Cycles:180 Average:19091.05 Median:4589.55 stddev:27238.57 (593.5%) stddev-sans-first:27279.57 01:11:03 INFO - PROCESS | 2245 | Values: 593.6 675.8 791.4 818.0 854.1 12699.0 15010.2 15462.7 15483.6 15679.6 12274.2 13697.2 13785.2 13869.7 13927.4 852.4 881.6 882.2 883.8 885.9 882.6 883.9 884.5 885.2 888.5 934.9 935.6 936.6 937.3 937.6 931.5 932.8 934.2 935.5 936.2 663.4 684.8 692.8 694.4 694.9 14840.0 14855.3 14873.8 14891.4 14945.9 12918.5 13080.4 13116.7 13263.2 13414.7 12317.8 12338.9 12358.2 12452.3 12490.4 4376.7 4497.8 4521.8 4548.7 4619.9 44634.1 47042.8 76798.0 89907.0 95097.0 8850.4 10827.2 10833.7 10858.2 11071.1 18235.5 19511.3 20861.7 20884.2 20900.3 7586.4 7795.8 7816.3 7978.9 8053.8 4153.3 4297.2 4396.5 4419.7 4482.4 3475.9 3494.2 3558.9 3607.6 3613.8 590.3 655.1 666.9 673.8 673.9 541.7 556.1 625.3 665.2 670.7 7485.1 8506.9 8656.7 8847.9 8959.1 659.3 659.5 666.1 671.3 687.8 4144.3 4303.5 4417.0 4498.0 4559.2 87853.0 108928.0 109813.0 113119.0 116714.0 52832.0 67062.7 76719.0 93117.6 93395.5 60975.0 83484.6 83680.0 84906.6 85285.0 9156.9 9448.5 9476.6 9523.0 9697.1 39533.4 48120.3 48721.5 49420.8 52387.5 67090.7 70178.0 70540.0 70853.0 72824.3 12083.2 12187.3 12206.8 12327.7 12410.6 13847.7 13877.4 14280.0 14305.0 14614.3 12865.2 12868.7 12925.4 13038.2 13134.8 12641.7 12887.9 13087.9 13191.2 13404.5 12564.4 13201.9 13222.5 13337.6 13337.9 10863.0 10883.5 10902.0 11008.4 11080.9 8622.2 8877.0 9094.8 10484.9 10843.7 01:11:03 INFO - PROCESS | 2245 | -------- Summary: end -------- 01:11:03 INFO - PROCESS | 2245 | 01:11:04 INFO - TEST-INFO | 2245: exit 0 01:11:04 INFO - TEST-OK | dromaeo_css | took 1119816ms 01:11:04 INFO - TEST-START | kraken 01:11:04 INFO - operating with platform_type : mac_ 01:11:04 INFO - Initialising browser for kraken test... 01:11:04 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpTK_bD4/profile http://localhost:53843/getInfo.html) 01:11:06 INFO - PROCESS | 2248 | __metrics Screen width/height:1600/1200 01:11:06 INFO - PROCESS | 2248 | colorDepth:24 01:11:06 INFO - PROCESS | 2248 | Browser inner width/height: 1024/689 01:11:06 INFO - PROCESS | 2248 | __metrics 01:11:06 INFO - PROCESS | 2248 | 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" 01:11:06 INFO - PROCESS | 2248 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:11:07 INFO - TEST-INFO | 2248: exit 0 01:11:07 INFO - Browser initialized. 01:11:07 INFO - Running cycle 1/1 for kraken test... 01:11:07 INFO - TEST-INFO | started process 2249 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpTK_bD4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:11:19 INFO - PROCESS | 2249 | RSS: Main: 230629376 01:11:19 INFO - PROCESS | 2249 | 01:11:21 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53843/tests/kraken/driver.html?testName=audio-beat-detection) 01:11:22 INFO - PROCESS | 2249 | RSS: Main: 290054144 01:11:22 INFO - PROCESS | 2249 | 01:11:25 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53843/tests/kraken/driver.html?testName=audio-dft) 01:11:26 INFO - PROCESS | 2249 | RSS: Main: 292614144 01:11:26 INFO - PROCESS | 2249 | 01:11:29 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53843/tests/kraken/driver.html?testName=audio-fft) 01:11:30 INFO - PROCESS | 2249 | RSS: Main: 385200128 01:11:30 INFO - PROCESS | 2249 | 01:11:32 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53843/tests/kraken/driver.html?testName=audio-oscillator) 01:11:32 INFO - PROCESS | 2249 | RSS: Main: 286314496 01:11:32 INFO - PROCESS | 2249 | 01:11:34 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:11:35 INFO - PROCESS | 2249 | RSS: Main: 288374784 01:11:35 INFO - PROCESS | 2249 | 01:11:38 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53843/tests/kraken/driver.html?testName=imaging-darkroom) 01:11:38 INFO - PROCESS | 2249 | RSS: Main: 325320704 01:11:38 INFO - PROCESS | 2249 | 01:11:41 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53843/tests/kraken/driver.html?testName=imaging-desaturate) 01:11:42 INFO - PROCESS | 2249 | RSS: Main: 326258688 01:11:42 INFO - PROCESS | 2249 | 01:11:45 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53843/tests/kraken/driver.html?testName=json-parse-financial) 01:11:45 INFO - PROCESS | 2249 | RSS: Main: 325853184 01:11:45 INFO - PROCESS | 2249 | 01:11:47 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:11:47 INFO - PROCESS | 2249 | RSS: Main: 302424064 01:11:47 INFO - PROCESS | 2249 | 01:11:49 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:11:50 INFO - PROCESS | 2249 | RSS: Main: 304513024 01:11:50 INFO - PROCESS | 2249 | 01:11:52 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:11:53 INFO - PROCESS | 2249 | RSS: Main: 309534720 01:11:53 INFO - PROCESS | 2249 | 01:11:56 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:11:57 INFO - PROCESS | 2249 | RSS: Main: 317620224 01:11:57 INFO - PROCESS | 2249 | 01:12:00 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:12:00 INFO - PROCESS | 2249 | RSS: Main: 317628416 01:12:00 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:53843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53843/tests/kraken/driver.html?testName=ai-astar) 01:12:02 INFO - PROCESS | 2249 | RSS: Main: 362512384 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | __start_tp_report 01:12:02 INFO - PROCESS | 2249 | _x_x_mozilla_page_load 01:12:02 INFO - PROCESS | 2249 | _x_x_mozilla_page_load_details 01:12:02 INFO - PROCESS | 2249 | |i|pagename|runs| 01:12:02 INFO - PROCESS | 2249 | |0;ai-astar;110;113;112;110;112;114;111;111;111;111 01:12:02 INFO - PROCESS | 2249 | |1;audio-beat-detection;155;116;115;152;115;118;141;110;176;144 01:12:02 INFO - PROCESS | 2249 | |2;audio-dft;181;182;182;185;184;180;181;180;182;181 01:12:02 INFO - PROCESS | 2249 | |3;audio-fft;82;60;58;91;61;73;81;82;72;72 01:12:02 INFO - PROCESS | 2249 | |4;audio-oscillator;81;71;94;69;67;67;91;66;67;90 01:12:02 INFO - PROCESS | 2249 | |5;imaging-gaussian-blur;87;87;88;84;73;114;106;84;87;84 01:12:02 INFO - PROCESS | 2249 | |6;imaging-darkroom;96;96;96;96;95;96;95;96;96;96 01:12:02 INFO - PROCESS | 2249 | |7;imaging-desaturate;82;82;79;79;80;81;82;83;80;80 01:12:02 INFO - PROCESS | 2249 | |8;json-parse-financial;56;53;54;53;54;55;55;55;54;55 01:12:02 INFO - PROCESS | 2249 | |9;json-stringify-tinderbox;65;68;74;79;76;72;72;70;69;71 01:12:02 INFO - PROCESS | 2249 | |10;stanford-crypto-aes;87;86;91;89;86;90;87;85;85;88 01:12:02 INFO - PROCESS | 2249 | |11;stanford-crypto-ccm;148;148;147;151;141;141;146;147;236;148 01:12:02 INFO - PROCESS | 2249 | |12;stanford-crypto-pbkdf2;222;241;174;173;173;177;171;175;174;172 01:12:02 INFO - PROCESS | 2249 | |13;stanford-crypto-sha256-iterative;67;69;70;68;69;69;68;69;68;69 01:12:02 INFO - PROCESS | 2249 | __end_tp_report 01:12:02 INFO - PROCESS | 2249 | __start_cc_report 01:12:02 INFO - PROCESS | 2249 | _x_x_mozilla_cycle_collect,2009 01:12:02 INFO - PROCESS | 2249 | __end_cc_report 01:12:02 INFO - PROCESS | 2249 | __startTimestamp1477469522631__endTimestamp 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | ------- Summary: start ------- 01:12:02 INFO - PROCESS | 2249 | Number of tests: 14 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:1.27 (1.1%) stddev-sans-first:1.22 01:12:02 INFO - PROCESS | 2249 | Values: 110.0 113.0 112.0 110.0 112.0 114.0 111.0 111.0 111.0 111.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:142.50 stddev:22.50 (15.8%) stddev-sans-first:22.57 01:12:02 INFO - PROCESS | 2249 | Values: 155.0 116.0 115.0 152.0 115.0 118.0 141.0 110.0 176.0 144.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#2] audio-dft Cycles:10 Average:181.80 Median:182.00 stddev:1.62 (0.9%) stddev-sans-first:1.69 01:12:02 INFO - PROCESS | 2249 | Values: 181.0 182.0 182.0 185.0 184.0 180.0 181.0 180.0 182.0 181.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#3] audio-fft Cycles:10 Average:73.20 Median:77.00 stddev:11.00 (14.3%) stddev-sans-first:11.20 01:12:02 INFO - PROCESS | 2249 | Values: 82.0 60.0 58.0 91.0 61.0 73.0 81.0 82.0 72.0 72.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:76.00 stddev:11.48 (15.1%) stddev-sans-first:12.05 01:12:02 INFO - PROCESS | 2249 | Values: 81.0 71.0 94.0 69.0 67.0 67.0 91.0 66.0 67.0 90.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:85.50 stddev:11.82 (13.8%) stddev-sans-first:12.50 01:12:02 INFO - PROCESS | 2249 | Values: 87.0 87.0 88.0 84.0 73.0 114.0 106.0 84.0 87.0 84.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:12:02 INFO - PROCESS | 2249 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#7] imaging-desaturate Cycles:10 Average:80.80 Median:81.50 stddev:1.40 (1.7%) stddev-sans-first:1.41 01:12:02 INFO - PROCESS | 2249 | Values: 82.0 82.0 79.0 79.0 80.0 81.0 82.0 83.0 80.0 80.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 01:12:02 INFO - PROCESS | 2249 | Values: 56.0 53.0 54.0 53.0 54.0 55.0 55.0 55.0 54.0 55.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:4.03 (5.6%) stddev-sans-first:3.50 01:12:02 INFO - PROCESS | 2249 | Values: 65.0 68.0 74.0 79.0 76.0 72.0 72.0 70.0 69.0 71.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.50 stddev:2.07 (2.4%) stddev-sans-first:2.19 01:12:02 INFO - PROCESS | 2249 | Values: 87.0 86.0 91.0 89.0 86.0 90.0 87.0 85.0 85.0 88.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#11] stanford-crypto-ccm Cycles:10 Average:155.30 Median:148.00 stddev:28.53 (19.3%) stddev-sans-first:30.13 01:12:02 INFO - PROCESS | 2249 | Values: 148.0 148.0 147.0 151.0 141.0 141.0 146.0 147.0 236.0 148.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:174.50 stddev:24.86 (14.2%) stddev-sans-first:22.52 01:12:02 INFO - PROCESS | 2249 | Values: 222.0 241.0 174.0 173.0 173.0 177.0 171.0 175.0 174.0 172.0 01:12:02 INFO - PROCESS | 2249 | 01:12:02 INFO - PROCESS | 2249 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.67 01:12:02 INFO - PROCESS | 2249 | Values: 67.0 69.0 70.0 68.0 69.0 69.0 68.0 69.0 68.0 69.0 01:12:02 INFO - PROCESS | 2249 | -------- Summary: end -------- 01:12:02 INFO - PROCESS | 2249 | 01:12:03 INFO - TEST-INFO | 2249: exit 0 01:12:03 INFO - TEST-OK | kraken | took 59410ms 01:12:03 INFO - SUITE-END | took 1179s 01:12:03 INFO - Completed test suite (00:19:39) 01:12:03 INFO - javascript benchmark 01:12:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.226561757987, 3292.3086151908115, 3294.5222942673304, 3346.0, 3358.4290670585997, 5502.174673798932, 5612.494875461212, 5639.069553523669, 5642.746076426561, 5652.123920792284, 5602.1596760485945, 5651.40660230676, 5723.771049158039, 5736.340320863092, 5776.277965254343, 5055.090083784918, 5099.770510327045, 5122.948770512303, 5156.613254005946, 5174.301469301634, 5246.68519888806, 5278.853118209753, 5280.867978300535, 5284.603654725892, 5287.444818294081, 4578.244589642705, 5060.721660308682, 5221.347331583552, 5241.502057304588, 5317.787288508455, 5126.897462050738, 5134.358205224347, 5169.663971841818, 5172.405173405069, 5212.843614691527, 5143.717095559743, 5182.818601348972, 5188.299579556787, 5200.037992971313, 5233.921491177635, 5658.547316214693, 5699.202111704365, 5709.543236541067, 5713.514351280104, 5722.885542289131, 6096.573239873211, 6121.757501469892, 6123.740204357149, 6123.953766440822, 6211.068339749028, 6209.099680546341, 6211.9068213976825, 6241.157443745082, 6247.937520624781, 6255.781047663356, 5784.913226301609, 5792.739326730307, 5796.217510636095, 5813.912791308134, 5845.620034697731, 6153.815385538441, 6165.475934545524, 6220.440160385587, 6223.937760622426, 6228.283747369111, 6055.2430946131735, 6090.208272924491, 6104.368208815833, 6124.899720463051, 6171.9691401542705, 6232.626042437469, 6238.438540531283, 6238.719257633417, 6245.906311405332, 6263.091851681481, 6158.969205153946, 6208.596441231396, 6219.626822390671, 6225.937740622627, 6243.032329988859, 6097.451229389376, 6122.794608434074, 6137.131844484766, 6139.829471381323, 6175.197224360804, 4925.852224433273, 4935.3090567320605, 4945.67853089548, 4956.033573453142, 4990.575801056951, 4397.714148580332, 4439.933400998988, 4445.844395446144, 4449.0, 4493.236149854532, 5559.777608895599, 5692.260006199168, 5699.5155411790465, 5795.275590551181, 5827.621204621686, 6170.845728856725, 6183.350748171377, 6209.937900620936, 6233.1273621693, 6261.186045814015, 5776.075827867521, 5779.479846813723, 5788.507976822018, 5796.3913789052385, 5820.534357251409, 5409.161579955114, 5409.377921538995, 5430.185472179205, 5431.321084864392, 5435.211894275308, 6115.179495343508, 6159.753609855556, 6173.32093469727, 6234.2830574484515, 6246.0, 6239.1577137085915, 6268.811935641938, 6273.74905003813, 6281.874362512815, 6287.96856015717, 6222.408871157414, 6232.158658581034, 6252.374762523711, 6253.37466253371, 6258.687065646791, 6028.306744724413, 6089.634621922699, 6103.5195042504665, 6115.4190351916495, 6188.288346840171, 6162.014077747539, 6258.906116408349, 6268.623882567061, 6271.843203919939, 6278.4035516625845, 6094.634321940521, 6141.1402403664415, 6147.600405973776, 6147.66187859672, 6162.0, 5937.168796368425, 5991.910121348096, 6068.8786224276155, 6096.817095487142, 6117.418845209698, 5880.353161152356, 5904.143899134688, 5912.054071348563, 6006.099085137264, 6073.483753880793, 6133.539984501091, 6143.017117261216, 6152.0156774915795, 6166.414190651881, 6174.38256174379, 5774.04728219839, 5776.826695199151, 5822.650640961556, 5826.70866456684, 5891.086881533369], "value": 5683.352119163639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.0127324342798, 461.8314315274924, 483.5285596543371, 491.0400167672201, 508.26301862299675, 24169.75830241699, 39523.0, 40410.39384409232, 40528.59471405285, 42484.36273455893, 41523.58476415235, 41915.79042104785, 41947.0, 41975.0, 42168.15663686724, 8566.143385661446, 9412.90587094129, 9565.234781217487, 9577.473238971854, 9582.568784404684, 8595.95702021489, 11430.5427782889, 11751.236169648946, 11751.412429378539, 11774.882251177463, 11566.59516916908, 11655.417229138551, 11677.70805729855, 11682.065434765198, 11759.11806614503, 8671.739847804576, 8869.246114080312, 11633.36016519091, 11673.007794337535, 11715.238509496856, 8683.392162548624, 8752.8687069694, 8774.868376974351, 11224.326540407601, 11572.784857589915, 39844.60155398438, 40270.19459610821, 40302.798486007385, 40303.59696403028, 40363.798181008904, 3307.371599396107, 3430.691237788611, 3475.739319551044, 3636.581793093775, 3947.2894878921784, 28022.859885700644, 29778.255543611365, 30164.84917575398, 30351.696483035106, 30798.076057718303, 3161.65221825599, 3164.367126574671, 3199.3281410903737, 3285.342931413703, 3290.6380298167182, 425744.0, 489221.0, 490155.0, 490893.54553227365, 492614.0, 57282.427175728546, 57716.71141644349, 57795.422045779844, 57824.42175578191, 57877.42122578804, 59801.401985980454, 59858.70070649619, 59897.40102598918, 59999.0, 60025.79948401007, 14989.175595342362, 15529.145896975775, 15548.455804046804, 15555.922220389051, 15558.455454059054, 10864.185186111074, 11038.613648522263, 11056.502457389437, 12071.517139314328, 12192.963598094084, 12995.350232488527, 13686.52097176594, 13715.794263085862, 14810.407583696748, 15229.695406092038, 5073.695578265242, 5268.841934741964, 6284.905726414107, 6297.874042519124, 6308.27454842699, 760.3423039071164, 990.9950450247846, 997.3567049253336, 1012.4380968562372, 1022.4121130350078, 29456.0, 29492.705072948997, 29779.553306700418, 30379.392412151632, 30524.69475305263, 1007.4056306779036, 1053.7892421515728, 1063.292910214714, 1087.141158484804, 1164.6098556983504, 14680.706385872223, 15167.924160379127, 15235.542933712006, 15448.459303924308, 15585.376584936475, 600101.0, 601840.0, 602088.0, 604264.0, 605496.9725151346, 55577.722111389994, 55807.16289255665, 55861.882762344525, 55884.0, 56056.71971640116, 1333.7199188170594, 1368.1996032321006, 1380.378829526697, 1385.4873696732072, 1385.515069725608, 29115.41769164647, 29154.854225728737, 29506.0, 29865.25336866596, 30017.249568760082, 47874.521254787, 48017.75991120022, 48082.0, 48093.75953120212, 48118.0, 499725.0, 503322.0, 503384.0, 504272.0, 504675.0, 37693.62306376901, 38731.03172420712, 38836.0, 39062.6093739059, 39155.476007159494, 34753.0, 46114.538854612365, 46117.0, 46606.0, 46650.0, 34912.30175396529, 34983.300333993684, 36822.26355472822, 38530.80734596309, 38752.0, 36883.63116368909, 37075.0, 37785.433218502294, 38188.618113818506, 38974.4153837687, 37167.44248836324, 37255.6960506381, 37501.43747843839, 38098.80950595229, 38222.853314400614, 30752.69247307498, 32529.02412927616, 33540.1614959628, 33610.49584256189, 33611.0, 24513.264602061965, 24692.38269043288, 24767.62848557237, 24865.62701559442, 24954.37614059663], "value": 19624.431993344853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.95763029621287, 351.47279081377934, 371.0871256708497, 375.6975634614136, 395.4108378516012, 14785.482508112218, 15010.549683509498, 15928.761068583952, 20247.86158145486, 20707.689384659203, 19868.50328741782, 20076.899615501938, 21149.0, 21150.365489035354, 21491.892540537316, 5541.141123125902, 5754.108113242443, 6060.181875446802, 6064.332923378425, 6075.0887366895095, 5575.8884822303735, 5991.610545314563, 6042.607230530023, 6048.485878700316, 6054.334023257438, 5644.153376993443, 5888.146218798272, 5982.102684597302, 5986.191864098357, 6012.158297838306, 5775.509081728058, 5818.44724751148, 5842.415758424145, 5910.615809972381, 5914.674692891889, 4887.095887260833, 5085.059264036166, 5140.922886156711, 5145.30538377318, 5154.587632989389, 24234.909429075735, 24716.382090447703, 25336.493270134677, 25924.092656756922, 25930.481390372086, 2130.7017017617545, 2203.504211552404, 2282.109977108929, 2464.8538429630307, 2805.849601663308, 9973.850392244121, 10076.193904487624, 10208.285420020602, 10285.623311558811, 10439.217058720626, 1734.3887598075614, 1764.214924358661, 1810.6559753646766, 1854.0729635182408, 1866.962660746791, 89567.0, 105622.4156637651, 111956.0, 112485.31272030926, 113031.0, 10325.535350909227, 10444.0, 11289.0, 11486.446408446434, 11703.356315402565, 14572.781408278672, 14696.632584185481, 14721.19033453149, 14728.263586820616, 14743.11541307525, 8201.179882011751, 8355.201007662501, 8422.115677853737, 8537.615807288686, 8557.78605534854, 8206.671733130608, 8233.304989222608, 8296.962879640045, 8463.830723385621, 8498.70254541088, 4473.239549276631, 4538.160440318552, 4541.500434952152, 4636.35091087248, 4647.0, 1881.0, 1916.549610841451, 1922.528980399811, 1926.8362189213794, 1974.0721860725437, 382.7378245901566, 389.3614472265487, 426.85273580615257, 833.6623667414707, 900.1088921967205, 9205.76985575366, 11381.203315767982, 11562.07503399726, 11908.880911190778, 12279.93860030712, 429.9398084268205, 435.7886425083832, 443.17126972561516, 833.4078334376281, 897.4615230861561, 8791.648334066565, 10758.946205268923, 11163.0, 11198.440077996067, 11249.550017999189, 585050.0747496235, 592218.0, 596516.0, 606778.0, 607591.0, 123027.38486307512, 125093.0, 125925.0, 127768.44463110686, 127903.0, 988.1699372527112, 1010.9039641234071, 1024.4621573673733, 1027.50679673757, 1028.7428142964259, 18035.81964180394, 18688.626227475102, 18767.967761773234, 18775.061246937872, 18784.812151878854, 49765.751171243915, 49890.0, 50400.49599504105, 52483.73758131185, 53356.729706895494, 73062.63468682622, 82753.0, 84283.73574396266, 84478.0, 84913.0, 7700.383969282332, 7898.407619428451, 7953.244441778022, 8094.554799486084, 8147.226013528705, 9443.338966272295, 11997.880021199677, 12354.196977196454, 12620.810687839506, 12650.683732906751, 10364.740881478023, 10502.52738626779, 11066.059384952368, 11086.334819910831, 11186.0, 8710.651573936972, 9225.49259790691, 10483.895161048293, 10628.681139565826, 10877.728056798644, 10275.7431064224, 11366.772664546497, 11413.429328533706, 11562.595309164139, 11663.941680291544, 8128.715494957648, 8170.223828736261, 8256.422050456651, 8276.793080173044, 8323.292520135614, 9613.90386096158, 10820.56717731282, 11301.660950171508, 11348.375839328915, 11457.427128643702], "value": 9028.474059552265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.9262490563015, 1525.0392252880683, 1562.343815597449, 1795.578039160797, 1960.392278393698, 7671.271229233221, 8147.633356498957, 8380.329573634102, 8690.087540808203, 8721.476711397321, 8483.406161568693, 8708.477491350508, 8709.172628600272, 8717.607707653155, 8728.519931403785, 2320.7447180810095, 2358.6344116661944, 2363.515479326734, 2364.8462849914786, 2366.3965688749345, 2309.3764683535437, 2358.433975845793, 2367.242482405631, 2367.2898130560848, 2373.1456675596773, 2323.500447403808, 2348.3189874936247, 2361.3152185866165, 2361.3978435498925, 2366.1127077345996, 2307.1348244408346, 2342.3090188394294, 2343.6484527320868, 2343.95312093758, 2358.5636657218297, 2324.93025209244, 2330.196082351586, 2331.7318508371413, 2334.0780391745334, 2350.471143992605, 8492.702755403592, 8524.74425767228, 8693.826123477558, 8714.25928796053, 8729.825403491895, 4724.527547245282, 5180.922286165711, 5253.0544501989625, 5293.258943747878, 5385.649932754359, 3435.7594968352223, 3556.6621170988715, 3596.0, 3600.0999750062483, 3611.422172452395, 1029.6602121299952, 1033.405791669793, 1033.7622346860264, 1042.5412818359973, 1070.619929924881, 11238.831417528743, 11364.545418183345, 11467.08263338931, 11468.0, 11475.770484590344, 4555.908881822345, 4636.884077898079, 4755.120302744003, 4758.524147585283, 4763.309320148559, 9715.902840971641, 9875.0, 9922.454265015493, 9939.254555908336, 9957.55191016406, 5389.83830485086, 5392.703401312965, 5395.163749618815, 5398.1632846908005, 5401.3518377794135, 4262.914741705211, 4317.309230523164, 4804.447488538793, 4821.951780482221, 4823.927641085386, 3786.261678972574, 3833.7124715646437, 3866.8646597368956, 3952.0317522207242, 3963.9387518490225, 1233.2045830439495, 1245.4582256718356, 1252.3487786351047, 1264.1530174782918, 1267.6830792301926, 857.4983634573845, 861.6036623153294, 876.4828751036791, 895.5566994337714, 953.1278879824882, 5530.336359636869, 5540.4763689985575, 5771.192033115367, 5878.242078498859, 5950.583459157904, 851.5486792000249, 912.6258234123977, 924.8751418558543, 939.0984654731534, 999.4003597841237, 3766.4915236443276, 3812.8284227209842, 3812.8856134316015, 3931.6264954829244, 3941.940870886939, 9779.8753143388, 10087.142592879687, 10431.5827366906, 10447.791044179074, 10461.84307235392, 9449.0, 10321.277510574188, 10434.634787782543, 10446.529906154241, 10448.477576121315, 7720.343770779435, 7967.800804979806, 8130.878036829452, 8139.0, 8191.631376588068, 5762.250907382014, 5866.3547009828035, 5940.049592065248, 5948.1448904525205, 5985.610935289193, 9338.906610933804, 9576.856347154659, 9674.806503869742, 9706.854397183906, 9760.658376956773, 9702.9029709702, 9760.170385517311, 9767.413955162712, 9895.752606184902, 9939.155171810477, 7332.30343117403, 7348.301911318416, 7475.626218689153, 7529.88705169412, 7531.510451820614, 8069.515829050276, 8170.550619715973, 8183.222593853575, 8189.918100818915, 8189.959050204711, 6959.652017399008, 7304.6347682616715, 7327.816804579928, 7414.962925185339, 7466.925330746841, 7073.3987611053635, 7230.530015549183, 7258.74594389215, 7287.672054757442, 7317.158526769277, 6814.454843612598, 6846.726130954706, 6853.040574319699, 6861.965690171517, 6898.827529311607, 4848.490908454562, 4983.775730092082, 4997.1754660482065, 5023.0, 5126.53861152498, 4928.728919909439, 4935.309056732132, 5058.48245526348, 5093.23601459784, 5159.251908473176], "value": 4530.778368129658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.6405536857454, 298.9297515083953, 299.37878901279845, 307.34995484550177, 312.83732459121256, 3785.3186426443262, 4893.730844803535, 5111.6166287528395, 5127.66670166439, 5203.427622961481, 4382.5398333175035, 5029.145045342291, 5040.42035165956, 5052.26742122392, 5091.847244582668, 3755.061234691327, 3908.0, 3924.7628851554628, 3970.9205815883665, 3995.7802320872343, 3876.8836934891856, 3901.1807520420743, 3981.1241526864187, 3985.541662708782, 4006.6994975376965, 3255.3489302139546, 3348.748843836722, 3706.6478684524927, 3922.529051605648, 3957.3866050762035, 3245.6754324567473, 3687.94468082979, 3864.594217607167, 3922.5489068756888, 3958.9208215835665, 3144.7326977206967, 3359.193793489545, 3453.706434953032, 3461.0, 3462.792232466035, 5009.747563109223, 5033.6224783141415, 5045.571126454256, 5049.596032317406, 5068.619853510964, 4327.632151267146, 4505.707129036602, 4529.048899731028, 4543.886402839922, 4551.886202844922, 4915.1398505261795, 5366.792471693877, 5393.6763794172475, 5400.459954004607, 5407.324084489439, 3732.9440058399146, 3799.4870692456443, 3803.6766874815676, 3805.315043292206, 3805.8858234253016, 4787.295178224292, 5420.509359926052, 5618.550515958755, 5688.97155514224, 5712.942870571283, 3539.0975301298517, 3685.2261025184475, 3840.8847734568008, 3872.2255548890334, 3886.319894018592, 3727.3535789589696, 3922.058705910561, 3934.409838524187, 3938.330483817758, 3947.4276229947072, 4022.718409711292, 4040.575739547364, 4193.559676233952, 4197.748135111903, 4500.639948804088, 5119.257707632447, 5371.409144994048, 5399.460053994648, 5428.809991650273, 5464.584634603373, 1158.1892675127444, 1294.8640392758625, 1298.7077907470743, 1304.2826445454962, 1317.5915466205506, 754.4982586579863, 855.1790281329993, 859.0292968945176, 873.7378786364065, 894.7539426657721, 4994.825181118644, 5069.797208111708, 5135.820246291362, 5165.328507294028, 5225.451327610546, 4530.388397566352, 4602.608778253819, 5324.361076670824, 5374.193870919394, 5556.333240011225, 4318.395424640553, 5003.3495645565845, 5084.237364395371, 5094.53571571335, 5106.948930510647, 2533.6302717385834, 2813.268550176928, 2860.8140470869325, 2927.6486821581548, 2935.823850568973, 5322.627416080837, 5654.660720356792, 5709.885802283931, 5727.5131613812455, 5728.255326807488, 4430.6831801837925, 4695.81216751333, 5599.888002239933, 5639.802606908738, 5676.460736230051, 5204.869878253074, 5655.575831812548, 5682.971585142048, 5687.236956543485, 5716.171155182476, 4354.782260886879, 4878.121938051185, 5265.552428043659, 5472.425395333592, 5555.500024988852, 4789.401324834395, 5333.7866485340155, 5408.5109359230955, 5461.890762184814, 5471.562275018068, 4291.506476755213, 4771.618270538279, 5627.52166065889, 5681.068436731531, 5705.0, 3244.3997860395903, 3805.657490825839, 3851.6340947609933, 3855.5951625078965, 3868.2456920900154, 4662.930056049094, 5494.450554944474, 5500.944990550203, 5531.280933478622, 5540.612157148961, 4612.4926258112255, 5378.811741589026, 5395.298611180521, 5395.865103372447, 5428.348598168245, 4814.229723244404, 5091.4144873338555, 5350.652207606493, 5371.946280537145, 5446.183072539151, 5057.342545469065, 5080.974595127001, 5209.697575606098, 5244.213367994678, 5248.685078895279, 4532.388127602863, 4730.445559397886, 4833.73414462208, 5493.423190564933, 5519.448055194448, 5137.5889928806355, 5331.840044798507, 5364.946350536445, 5372.919406208832, 5408.702521361363], "value": 3941.601852322458, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.60821857574, 675.8242856857215, 791.3510921044746, 817.9550124743139, 854.137321305482, 12699.047571432133, 15010.174440405774, 15462.69074618507, 15483.612909677264, 15679.608009799733, 12274.20217685852, 13697.178169309824, 13785.241811700353, 13869.722605547882, 13927.37326820293, 852.4033176776235, 881.5944665453867, 882.2016075451694, 883.8409086364452, 885.8892638420198, 882.554310073412, 883.8806761087235, 884.4516399832113, 885.2431171348501, 888.524639317965, 934.9065093490665, 935.6444551070583, 936.5691781780355, 937.3063932689795, 937.6483818568037, 931.5481991234246, 932.8181004704086, 934.22926085979, 935.5182081228173, 936.180841763457, 663.4360793325635, 684.8424862281653, 692.8302565871394, 694.4236283884364, 694.9200841903196, 14840.0, 14855.331510081964, 14873.776893346609, 14891.404343826234, 14945.850541494554, 12918.547850825176, 13080.41138148776, 13116.672083197996, 13263.204207747565, 13414.731705365935, 12317.815232771516, 12338.938305308506, 12358.196717213443, 12452.252864828139, 12490.43793029316, 4376.671749618791, 4497.842575509874, 4521.751303678297, 4548.704334218265, 4619.9076018479445, 44634.107317853784, 47042.764786176194, 76798.0, 89907.0, 95097.0, 8850.380473366931, 10827.187960902964, 10833.67498975032, 10858.239923205458, 11071.114310855111, 18235.54411139732, 19511.317103901296, 20861.68707469389, 20884.164633414795, 20900.268490602757, 7586.355159811367, 7795.844083118306, 7816.257455541714, 7978.880316795253, 8053.798655033671, 4153.273177193979, 4297.183535128315, 4396.494403143615, 4419.7348159109915, 4482.394876691605, 3475.913102172466, 3494.178867966026, 3558.893233203008, 3607.603163651996, 3613.7831730096277, 590.3358721438382, 655.1057806094647, 666.9166354205724, 673.8113328268092, 673.9049045301385, 541.7020638648728, 556.1435389500125, 625.343389441085, 665.2482694555218, 670.7082419147687, 7485.0643669541305, 8506.89410376647, 8656.740297791077, 8847.867281990775, 8959.148880856308, 659.3143131143653, 659.4823063894916, 666.1373521289844, 671.3253180553512, 687.8039758668856, 4144.334080639761, 4303.505096913832, 4416.977915110404, 4497.977510112429, 4559.202139625619, 87853.0, 108928.0, 109813.0, 113119.0, 116714.0, 52832.0, 67062.66468667724, 76719.0, 93117.60323595151, 93395.53302233445, 60975.0, 83484.58257708672, 83680.0, 84906.57546712227, 85285.0, 9156.93463471172, 9448.48033358172, 9476.57355418994, 9523.0, 9697.127258546765, 39533.40699889446, 48120.27819582639, 48721.512784871695, 49420.75289623529, 52387.47612523826, 67090.66454667696, 70178.0, 70540.0, 70853.0, 72824.27175728175, 12083.214591051905, 12187.268763874195, 12206.75586488283, 12327.69180770488, 12410.5656302029, 13847.653808654864, 13877.375518101508, 14280.0, 14305.0, 14614.342354593857, 12865.163764355288, 12868.742625147257, 12925.418356173806, 13038.217706937614, 13134.802977955147, 12641.747165056464, 12887.871121288666, 13087.934560327138, 13191.208527488381, 13404.530841420894, 12564.434600442819, 13201.943844492609, 13222.471101155847, 13337.599872003855, 13337.866621334051, 10863.0, 10883.510242038968, 10902.022621225857, 11008.449577521253, 11080.889191107986, 8622.223999840044, 8876.955615221883, 9094.772630684021, 10484.895151048697, 10843.728906777395], "value": 7293.23222283923, "unit": "score"}], "name": "dromaeo_css", "value": 7128.0605541435525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 112.0, 110.0, 112.0, 114.0, 111.0, 111.0, 111.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 116.0, 115.0, 152.0, 115.0, 118.0, 141.0, 110.0, 176.0, 144.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 182.0, 185.0, 184.0, 180.0, 181.0, 180.0, 182.0, 181.0], "value": 181.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 58.0, 91.0, 61.0, 73.0, 81.0, 82.0, 72.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 94.0, 69.0, 67.0, 67.0, 91.0, 66.0, 67.0, 90.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 84.0, 73.0, 114.0, 106.0, 84.0, 87.0, 84.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 79.0, 79.0, 80.0, 81.0, 82.0, 83.0, 80.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 54.0, 55.0, 55.0, 55.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 74.0, 79.0, 76.0, 72.0, 72.0, 70.0, 69.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 91.0, 89.0, 86.0, 90.0, 87.0, 85.0, 85.0, 88.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 151.0, 141.0, 141.0, 146.0, 147.0, 236.0, 148.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 241.0, 174.0, 173.0, 173.0, 177.0, 171.0, 175.0, 174.0, 172.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1465.4999999999998, "alertThreshold": 2.0}]} 01:12:03 INFO - Return code: 0 01:12:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:12:03 INFO - # TBPL SUCCESS # 01:12:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:12:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:12:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:12:03 INFO - 2016-10-26 01:12:03.961 screenresolution[2253:24980] starting screenresolution argv=screenresolution get 01:12:03 INFO - 2016-10-26 01:12:03.963 screenresolution[2253:24980] Display 0: 1600x1200x32@60 01:12:03 INFO - 2016-10-26 01:12:03.970 screenresolution[2254:24984] starting screenresolution argv=screenresolution list 01:12:03 INFO - Available Modes on Display 0 01:12:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:12:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:12:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:12:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:12:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:12:04 INFO - Intel Iris: 01:12:04 INFO - Chipset Model: Intel Iris 01:12:04 INFO - Type: GPU 01:12:04 INFO - Bus: Built-In 01:12:04 INFO - VRAM (Dynamic, Max): 1536 MB 01:12:04 INFO - Vendor: Intel (0x8086) 01:12:04 INFO - Device ID: 0x0a2e 01:12:04 INFO - Revision ID: 0x0009 01:12:04 INFO - Displays: 01:12:04 INFO - Display: 01:12:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:12:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:12:04 INFO - Display Serial Number: 1600x1200 60 01:12:04 INFO - Main Display: Yes 01:12:04 INFO - Mirror: Off 01:12:04 INFO - Online: Yes 01:12:04 INFO - Rotation: Supported 01:12:04 INFO - Return code: 0 01:12:04 INFO - Running post-action listener: _resource_record_post_action 01:12:04 INFO - [mozharness: 2016-10-26 08:12:04.210579Z] Finished run-tests step (success) 01:12:04 INFO - Running post-run listener: _resource_record_post_run 01:12:04 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 552960; Write bytes: 705779712; Read time: 6; Write time: 1977 01:12:04 INFO - TinderboxPrint: CPU usage
53.4% 01:12:04 INFO - TinderboxPrint: I/O read bytes / time
552,960 / 6 01:12:04 INFO - TinderboxPrint: I/O write bytes / time
705,779,712 / 1,977 01:12:04 INFO - TinderboxPrint: CPU idle
2,263.5 (46.6%) 01:12:04 INFO - TinderboxPrint: CPU system
969.2 (20.0%) 01:12:04 INFO - TinderboxPrint: CPU user
1,625.0 (33.5%) 01:12:04 INFO - TinderboxPrint: Swap in / out
404,238,336 / 0 01:12:04 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388749824; Write bytes: 382818304; Read time: 29914; Write time: 795 01:12:04 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 552960; Write bytes: 299188224; Read time: 6; Write time: 1121 01:12:04 INFO - Running post-run listener: _upload_blobber_files 01:12:04 INFO - Blob upload gear active. 01:12:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:12:04 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 01:12:04 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'] 01:12:04 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 01:12:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:06 INFO - (blobuploader) - INFO - Done attempting. 01:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:07 INFO - (blobuploader) - INFO - Done attempting. 01:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:12:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:12:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:12:10 INFO - (blobuploader) - INFO - Done attempting. 01:12:10 INFO - (blobuploader) - INFO - Iteration through files over. 01:12:10 INFO - Return code: 0 01:12:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:12:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:12:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5d345821c51b225f4f3da1d7894dc806926dd9a032004ca37ceca739bc0d2a63a4f824d6243041e72f110f16de2a66b32b966e7af2c0b96d9b44079c48e6344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434a361fe65c2d88c45536ed1d00838b330e4772036c446512fbd03eab8f52694ccb76be0e352c0552320cf768d49e801f5b5ae0497fde5fd3b50edf38b366a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44029b7b238eea815b21d8ac24befa31c5bc45749f7ef6c8c4d37c1df5b3458384940213028dd27c147012e19049555ea046699e12e3743854cc41f8426d2e68"} 01:12:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:12:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:12:10 INFO - Contents: 01:12:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5d345821c51b225f4f3da1d7894dc806926dd9a032004ca37ceca739bc0d2a63a4f824d6243041e72f110f16de2a66b32b966e7af2c0b96d9b44079c48e6344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434a361fe65c2d88c45536ed1d00838b330e4772036c446512fbd03eab8f52694ccb76be0e352c0552320cf768d49e801f5b5ae0497fde5fd3b50edf38b366a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44029b7b238eea815b21d8ac24befa31c5bc45749f7ef6c8c4d37c1df5b3458384940213028dd27c147012e19049555ea046699e12e3743854cc41f8426d2e68"} 01:12:10 INFO - Running post-run listener: copy_logs_to_upload_dir 01:12:10 INFO - Copying logs to upload dir... 01:12:10 INFO - mkdir: /builds/slave/test/build/upload/logs 01:12:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.375711 ========= master_lag: 1.31 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-26 01:12:11.903600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 01:12:11.906562) ========= 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.5uNaK3m108/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.AAil1shxRY/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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/f5d345821c51b225f4f3da1d7894dc806926dd9a032004ca37ceca739bc0d2a63a4f824d6243041e72f110f16de2a66b32b966e7af2c0b96d9b44079c48e6344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434a361fe65c2d88c45536ed1d00838b330e4772036c446512fbd03eab8f52694ccb76be0e352c0552320cf768d49e801f5b5ae0497fde5fd3b50edf38b366a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44029b7b238eea815b21d8ac24befa31c5bc45749f7ef6c8c4d37c1df5b3458384940213028dd27c147012e19049555ea046699e12e3743854cc41f8426d2e68"} build_url:https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/RGne5VwUShaAj-qCqePJyw/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/f5d345821c51b225f4f3da1d7894dc806926dd9a032004ca37ceca739bc0d2a63a4f824d6243041e72f110f16de2a66b32b966e7af2c0b96d9b44079c48e6344", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434a361fe65c2d88c45536ed1d00838b330e4772036c446512fbd03eab8f52694ccb76be0e352c0552320cf768d49e801f5b5ae0497fde5fd3b50edf38b366a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44029b7b238eea815b21d8ac24befa31c5bc45749f7ef6c8c4d37c1df5b3458384940213028dd27c147012e19049555ea046699e12e3743854cc41f8426d2e68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 01:12:11.942519) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:12:11.942962) ========= 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.5uNaK3m108/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.AAil1shxRY/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 01:12:11.990983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 01:12:11.991296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 01:12:11.991631) ========= ========= Total master_lag: 1.46 =========