builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0356 starttime: 1475582899.83 results: success (0) buildid: 20161004025701 builduid: 7983b3d6adf648f4a87109c38a4a04ba revision: 6bfa0e8a9f20f8c700e0ef60021449bc8cbc8601 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:19.827046) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:19.827665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:19.827939) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:19.854687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:19.855223) ========= 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.tKENF8I0U3/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.OZckCxaqVo/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-04 05:08:19-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 184M=0s 2016-10-04 05:08:19 (184 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:19.969634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:19.969919) ========= 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.tKENF8I0U3/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.OZckCxaqVo/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.025749 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:20.017420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 05:08:20.017727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6bfa0e8a9f20f8c700e0ef60021449bc8cbc8601 --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 6bfa0e8a9f20f8c700e0ef60021449bc8cbc8601 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tKENF8I0U3/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.OZckCxaqVo/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-04 05:08:20,093 truncating revision to first 12 chars 2016-10-04 05:08:20,093 Setting DEBUG logging. 2016-10-04 05:08:20,093 attempt 1/10 2016-10-04 05:08:20,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6bfa0e8a9f20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 05:08:21,266 unpacking tar archive at: mozilla-central-6bfa0e8a9f20/testing/mozharness/ program finished with exit code 0 elapsedTime=1.429594 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 05:08:21.469109) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:21.469627) ========= script_repo_revision: 6bfa0e8a9f20f8c700e0ef60021449bc8cbc8601 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:21.470277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:21.470716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 05:08:21.490611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 05:08:21.490993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tKENF8I0U3/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.OZckCxaqVo/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:08:21 INFO - MultiFileLogger online at 20161004 05:08:21 in /builds/slave/test 05:08:21 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 05:08:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:21 INFO - {'append_to_log': False, 05:08:21 INFO - 'base_work_dir': '/builds/slave/test', 05:08:21 INFO - 'blob_upload_branch': 'Firefox', 05:08:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:21 INFO - 'branch': 'Firefox', 05:08:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:21 INFO - 'config_files': ('talos/mac_config.py',), 05:08:21 INFO - 'default_actions': ('clobber', 05:08:21 INFO - 'read-buildbot-config', 05:08:21 INFO - 'download-and-extract', 05:08:21 INFO - 'populate-webroot', 05:08:21 INFO - 'create-virtualenv', 05:08:21 INFO - 'install', 05:08:21 INFO - 'run-tests'), 05:08:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:21 INFO - 'download_minidump_stackwalk': True, 05:08:21 INFO - 'download_symbols': 'ondemand', 05:08:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:21 INFO - 'installer_path': 'installer.exe', 05:08:21 INFO - 'log_level': 'info', 05:08:21 INFO - 'log_name': 'talos', 05:08:21 INFO - 'log_to_console': True, 05:08:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:08:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:08:21 INFO - 'opt_config_files': (), 05:08:21 INFO - 'pip_index': False, 05:08:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:21 INFO - 'cmd': ('bash', 05:08:21 INFO - '-c', 05:08:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:21 INFO - 'enabled': True, 05:08:21 INFO - 'halt_on_failure': False, 05:08:21 INFO - 'name': 'check_screen_resolution'},), 05:08:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:21 INFO - 'cmd': ('bash', 05:08:21 INFO - '-c', 05:08:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:21 INFO - 'enabled': True, 05:08:21 INFO - 'halt_on_failure': False, 05:08:21 INFO - 'name': 'check_screen_resolution'},), 05:08:21 INFO - 'run_cmd_checks_enabled': True, 05:08:21 INFO - 'sps_profile': False, 05:08:21 INFO - 'sps_profile_interval': 0, 05:08:21 INFO - 'suite': 'dromaeojs', 05:08:21 INFO - 'system_bits': '32', 05:08:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:21 INFO - 'title': 't-yosemite-r7-0356', 05:08:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:21 INFO - 'use_talos_json': True, 05:08:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:21 INFO - 'work_dir': 'build'} 05:08:21 INFO - [mozharness: 2016-10-04 12:08:21.675155Z] Running clobber step. 05:08:21 INFO - Running pre-action listener: _resource_record_pre_action 05:08:21 INFO - Running main action method: clobber 05:08:21 INFO - rmtree: /builds/slave/test/build 05:08:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:23 INFO - Running post-action listener: _resource_record_post_action 05:08:23 INFO - [mozharness: 2016-10-04 12:08:23.784976Z] Finished clobber step (success) 05:08:23 INFO - [mozharness: 2016-10-04 12:08:23.785103Z] Running read-buildbot-config step. 05:08:23 INFO - Running pre-action listener: _resource_record_pre_action 05:08:23 INFO - Running main action method: read_buildbot_config 05:08:23 INFO - Using buildbot properties: 05:08:23 INFO - { 05:08:23 INFO - "project": "", 05:08:23 INFO - "product": "firefox", 05:08:23 INFO - "script_repo_revision": "production", 05:08:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:08:23 INFO - "repository": "", 05:08:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:08:23 INFO - "buildid": "20161004025701", 05:08:23 INFO - "pgo_build": "False", 05:08:23 INFO - "basedir": "/builds/slave/test", 05:08:23 INFO - "buildnumber": 30, 05:08:23 INFO - "slavename": "t-yosemite-r7-0356", 05:08:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:08:23 INFO - "platform": "yosemite_r7", 05:08:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:08:23 INFO - "branch": "mozilla-central", 05:08:23 INFO - "repo_path": "mozilla-central", 05:08:23 INFO - "revision": "6bfa0e8a9f20f8c700e0ef60021449bc8cbc8601", 05:08:23 INFO - "stage_platform": "macosx64", 05:08:23 INFO - "builduid": "7983b3d6adf648f4a87109c38a4a04ba", 05:08:23 INFO - "slavebuilddir": "test" 05:08:23 INFO - } 05:08:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:08:23 INFO - Running post-action listener: _resource_record_post_action 05:08:23 INFO - [mozharness: 2016-10-04 12:08:23.788391Z] Finished read-buildbot-config step (success) 05:08:23 INFO - [mozharness: 2016-10-04 12:08:23.788514Z] Running download-and-extract step. 05:08:23 INFO - Running pre-action listener: _resource_record_pre_action 05:08:23 INFO - Running main action method: download_and_extract 05:08:23 INFO - mkdir: /builds/slave/test/build/tests 05:08: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')]} 05:08:23 INFO - trying https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:08:23 INFO - Downloading https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/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 05:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/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 05:08:25 INFO - Downloaded 1199 bytes. 05:08:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:08:25 INFO - Using the following test package requirements: 05:08:25 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:08:25 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:25 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:08:25 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'jsshell-mac.zip'], 05:08:25 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:08:25 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:08:25 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:08:25 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:08:25 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:08:25 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:08:25 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:08:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:25 INFO - Fetch https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:08:25 INFO - Http code: 200 05:08:25 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 05:08:25 INFO - x-amz-cf-id: SQPMMjVNp0tEqvQJospbjUNHi9Vzc6PhmRAFa508MK0bLBVfMlfrig== 05:08:25 INFO - x-amz-version-id: 1M68Tvxjnhn.F4ebeygnInQgBYILDeYz 05:08:26 INFO - Expected file size: 16476558 05:08:26 INFO - Obtained file size: 16476558 05:08:32 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 05:08:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:08:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:32 INFO - Fetch https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:08:33 INFO - Http code: 200 05:08:33 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 05:08:33 INFO - x-amz-cf-id: o6Oyo6JtyTKRnc8SQFgR8E5BkCtWXaMP2YLFKRAYxhihTfU_-cGpIg== 05:08:33 INFO - x-amz-version-id: 1M68Tvxjnhn.F4ebeygnInQgBYILDeYz 05:08:33 INFO - Expected file size: 16476558 05:08:33 INFO - Obtained file size: 16476558 05:08:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:08:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:08:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:08:40 INFO - Http code: 200 05:08:40 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 05:08:40 INFO - x-amz-cf-id: j1lMvdxS3p0AGcdnGpn4V9CWe7KB8AxUDaEgjhd0z1lymJeMYzSICQ== 05:08:40 INFO - x-amz-version-id: rQPwlmNWIpXdQEXw8zIkloGMSHt9.hQd 05:08:41 INFO - Expected file size: 14409006 05:08:41 INFO - Obtained file size: 14409006 05:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:41 INFO - trying https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:08:41 INFO - Downloading https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/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 05:08:44 INFO - Downloaded 111672722 bytes. 05:08:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:08:44 INFO - mkdir: /builds/slave/test/properties 05:08:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:44 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:44 INFO - Contents: 05:08:44 INFO - build_url:https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:08:44 INFO - Running post-action listener: _resource_record_post_action 05:08:44 INFO - Running post-action listener: set_extra_try_arguments 05:08:44 INFO - [mozharness: 2016-10-04 12:08:44.877628Z] Finished download-and-extract step (success) 05:08:44 INFO - [mozharness: 2016-10-04 12:08:44.877748Z] Running populate-webroot step. 05:08:44 INFO - Running pre-action listener: _resource_record_pre_action 05:08:44 INFO - Running main action method: populate_webroot 05:08:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:44 INFO - '--tppagecycles', 05:08:44 INFO - '7'], 05:08:44 INFO - 'tests': ['tsvgm']}}, 05:08:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['damp', 'tps']}, 05:08:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'tests': ['damp', 'tps']}, 05:08:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['dromaeo_dom']}, 05:08:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['basic_compositor_video']}, 05:08:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:08:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['a11yr', 05:08:44 INFO - 'ts_paint', 05:08:44 INFO - 'tpaint', 05:08:44 INFO - 'sessionrestore', 05:08:44 INFO - 'sessionrestore_no_auto_restore', 05:08:44 INFO - 'tabpaint']}, 05:08:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:44 INFO - 'ts_paint', 05:08:44 INFO - 'tpaint', 05:08:44 INFO - 'sessionrestore', 05:08:44 INFO - 'sessionrestore_no_auto_restore', 05:08:44 INFO - 'tabpaint']}, 05:08:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:44 INFO - 'ts_paint', 05:08:44 INFO - 'tpaint', 05:08:44 INFO - 'sessionrestore', 05:08:44 INFO - 'sessionrestore_no_auto_restore', 05:08:44 INFO - 'tabpaint']}, 05:08:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:44 INFO - 'ts_paint', 05:08:44 INFO - 'tpaint', 05:08:44 INFO - 'sessionrestore', 05:08:44 INFO - 'sessionrestore_no_auto_restore', 05:08:44 INFO - 'tabpaint']}, 05:08:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['a11yr', 05:08:44 INFO - 'ts_paint', 05:08:44 INFO - 'tpaint', 05:08:44 INFO - 'sessionrestore', 05:08:44 INFO - 'sessionrestore_no_auto_restore', 05:08:44 INFO - 'tabpaint']}, 05:08:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['a11yr', 05:08:44 INFO - 'ts_paint', 05:08:44 INFO - 'tpaint', 05:08:44 INFO - 'sessionrestore', 05:08:44 INFO - 'sessionrestore_no_auto_restore', 05:08:44 INFO - 'tabpaint']}, 05:08:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['tsvgx', 05:08:44 INFO - 'tsvgr_opacity', 05:08:44 INFO - 'tart', 05:08:44 INFO - 'tscrollx', 05:08:44 INFO - 'cart']}, 05:08:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:44 INFO - 'tsvgr_opacity', 05:08:44 INFO - 'tart', 05:08:44 INFO - 'tscrollx', 05:08:44 INFO - 'cart']}, 05:08:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'talos_options': ['--disable-e10s'], 05:08:44 INFO - 'tests': ['tp5o']}, 05:08:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'tests': ['tp5o']}, 05:08:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'talos_options': ['--disable-e10s', 05:08:44 INFO - '--xperf_path', 05:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:44 INFO - 'tests': ['tp5n']}, 05:08:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:44 INFO - 'talos_options': ['--xperf_path', 05:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:44 INFO - 'tests': ['tp5n']}}, 05:08:44 INFO - 'talos.zip': {'path': '', 05:08:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:44 INFO - Running post-action listener: _resource_record_post_action 05:08:44 INFO - [mozharness: 2016-10-04 12:08:44.896927Z] Finished populate-webroot step (success) 05:08:44 INFO - [mozharness: 2016-10-04 12:08:44.897038Z] Running create-virtualenv step. 05:08:44 INFO - Running pre-action listener: _resource_record_pre_action 05:08:44 INFO - Running main action method: create_virtualenv 05:08:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:44 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 05:08:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:45 INFO - Using real prefix '/tools/python27' 05:08:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:48 INFO - Installing pip.................done. 05:08:48 INFO - Return code: 0 05:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:08:48 INFO - Reading from file tmpfile_stdout 05:08:48 INFO - Output received: 05:08:48 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) 05:08:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:08: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', 'pip>=1.5'] in /builds/slave/test/build 05:08: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 pip>=1.5 05:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:48 INFO - 'HOME': '/Users/cltbld', 05:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:48 INFO - 'LOGNAME': 'cltbld', 05:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:48 INFO - 'MOZ_NO_REMOTE': '1', 05:08:48 INFO - 'NO_EM_RESTART': '1', 05:08:48 INFO - 'PAGER': '/bin/cat', 05:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:48 INFO - 'PWD': '/builds/slave/test', 05:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:48 INFO - 'SHELL': '/bin/bash', 05:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:08:48 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:48 INFO - 'USER': 'cltbld', 05:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:48 INFO - 'XPC_FLAGS': '0x0', 05:08:48 INFO - 'XPC_SERVICE_NAME': '0', 05:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:49 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 05:08:49 INFO - Cleaning up... 05:08:49 INFO - Return code: 0 05:08:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:49 INFO - 'HOME': '/Users/cltbld', 05:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:49 INFO - 'LOGNAME': 'cltbld', 05:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:49 INFO - 'MOZ_NO_REMOTE': '1', 05:08:49 INFO - 'NO_EM_RESTART': '1', 05:08:49 INFO - 'PAGER': '/bin/cat', 05:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:49 INFO - 'PWD': '/builds/slave/test', 05:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:49 INFO - 'SHELL': '/bin/bash', 05:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:08:49 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:49 INFO - 'USER': 'cltbld', 05:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:49 INFO - 'XPC_FLAGS': '0x0', 05:08:49 INFO - 'XPC_SERVICE_NAME': '0', 05:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:49 INFO - Downloading/unpacking psutil>=3.1.1 05:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:52 INFO - Installing collected packages: psutil 05:08:52 INFO - Running setup.py install for psutil 05:08:52 INFO - building 'psutil._psutil_osx' extension 05:08:52 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 05:08:53 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 05:08:53 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 05:08:53 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 05:08:53 INFO - building 'psutil._psutil_posix' extension 05:08:53 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 05:08:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:53 INFO - ^ 05:08:53 INFO - 1 warning generated. 05:08:53 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 05:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:53 INFO - Successfully installed psutil 05:08:53 INFO - Cleaning up... 05:08:53 INFO - Return code: 0 05:08:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:53 INFO - 'HOME': '/Users/cltbld', 05:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:53 INFO - 'LOGNAME': 'cltbld', 05:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:53 INFO - 'MOZ_NO_REMOTE': '1', 05:08:53 INFO - 'NO_EM_RESTART': '1', 05:08:53 INFO - 'PAGER': '/bin/cat', 05:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:53 INFO - 'PWD': '/builds/slave/test', 05:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:53 INFO - 'SHELL': '/bin/bash', 05:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:08:53 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:53 INFO - 'USER': 'cltbld', 05:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:53 INFO - 'XPC_FLAGS': '0x0', 05:08:53 INFO - 'XPC_SERVICE_NAME': '0', 05:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:08:56 INFO - Installing collected packages: mozsystemmonitor 05:08:56 INFO - Running setup.py install for mozsystemmonitor 05:08:56 INFO - Successfully installed mozsystemmonitor 05:08:56 INFO - Cleaning up... 05:08:57 INFO - Return code: 0 05:08:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:08:57 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')]} 05:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:57 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')]} 05:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:57 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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:08:57 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 05:08:57 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 05:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:57 INFO - 'HOME': '/Users/cltbld', 05:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:57 INFO - 'LOGNAME': 'cltbld', 05:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:57 INFO - 'MOZ_NO_REMOTE': '1', 05:08:57 INFO - 'NO_EM_RESTART': '1', 05:08:57 INFO - 'PAGER': '/bin/cat', 05:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:57 INFO - 'PWD': '/builds/slave/test', 05:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:57 INFO - 'SHELL': '/bin/bash', 05:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:08:57 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:57 INFO - 'USER': 'cltbld', 05:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:57 INFO - 'XPC_FLAGS': '0x0', 05:08:57 INFO - 'XPC_SERVICE_NAME': '0', 05:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:57 INFO - Downloading/unpacking jsonschema==2.5.1 05:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:08:59 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 05:08:59 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 05:08:59 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 05:08:59 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 05:08:59 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 05:08:59 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 05:09:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:00 INFO - warning: no files found matching '*.txt' 05:09:00 INFO - no previously-included directories found matching 'build' 05:09:00 INFO - no previously-included directories found matching 'dist' 05:09:00 INFO - no previously-included directories found matching '.git*' 05:09:00 INFO - Installing collected packages: jsonschema, functools32 05:09:00 INFO - Running setup.py install for functools32 05:09:00 INFO - warning: no files found matching '*.txt' 05:09:00 INFO - no previously-included directories found matching 'build' 05:09:00 INFO - no previously-included directories found matching 'dist' 05:09:00 INFO - no previously-included directories found matching '.git*' 05:09:00 INFO - Successfully installed jsonschema functools32 05:09:00 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:09:00 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 05:09:00 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 05:09:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:09:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:00 INFO - 'HOME': '/Users/cltbld', 05:09:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:00 INFO - 'LOGNAME': 'cltbld', 05:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:00 INFO - 'MOZ_NO_REMOTE': '1', 05:09:00 INFO - 'NO_EM_RESTART': '1', 05:09:00 INFO - 'PAGER': '/bin/cat', 05:09:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:00 INFO - 'PWD': '/builds/slave/test', 05:09:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:00 INFO - 'SHELL': '/bin/bash', 05:09:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:09:00 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:09:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:00 INFO - 'USER': 'cltbld', 05:09:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:00 INFO - 'XPC_FLAGS': '0x0', 05:09:00 INFO - 'XPC_SERVICE_NAME': '0', 05:09:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:09:00 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:00 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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:09:00 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 05:09:00 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 05:09:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:09:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:00 INFO - 'HOME': '/Users/cltbld', 05:09:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:00 INFO - 'LOGNAME': 'cltbld', 05:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:00 INFO - 'MOZ_NO_REMOTE': '1', 05:09:00 INFO - 'NO_EM_RESTART': '1', 05:09:00 INFO - 'PAGER': '/bin/cat', 05:09:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:00 INFO - 'PWD': '/builds/slave/test', 05:09:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:00 INFO - 'SHELL': '/bin/bash', 05:09:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:09:00 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:09:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:00 INFO - 'USER': 'cltbld', 05:09:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:00 INFO - 'XPC_FLAGS': '0x0', 05:09:00 INFO - 'XPC_SERVICE_NAME': '0', 05:09:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:04 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 05:09:04 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 05:09:04 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 05:09:04 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 05:09:04 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 05:09:04 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 05:09:04 INFO - Downloading docopt-0.6.1.tar.gz 05:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:04 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:04 INFO - Running setup.py install for blobuploader 05:09:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:04 INFO - Running setup.py install for requests 05:09:05 INFO - Running setup.py install for docopt 05:09:05 INFO - Successfully installed blobuploader requests docopt 05:09:05 INFO - Cleaning up... 05:09:05 INFO - Return code: 0 05:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:05 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')]} 05:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:05 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')]} 05:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:05 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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:09:05 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 05:09:05 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 05:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:05 INFO - 'HOME': '/Users/cltbld', 05:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:05 INFO - 'LOGNAME': 'cltbld', 05:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:05 INFO - 'MOZ_NO_REMOTE': '1', 05:09:05 INFO - 'NO_EM_RESTART': '1', 05:09:05 INFO - 'PAGER': '/bin/cat', 05:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:05 INFO - 'PWD': '/builds/slave/test', 05:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:05 INFO - 'SHELL': '/bin/bash', 05:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:09:05 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:05 INFO - 'USER': 'cltbld', 05:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:05 INFO - 'XPC_FLAGS': '0x0', 05:09:05 INFO - 'XPC_SERVICE_NAME': '0', 05:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:05 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-mUNShK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-WduZO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-TUUAde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-EQhd4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-pl9kTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-mEGF7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-_euTzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-nq3NDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ktKEr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:06 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-hzS392-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ODE7TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-5nqtvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-dp6uhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Jgw0UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Wx9xDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-LVBCDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:07 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-iw0VUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:07 INFO - Running setup.py install for manifestparser 05:09:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:07 INFO - Running setup.py install for mozcrash 05:09:08 INFO - Running setup.py install for mozdebug 05:09:08 INFO - Running setup.py install for mozdevice 05:09:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for mozfile 05:09:08 INFO - Running setup.py install for mozhttpd 05:09:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for mozinfo 05:09:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for mozInstall 05:09:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for mozleak 05:09:09 INFO - Running setup.py install for mozlog 05:09:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Running setup.py install for moznetwork 05:09:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Running setup.py install for mozprocess 05:09:09 INFO - Running setup.py install for mozprofile 05:09:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Running setup.py install for mozrunner 05:09:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Running setup.py install for mozscreenshot 05:09:10 INFO - Running setup.py install for moztest 05:09:10 INFO - Running setup.py install for mozversion 05:09:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:10 INFO - Cleaning up... 05:09:10 INFO - Return code: 0 05:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:10 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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:09:10 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 05:09:10 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 05:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:10 INFO - 'HOME': '/Users/cltbld', 05:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:10 INFO - 'LOGNAME': 'cltbld', 05:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:10 INFO - 'MOZ_NO_REMOTE': '1', 05:09:10 INFO - 'NO_EM_RESTART': '1', 05:09:10 INFO - 'PAGER': '/bin/cat', 05:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:10 INFO - 'PWD': '/builds/slave/test', 05:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:10 INFO - 'SHELL': '/bin/bash', 05:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:09:10 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:10 INFO - 'USER': 'cltbld', 05:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:10 INFO - 'XPC_FLAGS': '0x0', 05:09:10 INFO - 'XPC_SERVICE_NAME': '0', 05:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:10 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-JWrPsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:10 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)) 05:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:10 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-nqHURM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:10 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)) 05:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:10 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-owNdeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:10 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)) 05:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:10 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-QfFYHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-pFtKv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-YDchvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-MBlu1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-xsroNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-MeMqjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-CAO7oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-dRRJfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-EggrNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:11 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)) 05:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:11 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-wml296-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:12 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)) 05:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-mIMOYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:12 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)) 05:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-mJD8cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:12 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)) 05:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-jrB7at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:12 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)) 05:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:12 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-_HtvRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:12 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)) 05:09:12 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)) 05:09:12 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)) 05:09:12 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)) 05:09:12 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)) 05:09:12 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)) 05:09:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:12 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 05:09:12 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 05:09:12 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 05:09:12 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 05:09:12 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 05:09:12 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 05:09:14 INFO - Downloading blessings-1.6.tar.gz 05:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:14 INFO - Installing collected packages: blessings 05:09:14 INFO - Running setup.py install for blessings 05:09:15 INFO - Successfully installed blessings 05:09:15 INFO - Cleaning up... 05:09:15 INFO - Return code: 0 05:09:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:15 INFO - Reading from file tmpfile_stdout 05:09:15 INFO - Current package versions: 05:09:15 INFO - blessings == 1.6 05:09:15 INFO - blobuploader == 1.2.4 05:09:15 INFO - docopt == 0.6.1 05:09:15 INFO - functools32 == 3.2.3-2 05:09:15 INFO - jsonschema == 2.5.1 05:09:15 INFO - manifestparser == 1.1 05:09:15 INFO - mozInstall == 1.12 05:09:15 INFO - mozcrash == 0.17 05:09:15 INFO - mozdebug == 0.1 05:09:15 INFO - mozdevice == 0.48 05:09:15 INFO - mozfile == 1.2 05:09:15 INFO - mozhttpd == 0.7 05:09:15 INFO - mozinfo == 0.9 05:09:15 INFO - mozleak == 0.1 05:09:15 INFO - mozlog == 3.4 05:09:15 INFO - moznetwork == 0.27 05:09:15 INFO - mozprocess == 0.23 05:09:15 INFO - mozprofile == 0.28 05:09:15 INFO - mozrunner == 6.12 05:09:15 INFO - mozscreenshot == 0.1 05:09:15 INFO - mozsystemmonitor == 0.3 05:09:15 INFO - moztest == 0.7 05:09:15 INFO - mozversion == 1.4 05:09:15 INFO - psutil == 3.1.1 05:09:15 INFO - requests == 1.2.3 05:09:15 INFO - wsgiref == 0.1.2 05:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:15 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')]} 05:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:15 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')]} 05:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:09:16 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 05:09:16 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 05:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:16 INFO - 'HOME': '/Users/cltbld', 05:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:16 INFO - 'LOGNAME': 'cltbld', 05:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:16 INFO - 'MOZ_NO_REMOTE': '1', 05:09:16 INFO - 'NO_EM_RESTART': '1', 05:09:16 INFO - 'PAGER': '/bin/cat', 05:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:16 INFO - 'PWD': '/builds/slave/test', 05:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:16 INFO - 'SHELL': '/bin/bash', 05:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:09:16 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:16 INFO - 'USER': 'cltbld', 05:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:16 INFO - 'XPC_FLAGS': '0x0', 05:09:16 INFO - 'XPC_SERVICE_NAME': '0', 05:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 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)) 05:09:16 INFO - Cleaning up... 05:09:16 INFO - Return code: 0 05:09:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 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 0x1057f9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10576f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, '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.tKENF8I0U3/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.OZckCxaqVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 05:09:16 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 05:09:16 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 05:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:16 INFO - 'HOME': '/Users/cltbld', 05:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:16 INFO - 'LOGNAME': 'cltbld', 05:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:16 INFO - 'MOZ_NO_REMOTE': '1', 05:09:16 INFO - 'NO_EM_RESTART': '1', 05:09:16 INFO - 'PAGER': '/bin/cat', 05:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:16 INFO - 'PWD': '/builds/slave/test', 05:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:16 INFO - 'SHELL': '/bin/bash', 05:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:09:16 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:16 INFO - 'USER': 'cltbld', 05:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:16 INFO - 'XPC_FLAGS': '0x0', 05:09:16 INFO - 'XPC_SERVICE_NAME': '0', 05:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:17 INFO - Cleaning up... 05:09:17 INFO - Return code: 0 05:09:17 INFO - Running post-action listener: _resource_record_post_action 05:09:17 INFO - Running post-action listener: _start_resource_monitoring 05:09:17 INFO - Starting resource monitoring. 05:09:17 INFO - [mozharness: 2016-10-04 12:09:17.175606Z] Finished create-virtualenv step (success) 05:09:17 INFO - [mozharness: 2016-10-04 12:09:17.176627Z] Running install step. 05:09:17 INFO - Running pre-action listener: _resource_record_pre_action 05:09:17 INFO - Running main action method: install 05:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:17 INFO - Reading from file tmpfile_stdout 05:09:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:17 INFO - Reading from file tmpfile_stdout 05:09:17 INFO - Output received: 05:09:17 INFO - Usage: mozinstall [options] installer 05:09:17 INFO - Options: 05:09:17 INFO - -h, --help show this help message and exit 05:09:17 INFO - -d DEST, --destination=DEST 05:09:17 INFO - Directory to install application into. [default: 05:09:17 INFO - "/builds/slave/test"] 05:09:17 INFO - --app=APP Application being installed. [default: firefox] 05:09:17 INFO - mkdir: /builds/slave/test/build/application 05:09:17 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'] 05:09:17 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 05:09:51 INFO - Reading from file tmpfile_stdout 05:09:51 INFO - Output received: 05:09:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:09:51 INFO - Running post-action listener: _resource_record_post_action 05:09:51 INFO - [mozharness: 2016-10-04 12:09:51.760834Z] Finished install step (success) 05:09:51 INFO - [mozharness: 2016-10-04 12:09:51.760969Z] Running run-tests step. 05:09:51 INFO - Running pre-action listener: _resource_record_pre_action 05:09:51 INFO - Running main action method: run_tests 05:09:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:51 INFO - 2016-10-04 05:09:51.775 screenresolution[1638:7398] starting screenresolution argv=screenresolution get 05:09:51 INFO - 2016-10-04 05:09:51.777 screenresolution[1638:7398] Display 0: 1600x1200x32@60 05:09:51 INFO - 2016-10-04 05:09:51.783 screenresolution[1639:7400] starting screenresolution argv=screenresolution list 05:09:51 INFO - Available Modes on Display 0 05:09:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:52 INFO - Intel Iris: 05:09:52 INFO - Chipset Model: Intel Iris 05:09:52 INFO - Type: GPU 05:09:52 INFO - Bus: Built-In 05:09:52 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:52 INFO - Vendor: Intel (0x8086) 05:09:52 INFO - Device ID: 0x0a2e 05:09:52 INFO - Revision ID: 0x0009 05:09:52 INFO - Displays: 05:09:52 INFO - Display: 05:09:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:52 INFO - Display Serial Number: 1600x1200 60 05:09:52 INFO - Main Display: Yes 05:09:52 INFO - Mirror: Off 05:09:52 INFO - Online: Yes 05:09:52 INFO - Rotation: Supported 05:09:52 INFO - Return code: 0 05:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:52 INFO - Python 2.7.3 05:09:52 INFO - Return code: 0 05:09:52 INFO - grabbing minidump binary from tooltool 05:09:52 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')]} 05:09:52 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 0x10560dd30>, '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 0x105433db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105605b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:52 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 05:09:52 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 05:09:52 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 05:09:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:52 INFO - Return code: 0 05:09:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:52 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/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--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 05:09:52 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/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0356 --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 05:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKENF8I0U3/Render', 05:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:52 INFO - 'HOME': '/Users/cltbld', 05:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:52 INFO - 'LOGNAME': 'cltbld', 05:09:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:52 INFO - 'MOZ_NO_REMOTE': '1', 05:09:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:52 INFO - 'NO_EM_RESTART': '1', 05:09:52 INFO - 'PAGER': '/bin/cat', 05:09:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:52 INFO - 'PWD': '/builds/slave/test', 05:09:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:52 INFO - 'SHELL': '/bin/bash', 05:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OZckCxaqVo/Listeners', 05:09:52 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:52 INFO - 'USER': 'cltbld', 05:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:52 INFO - 'XPC_FLAGS': '0x0', 05:09:52 INFO - 'XPC_SERVICE_NAME': '0', 05:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:52 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/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--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 05:09:52 INFO - mozversion application_buildid: 20161004025701 05:09:52 INFO - mozversion application_changeset: 6bfa0e8a9f20f8c700e0ef60021449bc8cbc8601 05:09:52 INFO - mozversion application_display_name: Nightly 05:09:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:52 INFO - mozversion application_name: Firefox 05:09:52 INFO - mozversion application_remotingname: firefox 05:09:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:09:52 INFO - mozversion application_vendor: Mozilla 05:09:52 INFO - mozversion application_version: 52.0a1 05:09:52 INFO - mozversion platform_buildid: 20161004025701 05:09:52 INFO - mozversion platform_changeset: 6bfa0e8a9f20f8c700e0ef60021449bc8cbc8601 05:09:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:09:52 INFO - mozversion platform_version: 52.0a1 05:09:52 INFO - using testdate: 1475582992 05:09:52 INFO - actual date: 1475582992 05:09:52 INFO - starting webserver on 'localhost:49266' 05:09:52 INFO - SUITE-START | Running 2 tests 05:09:52 INFO - TEST-START | dromaeo_css 05:09:52 INFO - operating with platform_type : mac_ 05:09:52 INFO - Initialising browser for dromaeo_css test... 05:09:52 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmp9Vysve/profile http://localhost:49266/getInfo.html) 05:09:54 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 05:09:54 INFO - PROCESS | 1649 | colorDepth:24 05:09:54 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 05:09:54 INFO - PROCESS | 1649 | __metrics 05:09:54 INFO - PROCESS | 1649 | 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" 05:09:54 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:55 INFO - TEST-INFO | 1649: exit 0 05:09:55 INFO - Browser initialized. 05:09:55 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:55 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmp9Vysve/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:07 INFO - PROCESS | 1651 | RSS: Main: 235925504 05:10:07 INFO - PROCESS | 1651 | 05:10:58 INFO - PROCESS | 1651 | 1475583058732 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] 05:13:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 05:13:12 INFO - PROCESS | 1651 | RSS: Main: 396632064 05:13:12 INFO - PROCESS | 1651 | 05:16:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 05:16:16 INFO - PROCESS | 1651 | RSS: Main: 384696320 05:16:16 INFO - PROCESS | 1651 | 05:19:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 05:19:19 INFO - PROCESS | 1651 | RSS: Main: 365207552 05:19:19 INFO - PROCESS | 1651 | 05:22:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 05:22:22 INFO - PROCESS | 1651 | RSS: Main: 355844096 05:22:22 INFO - PROCESS | 1651 | 05:25:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 05:25:26 INFO - PROCESS | 1651 | RSS: Main: 329220096 05:25:26 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:28:30 INFO - PROCESS | 1651 | RSS: Main: 374640640 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | __start_tp_report 05:28:30 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 05:28:30 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 05:28:30 INFO - PROCESS | 1651 | |i|pagename|runs| 05:28:30 INFO - PROCESS | 1651 | |0;dojo.html;2777.222377734235;3307.9834600826994;3340.1482621931405;3341.5823022122227;3383.5939687237537;5562.3047119110115;5684.346300175476;5686.4313568643165;5706.714664266791;5706.77172913084;4843.24929635907;5521.2270282160425;5596.972015139919;5660.745266463009;5664.348599911012;5116.2069879168785;5198.844034678947;5206.739663016853;5280.392754833205;5288.995090932711;5162.767675454595;5206.7917283308625;5211.583073354142;5329.25390445338;5334.893302133955;5027.079160175091;5163.870903227412;5251.081060814342;5262.000219958196;5266.736663166846;5265.7893684252585;5270.998510283053;5275.657082289677;5320.760565774511;5351.143816989302;5065.594752419835;5204.245384419238;5208.5572726318305;5233.21501774733;5257;5602.355729091166;5650.0959846424785;5688.573356998241;5701.116326969326;5708.914366284509;6117.611910571121;6130.478909292716;6154.169187159766;6155.599886007395;6163.167972323724;6085.950265459504;6123.418275263843;6143.815685529441;6145.924463218964;6157.3534778848025;5661.377248502661;5732.742026608813;5735.885282294331;5750.482456578844;5862.120681897707;6213.068039793977;6253.749850005949;6275.497960163176;6276.089966954766;6284.874302513924;5969.492593129546;6102.969485152635;6106.053561697944;6125.84685382869;6134.263888333428;6083.69581520931;6103.572749907553;6139.355367686418;6143.907841382383;6158.261008678897;6112.877742445126;6134.938650613526;6138.978968775459;6151.046587778901;6218.875622487525;6201.069839524108;6201.379862013762;6214.658193799384;6223.595466294676;6229.875402491924;4198.727082739673;4850.902981940341;4870.14772414826;4876.609871210295;4903.901921961612;4336.588024137702;4367.995361066973;4388.802503887333;4403.471583409947;4412.24991751403;5746.712664366765;5750.654960702372;5756.769729210785;5763.193152958589;5802.622829516068;6229.595076320024;6234.438900498977;6253.218347706536;6254.21822272216;6262.906056409066;4679.976600116977;5653.519450846724;5700.828975130753;5726.770929162787;5728;5345.278387417727;5374.946250537445;5414.512693857571;5420.539254163361;5435.347758269033;6259.96870015647;6264.373562643699;6278.6546739929745;6285.779997700059;6287.71705273273;6081.817545473643;6248.4064013918605;6252.656103914328;6265.404786545271;6280.309165991828;6171.907421388593;6206.348333425106;6243.500519958483;6249.875002500015;6251.156093927261;6172.074188871705;6182.938170618237;6184.907226391518;6191.133241346305;6199.814005579839;6193.690315484298;6242.719077641608;6251.218597675291;6264.248290205204;6273.215848018997;5889.263842019747;5948.345681975065;6035.668038257762;6043.7884674036195;6050.031994880798;6110;6116.694165291807;6121.234845644294;6121.540884433596;6140.048292514667;5924.585279030426;5930.703464826827;5933.406659334032;5935.169076329404;5938;5237.764300606405;5612.933542626888;5821.563382746395;5998.190244316961;6072.544559157993;5720.11338242573;5831.82504524848;5842.38654941225;5952.107183922273;5957.582969192115 05:28:30 INFO - PROCESS | 1651 | |1;ext.html;493.3808070871057;501;501.9397672279329;537.0118981074821;538.3969953651911;24221.63667544986;40095.1980960381;41393.58606413935;41406.17187656253;43228;42045.7897710511;42477;42551.936201594974;42563.36154957678;42606.57393426065;8817.73546793594;9831.705048848527;9991.850122248172;10007.349522281029;10018.448985305806;8856.778580535474;12003.699907502294;12340.444679989421;12352.135350525466;12516.93741531291;11967.820482692767;12267.386630668476;12359.752804943895;12398;12417.937910310437;11627.47676354562;12349.753004939941;12351.19717218378;12375.443105060294;12393.442295096742;10191.89808101917;11987.82018269718;12054.69863253417;12068.336241506713;12111.878881211163;38836.41745373821;39118.02204944871;39140.60859391398;39153.21693566141;39249.21501569981;3216.3084936738715;3235.304409551934;3280.7703460757757;3525.506429099928;3535.5934067582302;30427.695723042707;31078.067657970296;31146.909858154857;31321.530177047363;31520;3189.4418476766473;3213.1324542373663;3215.2283451971593;3254.446744053517;3327.783694059878;404125;407021;407698;408003;409206.95396523125;32642.836785815918;33549.66450335514;54515.72742136264;54934;55009;34542.48186277208;34808;34874;34965;34973.9507814766;14350.641233969234;14488.782668259984;14504.927475362556;14529.854701453061;14550.12699238049;11008.339499630049;11272.71818204535;12131.090168237417;12304.200226985216;12427.005839532816;7462.70149194037;7577.2951086005205;7639.961800190964;7661.348785353196;7661.923380766232;3226.6934641209045;3274.721648659843;3281.2289112058647;3287.4247006773717;3301.834908254578;766.8772996320673;964.2671569607149;993.2848349188573;993.8012397520525;1043.1654676258963;23007.88496057509;28739.712602873704;29070.679124863393;29388;29524.852375737984;1046.2257929132538;1047.7328281288223;1055.9260851740457;1101.2346419238713;1113.5211858900589;13469.932650336686;15133.092014479167;15523;15635.905486615828;15638.530844074696;567903;571029;572466;574904;575068.1246593824;54449.72775136099;55109.448905511235;55142;55236;55243;1217.8234156047502;1260.9684757880943;1342.41604901868;1367.541873472378;1383.5295999360064;27004.745194991752;27219.86390068037;30854.53718194274;31372.686273136977;31434.37131257408;47765;48157.5184248153;48200.75899620479;48290.27564586464;48295.75852120717;516708;519237;519428;519680;520943;22207.555848883254;25866.35334116662;26174.476510470064;26829.597556036286;27777.305567360978;46022;46534;46667.766661166475;47144.29283560681;47716.52283477121;38201;38489.037774055876;38641.806790965864;39162.412563811;39834;36913.815430922674;37261.0684732873;37300.06749831276;38253.80873095728;38998.80500597479;36449;37235.6276437243;37910.62089379181;38001.80999094987;38030.61969380381;31821.522677160323;31949;33479.83260083781;34245.31509369848;34494.82752586221;24738.628920565847;25109.748902510742;25281.49437011286;25466;25783.871080644476 05:28:30 INFO - PROCESS | 1651 | |2;jquery.html;318.7895988647493;346.48027958062903;369.5417682074229;371.9981400092999;401.9176068905875;14852.48016319429;15214.923925380372;15412.15233162177;20568.177272909066;21207.257745978895;18593;19496.122674479648;19934.202631894743;20338.796612033875;20587.38237852863;4945.925811112827;6148.38516148386;6150.600210986294;6157.938420615781;6161.784337548187;5322.494363035506;5962.672053037081;6080.908786368208;6152.784652537162;6155.8153255402185;5820.214271073414;6056.273247210341;6092.177556029924;6094.939050609503;6106.206193194901;5988.251468566429;6110.725017374229;6110.969445152746;6113.786017489411;6116.9906965350665;5114.600701789292;5168.147255702805;5311.176767601028;5320.042392369372;5320.414754377015;26325;26511.73488265112;26544.60183097255;26735.866320668465;26803;2396.3769419950936;2398.9640155397683;2938.823670579772;3071.539269109629;3212.1166679163416;11344.205905586612;15330.080195188324;15517.922410387988;15786.526404207892;15843.762343564857;1679.7480377943284;1765.6733504301744;1831.2034265094594;1910.9140088696042;1915.0807612346014;110349.24062909324;114574;116671;118590.40704796507;123712;10903.364495325764;10921.726956825984;11269.71825704364;11433.314001159957;11522.76954460906;14433.494827680981;14475.855241447662;14486.420543178365;14497.565073047825;14501.419943202365;8372.958135209285;8512.191341822518;8514.106018868053;8522.318214542822;8657.264132548678;8186.877196841933;8371.609498153257;8438.915610843937;8654.6970856021;8662.003869555081;3789.5831458539537;3955.723099383073;4470.619997300266;4508.346289787963;4563.224251877189;1631.2740830330627;1853.5458812591;1910.732497450358;1922.846172306212;1930.4691209917105;793.4525177627419;841.7096101844976;915.4507295622573;955.2358113509165;994.7314225159166;20491.897540512502;21022.579548408947;21172.894135529532;21371.35885923425;21394.35816925495;932.9440233585871;941.3880977364768;941.8116376724546;947.8720322815827;972.3409755224666;10296.176305895511;10797.62208322705;10979.505922233519;11325.263857849379;11337.26307789991;556967.2151639297;558935;560963;571872;594126;119940;121522;122639;124275;124494.37752811359;955.7276176289724;971.6502059258661;998.7153661206667;1000.2997901469001;1000.9949950250202;18512.537186570444;18667.253309867996;18802.717959230897;18844.434666960013;18873.961932093865;51287.74356128195;52281.43155705335;53846;54772.72613636906;54889.668756310726;73159.63420182865;73743;76785;77171;77581.2241877574;5436.130219164915;7963.522188668699;8004.95997520032;8045.597720113854;8404.453710508797;10293.309843472503;10992.792837726563;12770.744585108432;12978.740425191254;13073.542426015043;11152.776944461228;11311.434428278388;11435.542578296774;11578.36319002463;11598.652040438801;10803.945980270048;10915.181361398085;11007.504662290055;11241.775164496501;11352.205345626056;9790.902090979283;11146.49840757184;11470.197086203885;11474;11680;8051.83896322082;8169.183081691784;8222.136675648972;8259.091499934882;8358.492452264418;11237.49431275611;11252.502358832095;11362.091032717528;11461.885381146081;11464.94267528657 05:28:30 INFO - PROCESS | 1651 | |3;mootools.html;1366.3236697834561;1523.9542813715586;1546.5051183621238;1775.5383600263926;1952.73638058862;7887.684492620296;8418.200270974256;8554.700585479517;8944.50805205715;8951;8809.54642483991;8889.28885689145;8891.955540222307;8901.020887702363;8904.465732056065;2299.8390112692077;2344.4490544721975;2348.5537747827943;2350.5063936573342;2364.3498038039593;2302.3783578433813;2341.7775311345395;2342.472943587696;2344.6131388320905;2347.295811256616;2300.850444721096;2316.061994892071;2329.091654254842;2340.2511196417154;2343.6718859359703;2272.4659704969317;2296.2881506732965;2303.090279339668;2304.182015384531;2326.790588847012;2300.6894069300597;2304.2165663674264;2305.5619432307976;2305.7694230576976;2307.826912981533;8886.155815197546;8900.243479304203;8947.686830960885;8967.641294348217;9008.864867027;5181.1969144782615;5393.9730301348245;5395.595330350239;5421.457854214586;5424.077906755861;3465.428204346305;3606.6934310583633;3684.042149041242;3686.8156592170553;3695.7597756145765;846.289117141604;1052.7315534538643;1080.9621663241749;1086.869575650919;1111.394290111891;11875;11922.761544769057;12018.51925922962;12032.157748957576;12037.277763334228;4334.068175342317;4394.143142087326;4560.954390456053;4592.70147440422;4605.815767369335;9272.119148680864;9278.11857873501;9281.025492323344;9288.674896378594;9288.953555232316;5203.947960520422;5206.921896171561;5214.348206474191;5220.138677118233;5229;4123.237201117803;4365.345198220292;4529.547045295444;4530.886727831765;4884.7069175849565;3222.38774632819;3692.298463291966;3714.4985426967555;3820.5797362290127;3822.140018495872;1097.5774326884207;1101.0695961912172;1103.5916710817048;1104.718296834302;1105.1269497097364;813.5484805932764;827.6027506796651;868.8305780372766;874.208840998897;919.1268295119663;5440.265564148868;5581;5728.914066289009;5931.872944140599;5958.821235362946;964.8166848298941;973.6592192732628;975.3367709957297;991.7074463033423;1047.3349423116224;3631.8002509862213;3663.6885864701267;3752.7308838133067;3854.4411060396646;3882.2041481496226;10619.30974486656;10881.782364352668;10976.341419514694;10992.615258465916;11000.559977600806;10533.736656583647;10937.234393592373;10943.671689849318;10950.452477376099;10954;7119.1457025157315;8177.427580069457;8323.458975166595;8345.707900223462;8357.707480238285;5799.101139323411;5943.821685349447;5981.401859813984;6003.3996600339615;6039.849003774941;9402.34183607141;9517.619295228113;10007.149392301735;10247.180225581786;10301.330413523097;9439.00890406525;10016.699499015042;10301.639442619473;10372.636957706443;10434.21743369235;7053.823654408476;7305.269473052652;7382.2617738225745;7594.924050759421;7625.428092893166;8281.875771863548;8291.170882911661;8373.246407823324;8389.580520974048;8486.957565212135;7566.659500322608;7577.469577129768;7601.011868457065;7609.733659322119;7753.030871141107;7347.66935487915;7430.145533263744;7447.404207663482;7478.850422991401;7640.885386719093;6683.198016237888;6922.411595014481;6934.237233904368;6998.965005174941;7002.544834585736;4456.331550267356;4538.568835960578;4561.29299958507;4575.130725162208;4671.579557839811;4851.126797176401;4934.259861020875;4987.376577927759;5148;5166.405863325615 05:28:30 INFO - PROCESS | 1651 | |4;prototype.html;286.65744435399694;295.4666826378387;305.9109569931045;310.25074445214807;313.5813688725551;4914.778834952427;5159.380874295085;5162.22566615008;5193.32486776719;5254.18560123181;4533.637309015279;4955.3310303109065;5008.424031236409;5042.520960508755;5126.5642420394315;3322.900312990614;3929.862454814082;3946.3093958557283;3951.565327813938;3987.6610488108545;3670;3981.6615587675083;3992.662458076548;4001.9799901000456;4003.878913904097;3731.365667836474;3737.5514938207452;3891.9610803891883;3920.882373528799;3968.206358728266;3325.451300535409;3960.425738267964;3962.5443074046566;3970.205958808221;3987.7607343559334;3468.3583537045474;3468.7918724876336;3485.9128521786906;3491.9825400873087;3497.7726447780815;4878.877858092623;5043.42000669924;5046.19260918255;5056.342675452168;5090.821821236239;4480.215962206601;4520.50274469808;4528.75091869947;4556.7721613919175;4571.040081582838;4808.2787581863;5256.316678831766;5446.782128714846;5451.291332126838;5454.400015998237;3580.6240344763946;3593.975716920665;3750.3436898542645;3750.456183853326;3819.4652748615217;4830.6135509159185;4970.005998800254;5441.476386611755;5724.227229324029;5747.856303592402;3201.951970720441;3701.296753616858;3710.257948410275;3716.201016781351;3810.314143454205;3105.1460848266906;3358.983205083959;3776.1126135358168;3864.401017842239;3884.0678237222864;3810.7713537187856;4467.5755803198645;4532.637389008872;4534.410526631583;4548.361950068952;4559.430071241095;5219.973900130551;5321.946780532223;5508.804893161957;5564.1931919871395;1048.5910494906993;1310.6919873829643;1318.9975618529986;1323.8808507234396;1328.0902581731352;651.8989556618732;771.4831063187678;797.6211299632628;812.1513018895268;814.8288859339605;3980;4187.183499217685;4215;4252.659787217015;4341.956580434218;4656.67403281767;4662.883427914329;4665.136949664323;4673.859784206479;4698.765061746899;4264;4272.594103560157;4272.786360682016;4275;4291.077418355007;2318.652202169688;2661.8136730429073;2949.2037149969387;2977.746891514202;2978.89573864918;5479.8492316613165;5799.318197722613;5812.21535092757;5815.214945982323;5844.590878638454;5306.814261500829;5473.370562385297;5763.85590360236;5766.163906233573;5793.188953546507;5597.104463285936;5696.525119676994;5762.222100016612;5768.538516918553;5803.839232153586;5609.523190528687;5612.382637909908;5616.943830561642;5661.348944871393;5671.602987790815;4544.7045942013665;4615.30770384445;5307.187190788888;5389.029974604452;5749.9712501437225;4843.733594652328;5518.420565840529;5788.247527821356;5799.4921320457825;5846;3444.9483257750653;3583.691952437394;3646.2707458508935;3684.5446048811104;3816.637419445148;4564.589186973056;5327.137825076943;5624.437556244507;5718.285214348207;5757.510611598061;4858.465568787501;4997.725125118008;5279.788808447773;5474.315710536183;5513.365962914316;5215.191645294985;5446.237526746179;5474.1807968895255;5475.890482190413;5506.889862202814;4561.7262964222255;4865.375295404946;5369.838904832861;5391.272178255886;5426.155107263549;5073.53933342336;5385.46145385474;5432.728363581726;5449;5495.890082198253;4810.921010553318;5384.246205531151;5400.945990540202;5434.945650543444;5470.671759694431 05:28:30 INFO - PROCESS | 1651 | |5;yui.html;707.7699747582034;710.4848984486247;719.2879049740754;720.8414148887247;749.4880817478781;14939.25303734813;15843.683126337466;15855;15899.52301430956;15900.602484937883;14347.64130896728;14463.638409039779;14504.129752214874;14504.274786260698;14518.637034074154;665.7137430904709;688.2532452289272;689.0904006711144;829.8340331933607;854.940154189207;839.3662784597651;856.1053698884681;861.6036623153357;877.5656050255133;879.4811061473729;906.7914379692675;908.4413085952158;908.5865931001379;908.9272858171363;909.6816114359988;707.5789905006513;901.1664210605197;902.2376092202079;902.3593248793364;902.571278642646;550.4852962480094;551.9144532597454;553.3691591585596;553.3940335332804;665.9600423974578;14814.259287035606;15275.847241527665;15283.770743438858;15332;15335.693286134327;13786.724265514735;14001.649958751012;14194.716105677828;14205.573832785032;14225.928870355581;12870.485180592765;12874.16317939331;12965.546205882843;13150.802737958938;13260.867391326059;4289.120730250291;4333.739975601474;4362.520122786491;4429.291313389842;4513.909721805579;93361;96077;112022;116881.41559292233;122434;11111.888881111247;11121.610743624096;11163.665090047312;11562.826557601642;11616.303021818549;21854.45363865916;21858.797766122698;21882.343529693815;21886.562268754536;21941.890290548447;8021.598920053974;8212;8245.340372770284;8248.422610417334;8360.665573376997;3981.581933896899;4300.505441874162;4416.536263692266;4441.777911104432;4447.155040542287;3620;3723.888283351504;3758.041699366644;3759.266942946154;3767.849286028583;683.0573808144728;683.736761346885;686.5708931917552;692.6848284030754;700.3906601256939;570.9314882214161;583.1718959078034;664.973401063952;679.2935347238816;689.9206591241971;8798.86801697975;8833.734987950373;9483.241340692866;9590.952045239728;9613.759656008517;623.5790841182184;638.9680515974183;644.3685188515282;669.4410167510086;671.6775947545206;4398.274284743045;4608.124456353282;4659.836905708284;4675.836345727951;4797.112534181188;105750.4712476448;163029.73039178946;165850;176372;180553;143927.2803635975;144176;146363;152054;153030;81509.18490815016;108463.37304940433;113486.43256783663;115814;120901.18648220284;7924.881126782988;8247.134050924567;8965.013848476792;8966.730998070068;9079.95460022722;59866.605335787826;65481.34518654752;66599.66700166468;67616;67811;76117;94192;97333.51333243572;98023;101768.98231017595;10914;11243.66269011931;11348.659540213806;11577.363245021605;12268.141230113806;13123.015773817193;14515.782263265848;14893.85106148968;15329.6167595811;16036.198190090683;14072.507462238773;14244.715105698035;14264.643383915485;14362.425502979764;14416.42334306616;13829.892716203509;13831.515896943558;14096.718065638424;14105.506307279196;14546.345414456586;13608.31958402056;13626.591202263948;14071.929640351733;14101.6474588132;14432.278386080445;11344.602938897098;11482.885171148515;11661.65015049516;11747.588834390755;11910.702232444259;11303.660890173307;11320.320780753182;11426;11652;11701.941490292495 05:28:30 INFO - PROCESS | 1651 | __end_tp_report 05:28:30 INFO - PROCESS | 1651 | __start_cc_report 05:28:30 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1706 05:28:30 INFO - PROCESS | 1651 | __end_cc_report 05:28:30 INFO - PROCESS | 1651 | __startTimestamp1475584110260__endTimestamp 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | ------- Summary: start ------- 05:28:30 INFO - PROCESS | 1651 | Number of tests: 6 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5693.49 Median:5924.59 stddev:657.21 (11.1%) stddev-sans-first:618.13 05:28:30 INFO - PROCESS | 1651 | Values: 2777.2 3308.0 3340.1 3341.6 3383.6 5562.3 5684.3 5686.4 5706.7 5706.8 4843.2 5521.2 5597.0 5660.7 5664.3 5116.2 5198.8 5206.7 5280.4 5289.0 5162.8 5206.8 5211.6 5329.3 5334.9 5027.1 5163.9 5251.1 5262.0 5266.7 5265.8 5271.0 5275.7 5320.8 5351.1 5065.6 5204.2 5208.6 5233.2 5257.0 5602.4 5650.1 5688.6 5701.1 5708.9 6117.6 6130.5 6154.2 6155.6 6163.2 6086.0 6123.4 6143.8 6145.9 6157.4 5661.4 5732.7 5735.9 5750.5 5862.1 6213.1 6253.7 6275.5 6276.1 6284.9 5969.5 6103.0 6106.1 6125.8 6134.3 6083.7 6103.6 6139.4 6143.9 6158.3 6112.9 6134.9 6139.0 6151.0 6218.9 6201.1 6201.4 6214.7 6223.6 6229.9 4198.7 4850.9 4870.1 4876.6 4903.9 4336.6 4368.0 4388.8 4403.5 4412.2 5746.7 5750.7 5756.8 5763.2 5802.6 6229.6 6234.4 6253.2 6254.2 6262.9 4680.0 5653.5 5700.8 5726.8 5728.0 5345.3 5374.9 5414.5 5420.5 5435.3 6260.0 6264.4 6278.7 6285.8 6287.7 6081.8 6248.4 6252.7 6265.4 6280.3 6171.9 6206.3 6243.5 6249.9 6251.2 6172.1 6182.9 6184.9 6191.1 6199.8 6193.7 6242.7 6251.2 6264.2 6273.2 5889.3 5948.3 6035.7 6043.8 6050.0 6110.0 6116.7 6121.2 6121.5 6140.0 5924.6 5930.7 5933.4 5935.2 5938.0 5237.8 5612.9 5821.6 5998.2 6072.5 5720.1 5831.8 5842.4 5952.1 5957.6 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:62681.02 Median:33897.49 stddev:134539.30 (396.9%) stddev-sans-first:134835.69 05:28:30 INFO - PROCESS | 1651 | Values: 493.4 501.0 501.9 537.0 538.4 24221.6 40095.2 41393.6 41406.2 43228.0 42045.8 42477.0 42551.9 42563.4 42606.6 8817.7 9831.7 9991.9 10007.3 10018.4 8856.8 12003.7 12340.4 12352.1 12516.9 11967.8 12267.4 12359.8 12398.0 12417.9 11627.5 12349.8 12351.2 12375.4 12393.4 10191.9 11987.8 12054.7 12068.3 12111.9 38836.4 39118.0 39140.6 39153.2 39249.2 3216.3 3235.3 3280.8 3525.5 3535.6 30427.7 31078.1 31146.9 31321.5 31520.0 3189.4 3213.1 3215.2 3254.4 3327.8 404125.0 407021.0 407698.0 408003.0 409207.0 32642.8 33549.7 54515.7 54934.0 55009.0 34542.5 34808.0 34874.0 34965.0 34974.0 14350.6 14488.8 14504.9 14529.9 14550.1 11008.3 11272.7 12131.1 12304.2 12427.0 7462.7 7577.3 7640.0 7661.3 7661.9 3226.7 3274.7 3281.2 3287.4 3301.8 766.9 964.3 993.3 993.8 1043.2 23007.9 28739.7 29070.7 29388.0 29524.9 1046.2 1047.7 1055.9 1101.2 1113.5 13469.9 15133.1 15523.0 15635.9 15638.5 567903.0 571029.0 572466.0 574904.0 575068.1 54449.7 55109.4 55142.0 55236.0 55243.0 1217.8 1261.0 1342.4 1367.5 1383.5 27004.7 27219.9 30854.5 31372.7 31434.4 47765.0 48157.5 48200.8 48290.3 48295.8 516708.0 519237.0 519428.0 519680.0 520943.0 22207.6 25866.4 26174.5 26829.6 27777.3 46022.0 46534.0 46667.8 47144.3 47716.5 38201.0 38489.0 38641.8 39162.4 39834.0 36913.8 37261.1 37300.1 38253.8 38998.8 36449.0 37235.6 37910.6 38001.8 38030.6 31821.5 31949.0 33479.8 34245.3 34494.8 24738.6 25109.7 25281.5 25466.0 25783.9 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34026.67 Median:26640.23 stddev:94996.00 (356.6%) stddev-sans-first:95228.77 05:28:30 INFO - PROCESS | 1651 | Values: 318.8 346.5 369.5 372.0 401.9 14852.5 15214.9 15412.2 20568.2 21207.3 18593.0 19496.1 19934.2 20338.8 20587.4 4945.9 6148.4 6150.6 6157.9 6161.8 5322.5 5962.7 6080.9 6152.8 6155.8 5820.2 6056.3 6092.2 6094.9 6106.2 5988.3 6110.7 6111.0 6113.8 6117.0 5114.6 5168.1 5311.2 5320.0 5320.4 26325.0 26511.7 26544.6 26735.9 26803.0 2396.4 2399.0 2938.8 3071.5 3212.1 11344.2 15330.1 15517.9 15786.5 15843.8 1679.7 1765.7 1831.2 1910.9 1915.1 110349.2 114574.0 116671.0 118590.4 123712.0 10903.4 10921.7 11269.7 11433.3 11522.8 14433.5 14475.9 14486.4 14497.6 14501.4 8373.0 8512.2 8514.1 8522.3 8657.3 8186.9 8371.6 8438.9 8654.7 8662.0 3789.6 3955.7 4470.6 4508.3 4563.2 1631.3 1853.5 1910.7 1922.8 1930.5 793.5 841.7 915.5 955.2 994.7 20491.9 21022.6 21172.9 21371.4 21394.4 932.9 941.4 941.8 947.9 972.3 10296.2 10797.6 10979.5 11325.3 11337.3 556967.2 558935.0 560963.0 571872.0 594126.0 119940.0 121522.0 122639.0 124275.0 124494.4 955.7 971.7 998.7 1000.3 1001.0 18512.5 18667.3 18802.7 18844.4 18874.0 51287.7 52281.4 53846.0 54772.7 54889.7 73159.6 73743.0 76785.0 77171.0 77581.2 5436.1 7963.5 8005.0 8045.6 8404.5 10293.3 10992.8 12770.7 12978.7 13073.5 11152.8 11311.4 11435.5 11578.4 11598.7 10803.9 10915.2 11007.5 11241.8 11352.2 9790.9 11146.5 11470.2 11474.0 11680.0 8051.8 8169.2 8222.1 8259.1 8358.5 11237.5 11252.5 11362.1 11461.9 11464.9 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5675.28 Median:4761.35 stddev:3240.87 (68.1%) stddev-sans-first:3233.79 05:28:30 INFO - PROCESS | 1651 | Values: 1366.3 1524.0 1546.5 1775.5 1952.7 7887.7 8418.2 8554.7 8944.5 8951.0 8809.5 8889.3 8892.0 8901.0 8904.5 2299.8 2344.4 2348.6 2350.5 2364.3 2302.4 2341.8 2342.5 2344.6 2347.3 2300.9 2316.1 2329.1 2340.3 2343.7 2272.5 2296.3 2303.1 2304.2 2326.8 2300.7 2304.2 2305.6 2305.8 2307.8 8886.2 8900.2 8947.7 8967.6 9008.9 5181.2 5394.0 5395.6 5421.5 5424.1 3465.4 3606.7 3684.0 3686.8 3695.8 846.3 1052.7 1081.0 1086.9 1111.4 11875.0 11922.8 12018.5 12032.2 12037.3 4334.1 4394.1 4561.0 4592.7 4605.8 9272.1 9278.1 9281.0 9288.7 9289.0 5203.9 5206.9 5214.3 5220.1 5229.0 4123.2 4365.3 4529.5 4530.9 4884.7 3222.4 3692.3 3714.5 3820.6 3822.1 1097.6 1101.1 1103.6 1104.7 1105.1 813.5 827.6 868.8 874.2 919.1 5440.3 5581.0 5728.9 5931.9 5958.8 964.8 973.7 975.3 991.7 1047.3 3631.8 3663.7 3752.7 3854.4 3882.2 10619.3 10881.8 10976.3 10992.6 11000.6 10533.7 10937.2 10943.7 10950.5 10954.0 7119.1 8177.4 8323.5 8345.7 8357.7 5799.1 5943.8 5981.4 6003.4 6039.8 9402.3 9517.6 10007.1 10247.2 10301.3 9439.0 10016.7 10301.6 10372.6 10434.2 7053.8 7305.3 7382.3 7594.9 7625.4 8281.9 8291.2 8373.2 8389.6 8487.0 7566.7 7577.5 7601.0 7609.7 7753.0 7347.7 7430.1 7447.4 7478.9 7640.9 6683.2 6922.4 6934.2 6999.0 7002.5 4456.3 4538.6 4561.3 4575.1 4671.6 4851.1 4934.3 4987.4 5148.0 5166.4 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4357.27 Median:4753.52 stddev:1354.35 (28.5%) stddev-sans-first:1323.24 05:28:30 INFO - PROCESS | 1651 | Values: 286.7 295.5 305.9 310.3 313.6 4914.8 5159.4 5162.2 5193.3 5254.2 4533.6 4955.3 5008.4 5042.5 5126.6 3322.9 3929.9 3946.3 3951.6 3987.7 3670.0 3981.7 3992.7 4002.0 4003.9 3731.4 3737.6 3892.0 3920.9 3968.2 3325.5 3960.4 3962.5 3970.2 3987.8 3468.4 3468.8 3485.9 3492.0 3497.8 4878.9 5043.4 5046.2 5056.3 5090.8 4480.2 4520.5 4528.8 4556.8 4571.0 4808.3 5256.3 5446.8 5451.3 5454.4 3580.6 3594.0 3750.3 3750.5 3819.5 4830.6 4970.0 5441.5 5724.2 5747.9 3202.0 3701.3 3710.3 3716.2 3810.3 3105.1 3359.0 3776.1 3864.4 3884.1 3810.8 4467.6 4532.6 4534.4 4548.4 4559.4 5220.0 5321.9 5508.8 5564.2 1048.6 1310.7 1319.0 1323.9 1328.1 651.9 771.5 797.6 812.2 814.8 3980.0 4187.2 4215.0 4252.7 4342.0 4656.7 4662.9 4665.1 4673.9 4698.8 4264.0 4272.6 4272.8 4275.0 4291.1 2318.7 2661.8 2949.2 2977.7 2978.9 5479.8 5799.3 5812.2 5815.2 5844.6 5306.8 5473.4 5763.9 5766.2 5793.2 5597.1 5696.5 5762.2 5768.5 5803.8 5609.5 5612.4 5616.9 5661.3 5671.6 4544.7 4615.3 5307.2 5389.0 5750.0 4843.7 5518.4 5788.2 5799.5 5846.0 3444.9 3583.7 3646.3 3684.5 3816.6 4564.6 5327.1 5624.4 5718.3 5757.5 4858.5 4997.7 5279.8 5474.3 5513.4 5215.2 5446.2 5474.2 5475.9 5506.9 4561.7 4865.4 5369.8 5391.3 5426.2 5073.5 5385.5 5432.7 5449.0 5495.9 4810.9 5384.2 5400.9 5434.9 5470.7 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:25793.19 Median:3758.65 stddev:42192.22 (1122.5%) stddev-sans-first:42268.54 05:28:30 INFO - PROCESS | 1651 | Values: 707.8 710.5 719.3 720.8 749.5 14939.3 15843.7 15855.0 15899.5 15900.6 14347.6 14463.6 14504.1 14504.3 14518.6 665.7 688.3 689.1 829.8 854.9 839.4 856.1 861.6 877.6 879.5 906.8 908.4 908.6 908.9 909.7 707.6 901.2 902.2 902.4 902.6 550.5 551.9 553.4 553.4 666.0 14814.3 15275.8 15283.8 15332.0 15335.7 13786.7 14001.6 14194.7 14205.6 14225.9 12870.5 12874.2 12965.5 13150.8 13260.9 4289.1 4333.7 4362.5 4429.3 4513.9 93361.0 96077.0 112022.0 116881.4 122434.0 11111.9 11121.6 11163.7 11562.8 11616.3 21854.5 21858.8 21882.3 21886.6 21941.9 8021.6 8212.0 8245.3 8248.4 8360.7 3981.6 4300.5 4416.5 4441.8 4447.2 3620.0 3723.9 3758.0 3759.3 3767.8 683.1 683.7 686.6 692.7 700.4 570.9 583.2 665.0 679.3 689.9 8798.9 8833.7 9483.2 9591.0 9613.8 623.6 639.0 644.4 669.4 671.7 4398.3 4608.1 4659.8 4675.8 4797.1 105750.5 163029.7 165850.0 176372.0 180553.0 143927.3 144176.0 146363.0 152054.0 153030.0 81509.2 108463.4 113486.4 115814.0 120901.2 7924.9 8247.1 8965.0 8966.7 9080.0 59866.6 65481.3 66599.7 67616.0 67811.0 76117.0 94192.0 97333.5 98023.0 101769.0 10914.0 11243.7 11348.7 11577.4 12268.1 13123.0 14515.8 14893.9 15329.6 16036.2 14072.5 14244.7 14264.6 14362.4 14416.4 13829.9 13831.5 14096.7 14105.5 14546.3 13608.3 13626.6 14071.9 14101.6 14432.3 11344.6 11482.9 11661.7 11747.6 11910.7 11303.7 11320.3 11426.0 11652.0 11701.9 05:28:30 INFO - PROCESS | 1651 | -------- Summary: end -------- 05:28:30 INFO - PROCESS | 1651 | 05:28:30 INFO - TEST-INFO | 1651: exit 0 05:28:30 INFO - TEST-OK | dromaeo_css | took 1118577ms 05:28:30 INFO - TEST-START | kraken 05:28:30 INFO - operating with platform_type : mac_ 05:28:30 INFO - Initialising browser for kraken test... 05:28:30 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpKniBbT/profile http://localhost:49266/getInfo.html) 05:28:33 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:28:33 INFO - PROCESS | 1661 | colorDepth:24 05:28:33 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:28:33 INFO - PROCESS | 1661 | __metrics 05:28:33 INFO - PROCESS | 1661 | 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" 05:28:33 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:34 INFO - TEST-INFO | 1661: exit 0 05:28:34 INFO - Browser initialized. 05:28:34 INFO - Running cycle 1/1 for kraken test... 05:28:34 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpKniBbT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:46 INFO - PROCESS | 1662 | RSS: Main: 235913216 05:28:46 INFO - PROCESS | 1662 | 05:28:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:49 INFO - PROCESS | 1662 | RSS: Main: 294817792 05:28:49 INFO - PROCESS | 1662 | 05:28:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:28:53 INFO - PROCESS | 1662 | RSS: Main: 293429248 05:28:53 INFO - PROCESS | 1662 | 05:28:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:28:57 INFO - PROCESS | 1662 | RSS: Main: 387690496 05:28:57 INFO - PROCESS | 1662 | 05:28:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:28:59 INFO - PROCESS | 1662 | RSS: Main: 287035392 05:28:59 INFO - PROCESS | 1662 | 05:29:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:02 INFO - PROCESS | 1662 | RSS: Main: 291434496 05:29:02 INFO - PROCESS | 1662 | 05:29:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:05 INFO - PROCESS | 1662 | RSS: Main: 328851456 05:29:05 INFO - PROCESS | 1662 | 05:29:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:09 INFO - PROCESS | 1662 | RSS: Main: 329715712 05:29:09 INFO - PROCESS | 1662 | 05:29:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:29:12 INFO - PROCESS | 1662 | RSS: Main: 326975488 05:29:12 INFO - PROCESS | 1662 | 05:29:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:14 INFO - PROCESS | 1662 | RSS: Main: 304865280 05:29:14 INFO - PROCESS | 1662 | 05:29:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:17 INFO - PROCESS | 1662 | RSS: Main: 306544640 05:29:17 INFO - PROCESS | 1662 | 05:29:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:20 INFO - PROCESS | 1662 | RSS: Main: 311775232 05:29:20 INFO - PROCESS | 1662 | 05:29:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:24 INFO - PROCESS | 1662 | RSS: Main: 319655936 05:29:24 INFO - PROCESS | 1662 | 05:29:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:27 INFO - PROCESS | 1662 | RSS: Main: 319021056 05:29:27 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:29:29 INFO - PROCESS | 1662 | RSS: Main: 362971136 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | __start_tp_report 05:29:29 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:29:29 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:29:29 INFO - PROCESS | 1662 | |i|pagename|runs| 05:29:29 INFO - PROCESS | 1662 | |0;ai-astar;158;169;145;114;113;114;115;114;113;114 05:29:29 INFO - PROCESS | 1662 | |1;audio-beat-detection;147;118;146;180;131;112;115;112;145;113 05:29:29 INFO - PROCESS | 1662 | |2;audio-dft;183;197;261;190;186;174;182;184;183;182 05:29:29 INFO - PROCESS | 1662 | |3;audio-fft;79;59;60;96;63;61;58;61;81;57 05:29:29 INFO - PROCESS | 1662 | |4;audio-oscillator;86;73;92;70;68;70;93;68;70;93 05:29:29 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;88;84;88;85;89;85;88;87;88;85 05:29:29 INFO - PROCESS | 1662 | |6;imaging-darkroom;94;95;94;94;93;92;94;94;93;92 05:29:29 INFO - PROCESS | 1662 | |7;imaging-desaturate;85;84;86;84;83;86;81;90;83;86 05:29:29 INFO - PROCESS | 1662 | |8;json-parse-financial;56;56;54;53;54;54;55;54;54;54 05:29:29 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;73;68;76;70;69;71;68;69;72 05:29:29 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;95;104;87;87;86;89;85;87;90;91 05:29:29 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;144;149;156;159;148;156;149;159;231;147 05:29:29 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;183;186;173;173;174;174;171;226;174;176 05:29:29 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;70;69;70;68;69;69;69;71;69;69 05:29:29 INFO - PROCESS | 1662 | __end_tp_report 05:29:29 INFO - PROCESS | 1662 | __start_cc_report 05:29:29 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1918 05:29:29 INFO - PROCESS | 1662 | __end_cc_report 05:29:29 INFO - PROCESS | 1662 | __startTimestamp1475584169625__endTimestamp 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:29:29 INFO - PROCESS | 1662 | Number of tests: 14 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:126.90 Median:114.50 stddev:21.76 (19.0%) stddev-sans-first:19.96 05:29:29 INFO - PROCESS | 1662 | Values: 158.0 169.0 145.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:138.00 stddev:22.46 (16.3%) stddev-sans-first:23.15 05:29:29 INFO - PROCESS | 1662 | Values: 147.0 118.0 146.0 180.0 131.0 112.0 115.0 112.0 145.0 113.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:192.20 Median:185.00 stddev:24.89 (13.5%) stddev-sans-first:26.18 05:29:29 INFO - PROCESS | 1662 | Values: 183.0 197.0 261.0 190.0 186.0 174.0 182.0 184.0 183.0 182.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:67.50 Median:62.00 stddev:13.17 (21.2%) stddev-sans-first:13.29 05:29:29 INFO - PROCESS | 1662 | Values: 79.0 59.0 60.0 96.0 63.0 61.0 58.0 61.0 81.0 57.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:79.50 stddev:11.19 (14.1%) stddev-sans-first:11.51 05:29:29 INFO - PROCESS | 1662 | Values: 86.0 73.0 92.0 70.0 68.0 70.0 93.0 68.0 70.0 93.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:1.77 (2.0%) stddev-sans-first:1.81 05:29:29 INFO - PROCESS | 1662 | Values: 88.0 84.0 88.0 85.0 89.0 85.0 88.0 87.0 88.0 85.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 05:29:29 INFO - PROCESS | 1662 | Values: 94.0 95.0 94.0 94.0 93.0 92.0 94.0 94.0 93.0 92.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:2.44 (2.9%) stddev-sans-first:2.59 05:29:29 INFO - PROCESS | 1662 | Values: 85.0 84.0 86.0 84.0 83.0 86.0 81.0 90.0 83.0 86.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 05:29:29 INFO - PROCESS | 1662 | Values: 56.0 56.0 54.0 53.0 54.0 54.0 55.0 54.0 54.0 54.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:3.27 (4.6%) stddev-sans-first:2.65 05:29:29 INFO - PROCESS | 1662 | Values: 64.0 73.0 68.0 76.0 70.0 69.0 71.0 68.0 69.0 72.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:88.00 stddev:5.69 (6.5%) stddev-sans-first:5.75 05:29:29 INFO - PROCESS | 1662 | Values: 95.0 104.0 87.0 87.0 86.0 89.0 85.0 87.0 90.0 91.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:159.80 Median:156.00 stddev:25.57 (16.4%) stddev-sans-first:26.48 05:29:29 INFO - PROCESS | 1662 | Values: 144.0 149.0 156.0 159.0 148.0 156.0 149.0 159.0 231.0 147.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:175.00 stddev:16.51 (9.4%) stddev-sans-first:17.50 05:29:29 INFO - PROCESS | 1662 | Values: 183.0 186.0 173.0 173.0 174.0 174.0 171.0 226.0 174.0 176.0 05:29:29 INFO - PROCESS | 1662 | 05:29:29 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 05:29:29 INFO - PROCESS | 1662 | Values: 70.0 69.0 70.0 68.0 69.0 69.0 69.0 71.0 69.0 69.0 05:29:29 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:29:29 INFO - PROCESS | 1662 | 05:29:30 INFO - TEST-INFO | 1662: exit 0 05:29:30 INFO - TEST-OK | kraken | took 59585ms 05:29:30 INFO - SUITE-END | took 1178s 05:29:30 INFO - Completed test suite (00:19:38) 05:29:30 INFO - javascript benchmark 05:29:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2777.222377734235, 3307.9834600826994, 3340.1482621931405, 3341.5823022122227, 3383.5939687237537, 5562.3047119110115, 5684.346300175476, 5686.4313568643165, 5706.714664266791, 5706.77172913084, 4843.24929635907, 5521.2270282160425, 5596.972015139919, 5660.745266463009, 5664.348599911012, 5116.2069879168785, 5198.844034678947, 5206.739663016853, 5280.392754833205, 5288.995090932711, 5162.767675454595, 5206.7917283308625, 5211.583073354142, 5329.25390445338, 5334.893302133955, 5027.079160175091, 5163.870903227412, 5251.081060814342, 5262.000219958196, 5266.736663166846, 5265.7893684252585, 5270.998510283053, 5275.657082289677, 5320.760565774511, 5351.143816989302, 5065.594752419835, 5204.245384419238, 5208.5572726318305, 5233.21501774733, 5257.0, 5602.355729091166, 5650.0959846424785, 5688.573356998241, 5701.116326969326, 5708.914366284509, 6117.611910571121, 6130.478909292716, 6154.169187159766, 6155.599886007395, 6163.167972323724, 6085.950265459504, 6123.418275263843, 6143.815685529441, 6145.924463218964, 6157.3534778848025, 5661.377248502661, 5732.742026608813, 5735.885282294331, 5750.482456578844, 5862.120681897707, 6213.068039793977, 6253.749850005949, 6275.497960163176, 6276.089966954766, 6284.874302513924, 5969.492593129546, 6102.969485152635, 6106.053561697944, 6125.84685382869, 6134.263888333428, 6083.69581520931, 6103.572749907553, 6139.355367686418, 6143.907841382383, 6158.261008678897, 6112.877742445126, 6134.938650613526, 6138.978968775459, 6151.046587778901, 6218.875622487525, 6201.069839524108, 6201.379862013762, 6214.658193799384, 6223.595466294676, 6229.875402491924, 4198.727082739673, 4850.902981940341, 4870.14772414826, 4876.609871210295, 4903.901921961612, 4336.588024137702, 4367.995361066973, 4388.802503887333, 4403.471583409947, 4412.24991751403, 5746.712664366765, 5750.654960702372, 5756.769729210785, 5763.193152958589, 5802.622829516068, 6229.595076320024, 6234.438900498977, 6253.218347706536, 6254.21822272216, 6262.906056409066, 4679.976600116977, 5653.519450846724, 5700.828975130753, 5726.770929162787, 5728.0, 5345.278387417727, 5374.946250537445, 5414.512693857571, 5420.539254163361, 5435.347758269033, 6259.96870015647, 6264.373562643699, 6278.6546739929745, 6285.779997700059, 6287.71705273273, 6081.817545473643, 6248.4064013918605, 6252.656103914328, 6265.404786545271, 6280.309165991828, 6171.907421388593, 6206.348333425106, 6243.500519958483, 6249.875002500015, 6251.156093927261, 6172.074188871705, 6182.938170618237, 6184.907226391518, 6191.133241346305, 6199.814005579839, 6193.690315484298, 6242.719077641608, 6251.218597675291, 6264.248290205204, 6273.215848018997, 5889.263842019747, 5948.345681975065, 6035.668038257762, 6043.7884674036195, 6050.031994880798, 6110.0, 6116.694165291807, 6121.234845644294, 6121.540884433596, 6140.048292514667, 5924.585279030426, 5930.703464826827, 5933.406659334032, 5935.169076329404, 5938.0, 5237.764300606405, 5612.933542626888, 5821.563382746395, 5998.190244316961, 6072.544559157993, 5720.11338242573, 5831.82504524848, 5842.38654941225, 5952.107183922273, 5957.582969192115], "value": 5649.598496297257, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.3808070871057, 501.0, 501.9397672279329, 537.0118981074821, 538.3969953651911, 24221.63667544986, 40095.1980960381, 41393.58606413935, 41406.17187656253, 43228.0, 42045.7897710511, 42477.0, 42551.936201594974, 42563.36154957678, 42606.57393426065, 8817.73546793594, 9831.705048848527, 9991.850122248172, 10007.349522281029, 10018.448985305806, 8856.778580535474, 12003.699907502294, 12340.444679989421, 12352.135350525466, 12516.93741531291, 11967.820482692767, 12267.386630668476, 12359.752804943895, 12398.0, 12417.937910310437, 11627.47676354562, 12349.753004939941, 12351.19717218378, 12375.443105060294, 12393.442295096742, 10191.89808101917, 11987.82018269718, 12054.69863253417, 12068.336241506713, 12111.878881211163, 38836.41745373821, 39118.02204944871, 39140.60859391398, 39153.21693566141, 39249.21501569981, 3216.3084936738715, 3235.304409551934, 3280.7703460757757, 3525.506429099928, 3535.5934067582302, 30427.695723042707, 31078.067657970296, 31146.909858154857, 31321.530177047363, 31520.0, 3189.4418476766473, 3213.1324542373663, 3215.2283451971593, 3254.446744053517, 3327.783694059878, 404125.0, 407021.0, 407698.0, 408003.0, 409206.95396523125, 32642.836785815918, 33549.66450335514, 54515.72742136264, 54934.0, 55009.0, 34542.48186277208, 34808.0, 34874.0, 34965.0, 34973.9507814766, 14350.641233969234, 14488.782668259984, 14504.927475362556, 14529.854701453061, 14550.12699238049, 11008.339499630049, 11272.71818204535, 12131.090168237417, 12304.200226985216, 12427.005839532816, 7462.70149194037, 7577.2951086005205, 7639.961800190964, 7661.348785353196, 7661.923380766232, 3226.6934641209045, 3274.721648659843, 3281.2289112058647, 3287.4247006773717, 3301.834908254578, 766.8772996320673, 964.2671569607149, 993.2848349188573, 993.8012397520525, 1043.1654676258963, 23007.88496057509, 28739.712602873704, 29070.679124863393, 29388.0, 29524.852375737984, 1046.2257929132538, 1047.7328281288223, 1055.9260851740457, 1101.2346419238713, 1113.5211858900589, 13469.932650336686, 15133.092014479167, 15523.0, 15635.905486615828, 15638.530844074696, 567903.0, 571029.0, 572466.0, 574904.0, 575068.1246593824, 54449.72775136099, 55109.448905511235, 55142.0, 55236.0, 55243.0, 1217.8234156047502, 1260.9684757880943, 1342.41604901868, 1367.541873472378, 1383.5295999360064, 27004.745194991752, 27219.86390068037, 30854.53718194274, 31372.686273136977, 31434.37131257408, 47765.0, 48157.5184248153, 48200.75899620479, 48290.27564586464, 48295.75852120717, 516708.0, 519237.0, 519428.0, 519680.0, 520943.0, 22207.555848883254, 25866.35334116662, 26174.476510470064, 26829.597556036286, 27777.305567360978, 46022.0, 46534.0, 46667.766661166475, 47144.29283560681, 47716.52283477121, 38201.0, 38489.037774055876, 38641.806790965864, 39162.412563811, 39834.0, 36913.815430922674, 37261.0684732873, 37300.06749831276, 38253.80873095728, 38998.80500597479, 36449.0, 37235.6276437243, 37910.62089379181, 38001.80999094987, 38030.61969380381, 31821.522677160323, 31949.0, 33479.83260083781, 34245.31509369848, 34494.82752586221, 24738.628920565847, 25109.748902510742, 25281.49437011286, 25466.0, 25783.871080644476], "value": 18540.295536298374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.7895988647493, 346.48027958062903, 369.5417682074229, 371.9981400092999, 401.9176068905875, 14852.48016319429, 15214.923925380372, 15412.15233162177, 20568.177272909066, 21207.257745978895, 18593.0, 19496.122674479648, 19934.202631894743, 20338.796612033875, 20587.38237852863, 4945.925811112827, 6148.38516148386, 6150.600210986294, 6157.938420615781, 6161.784337548187, 5322.494363035506, 5962.672053037081, 6080.908786368208, 6152.784652537162, 6155.8153255402185, 5820.214271073414, 6056.273247210341, 6092.177556029924, 6094.939050609503, 6106.206193194901, 5988.251468566429, 6110.725017374229, 6110.969445152746, 6113.786017489411, 6116.9906965350665, 5114.600701789292, 5168.147255702805, 5311.176767601028, 5320.042392369372, 5320.414754377015, 26325.0, 26511.73488265112, 26544.60183097255, 26735.866320668465, 26803.0, 2396.3769419950936, 2398.9640155397683, 2938.823670579772, 3071.539269109629, 3212.1166679163416, 11344.205905586612, 15330.080195188324, 15517.922410387988, 15786.526404207892, 15843.762343564857, 1679.7480377943284, 1765.6733504301744, 1831.2034265094594, 1910.9140088696042, 1915.0807612346014, 110349.24062909324, 114574.0, 116671.0, 118590.40704796507, 123712.0, 10903.364495325764, 10921.726956825984, 11269.71825704364, 11433.314001159957, 11522.76954460906, 14433.494827680981, 14475.855241447662, 14486.420543178365, 14497.565073047825, 14501.419943202365, 8372.958135209285, 8512.191341822518, 8514.106018868053, 8522.318214542822, 8657.264132548678, 8186.877196841933, 8371.609498153257, 8438.915610843937, 8654.6970856021, 8662.003869555081, 3789.5831458539537, 3955.723099383073, 4470.619997300266, 4508.346289787963, 4563.224251877189, 1631.2740830330627, 1853.5458812591, 1910.732497450358, 1922.846172306212, 1930.4691209917105, 793.4525177627419, 841.7096101844976, 915.4507295622573, 955.2358113509165, 994.7314225159166, 20491.897540512502, 21022.579548408947, 21172.894135529532, 21371.35885923425, 21394.35816925495, 932.9440233585871, 941.3880977364768, 941.8116376724546, 947.8720322815827, 972.3409755224666, 10296.176305895511, 10797.62208322705, 10979.505922233519, 11325.263857849379, 11337.26307789991, 556967.2151639297, 558935.0, 560963.0, 571872.0, 594126.0, 119940.0, 121522.0, 122639.0, 124275.0, 124494.37752811359, 955.7276176289724, 971.6502059258661, 998.7153661206667, 1000.2997901469001, 1000.9949950250202, 18512.537186570444, 18667.253309867996, 18802.717959230897, 18844.434666960013, 18873.961932093865, 51287.74356128195, 52281.43155705335, 53846.0, 54772.72613636906, 54889.668756310726, 73159.63420182865, 73743.0, 76785.0, 77171.0, 77581.2241877574, 5436.130219164915, 7963.522188668699, 8004.95997520032, 8045.597720113854, 8404.453710508797, 10293.309843472503, 10992.792837726563, 12770.744585108432, 12978.740425191254, 13073.542426015043, 11152.776944461228, 11311.434428278388, 11435.542578296774, 11578.36319002463, 11598.652040438801, 10803.945980270048, 10915.181361398085, 11007.504662290055, 11241.775164496501, 11352.205345626056, 9790.902090979283, 11146.49840757184, 11470.197086203885, 11474.0, 11680.0, 8051.83896322082, 8169.183081691784, 8222.136675648972, 8259.091499934882, 8358.492452264418, 11237.49431275611, 11252.502358832095, 11362.091032717528, 11461.885381146081, 11464.94267528657], "value": 9592.496239705251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.3236697834561, 1523.9542813715586, 1546.5051183621238, 1775.5383600263926, 1952.73638058862, 7887.684492620296, 8418.200270974256, 8554.700585479517, 8944.50805205715, 8951.0, 8809.54642483991, 8889.28885689145, 8891.955540222307, 8901.020887702363, 8904.465732056065, 2299.8390112692077, 2344.4490544721975, 2348.5537747827943, 2350.5063936573342, 2364.3498038039593, 2302.3783578433813, 2341.7775311345395, 2342.472943587696, 2344.6131388320905, 2347.295811256616, 2300.850444721096, 2316.061994892071, 2329.091654254842, 2340.2511196417154, 2343.6718859359703, 2272.4659704969317, 2296.2881506732965, 2303.090279339668, 2304.182015384531, 2326.790588847012, 2300.6894069300597, 2304.2165663674264, 2305.5619432307976, 2305.7694230576976, 2307.826912981533, 8886.155815197546, 8900.243479304203, 8947.686830960885, 8967.641294348217, 9008.864867027, 5181.1969144782615, 5393.9730301348245, 5395.595330350239, 5421.457854214586, 5424.077906755861, 3465.428204346305, 3606.6934310583633, 3684.042149041242, 3686.8156592170553, 3695.7597756145765, 846.289117141604, 1052.7315534538643, 1080.9621663241749, 1086.869575650919, 1111.394290111891, 11875.0, 11922.761544769057, 12018.51925922962, 12032.157748957576, 12037.277763334228, 4334.068175342317, 4394.143142087326, 4560.954390456053, 4592.70147440422, 4605.815767369335, 9272.119148680864, 9278.11857873501, 9281.025492323344, 9288.674896378594, 9288.953555232316, 5203.947960520422, 5206.921896171561, 5214.348206474191, 5220.138677118233, 5229.0, 4123.237201117803, 4365.345198220292, 4529.547045295444, 4530.886727831765, 4884.7069175849565, 3222.38774632819, 3692.298463291966, 3714.4985426967555, 3820.5797362290127, 3822.140018495872, 1097.5774326884207, 1101.0695961912172, 1103.5916710817048, 1104.718296834302, 1105.1269497097364, 813.5484805932764, 827.6027506796651, 868.8305780372766, 874.208840998897, 919.1268295119663, 5440.265564148868, 5581.0, 5728.914066289009, 5931.872944140599, 5958.821235362946, 964.8166848298941, 973.6592192732628, 975.3367709957297, 991.7074463033423, 1047.3349423116224, 3631.8002509862213, 3663.6885864701267, 3752.7308838133067, 3854.4411060396646, 3882.2041481496226, 10619.30974486656, 10881.782364352668, 10976.341419514694, 10992.615258465916, 11000.559977600806, 10533.736656583647, 10937.234393592373, 10943.671689849318, 10950.452477376099, 10954.0, 7119.1457025157315, 8177.427580069457, 8323.458975166595, 8345.707900223462, 8357.707480238285, 5799.101139323411, 5943.821685349447, 5981.401859813984, 6003.3996600339615, 6039.849003774941, 9402.34183607141, 9517.619295228113, 10007.149392301735, 10247.180225581786, 10301.330413523097, 9439.00890406525, 10016.699499015042, 10301.639442619473, 10372.636957706443, 10434.21743369235, 7053.823654408476, 7305.269473052652, 7382.2617738225745, 7594.924050759421, 7625.428092893166, 8281.875771863548, 8291.170882911661, 8373.246407823324, 8389.580520974048, 8486.957565212135, 7566.659500322608, 7577.469577129768, 7601.011868457065, 7609.733659322119, 7753.030871141107, 7347.66935487915, 7430.145533263744, 7447.404207663482, 7478.850422991401, 7640.885386719093, 6683.198016237888, 6922.411595014481, 6934.237233904368, 6998.965005174941, 7002.544834585736, 4456.331550267356, 4538.568835960578, 4561.29299958507, 4575.130725162208, 4671.579557839811, 4851.126797176401, 4934.259861020875, 4987.376577927759, 5148.0, 5166.405863325615], "value": 4529.1201050150985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.65744435399694, 295.4666826378387, 305.9109569931045, 310.25074445214807, 313.5813688725551, 4914.778834952427, 5159.380874295085, 5162.22566615008, 5193.32486776719, 5254.18560123181, 4533.637309015279, 4955.3310303109065, 5008.424031236409, 5042.520960508755, 5126.5642420394315, 3322.900312990614, 3929.862454814082, 3946.3093958557283, 3951.565327813938, 3987.6610488108545, 3670.0, 3981.6615587675083, 3992.662458076548, 4001.9799901000456, 4003.878913904097, 3731.365667836474, 3737.5514938207452, 3891.9610803891883, 3920.882373528799, 3968.206358728266, 3325.451300535409, 3960.425738267964, 3962.5443074046566, 3970.205958808221, 3987.7607343559334, 3468.3583537045474, 3468.7918724876336, 3485.9128521786906, 3491.9825400873087, 3497.7726447780815, 4878.877858092623, 5043.42000669924, 5046.19260918255, 5056.342675452168, 5090.821821236239, 4480.215962206601, 4520.50274469808, 4528.75091869947, 4556.7721613919175, 4571.040081582838, 4808.2787581863, 5256.316678831766, 5446.782128714846, 5451.291332126838, 5454.400015998237, 3580.6240344763946, 3593.975716920665, 3750.3436898542645, 3750.456183853326, 3819.4652748615217, 4830.6135509159185, 4970.005998800254, 5441.476386611755, 5724.227229324029, 5747.856303592402, 3201.951970720441, 3701.296753616858, 3710.257948410275, 3716.201016781351, 3810.314143454205, 3105.1460848266906, 3358.983205083959, 3776.1126135358168, 3864.401017842239, 3884.0678237222864, 3810.7713537187856, 4467.5755803198645, 4532.637389008872, 4534.410526631583, 4548.361950068952, 4559.430071241095, 5219.973900130551, 5321.946780532223, 5508.804893161957, 5564.1931919871395, 1048.5910494906993, 1310.6919873829643, 1318.9975618529986, 1323.8808507234396, 1328.0902581731352, 651.8989556618732, 771.4831063187678, 797.6211299632628, 812.1513018895268, 814.8288859339605, 3980.0, 4187.183499217685, 4215.0, 4252.659787217015, 4341.956580434218, 4656.67403281767, 4662.883427914329, 4665.136949664323, 4673.859784206479, 4698.765061746899, 4264.0, 4272.594103560157, 4272.786360682016, 4275.0, 4291.077418355007, 2318.652202169688, 2661.8136730429073, 2949.2037149969387, 2977.746891514202, 2978.89573864918, 5479.8492316613165, 5799.318197722613, 5812.21535092757, 5815.214945982323, 5844.590878638454, 5306.814261500829, 5473.370562385297, 5763.85590360236, 5766.163906233573, 5793.188953546507, 5597.104463285936, 5696.525119676994, 5762.222100016612, 5768.538516918553, 5803.839232153586, 5609.523190528687, 5612.382637909908, 5616.943830561642, 5661.348944871393, 5671.602987790815, 4544.7045942013665, 4615.30770384445, 5307.187190788888, 5389.029974604452, 5749.9712501437225, 4843.733594652328, 5518.420565840529, 5788.247527821356, 5799.4921320457825, 5846.0, 3444.9483257750653, 3583.691952437394, 3646.2707458508935, 3684.5446048811104, 3816.637419445148, 4564.589186973056, 5327.137825076943, 5624.437556244507, 5718.285214348207, 5757.510611598061, 4858.465568787501, 4997.725125118008, 5279.788808447773, 5474.315710536183, 5513.365962914316, 5215.191645294985, 5446.237526746179, 5474.1807968895255, 5475.890482190413, 5506.889862202814, 4561.7262964222255, 4865.375295404946, 5369.838904832861, 5391.272178255886, 5426.155107263549, 5073.53933342336, 5385.46145385474, 5432.728363581726, 5449.0, 5495.890082198253, 4810.921010553318, 5384.246205531151, 5400.945990540202, 5434.945650543444, 5470.671759694431], "value": 3921.366483029584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.7699747582034, 710.4848984486247, 719.2879049740754, 720.8414148887247, 749.4880817478781, 14939.25303734813, 15843.683126337466, 15855.0, 15899.52301430956, 15900.602484937883, 14347.64130896728, 14463.638409039779, 14504.129752214874, 14504.274786260698, 14518.637034074154, 665.7137430904709, 688.2532452289272, 689.0904006711144, 829.8340331933607, 854.940154189207, 839.3662784597651, 856.1053698884681, 861.6036623153357, 877.5656050255133, 879.4811061473729, 906.7914379692675, 908.4413085952158, 908.5865931001379, 908.9272858171363, 909.6816114359988, 707.5789905006513, 901.1664210605197, 902.2376092202079, 902.3593248793364, 902.571278642646, 550.4852962480094, 551.9144532597454, 553.3691591585596, 553.3940335332804, 665.9600423974578, 14814.259287035606, 15275.847241527665, 15283.770743438858, 15332.0, 15335.693286134327, 13786.724265514735, 14001.649958751012, 14194.716105677828, 14205.573832785032, 14225.928870355581, 12870.485180592765, 12874.16317939331, 12965.546205882843, 13150.802737958938, 13260.867391326059, 4289.120730250291, 4333.739975601474, 4362.520122786491, 4429.291313389842, 4513.909721805579, 93361.0, 96077.0, 112022.0, 116881.41559292233, 122434.0, 11111.888881111247, 11121.610743624096, 11163.665090047312, 11562.826557601642, 11616.303021818549, 21854.45363865916, 21858.797766122698, 21882.343529693815, 21886.562268754536, 21941.890290548447, 8021.598920053974, 8212.0, 8245.340372770284, 8248.422610417334, 8360.665573376997, 3981.581933896899, 4300.505441874162, 4416.536263692266, 4441.777911104432, 4447.155040542287, 3620.0, 3723.888283351504, 3758.041699366644, 3759.266942946154, 3767.849286028583, 683.0573808144728, 683.736761346885, 686.5708931917552, 692.6848284030754, 700.3906601256939, 570.9314882214161, 583.1718959078034, 664.973401063952, 679.2935347238816, 689.9206591241971, 8798.86801697975, 8833.734987950373, 9483.241340692866, 9590.952045239728, 9613.759656008517, 623.5790841182184, 638.9680515974183, 644.3685188515282, 669.4410167510086, 671.6775947545206, 4398.274284743045, 4608.124456353282, 4659.836905708284, 4675.836345727951, 4797.112534181188, 105750.4712476448, 163029.73039178946, 165850.0, 176372.0, 180553.0, 143927.2803635975, 144176.0, 146363.0, 152054.0, 153030.0, 81509.18490815016, 108463.37304940433, 113486.43256783663, 115814.0, 120901.18648220284, 7924.881126782988, 8247.134050924567, 8965.013848476792, 8966.730998070068, 9079.95460022722, 59866.605335787826, 65481.34518654752, 66599.66700166468, 67616.0, 67811.0, 76117.0, 94192.0, 97333.51333243572, 98023.0, 101768.98231017595, 10914.0, 11243.66269011931, 11348.659540213806, 11577.363245021605, 12268.141230113806, 13123.015773817193, 14515.782263265848, 14893.85106148968, 15329.6167595811, 16036.198190090683, 14072.507462238773, 14244.715105698035, 14264.643383915485, 14362.425502979764, 14416.42334306616, 13829.892716203509, 13831.515896943558, 14096.718065638424, 14105.506307279196, 14546.345414456586, 13608.31958402056, 13626.591202263948, 14071.929640351733, 14101.6474588132, 14432.278386080445, 11344.602938897098, 11482.885171148515, 11661.65015049516, 11747.588834390755, 11910.702232444259, 11303.660890173307, 11320.320780753182, 11426.0, 11652.0, 11701.941490292495], "value": 7910.309857880747, "unit": "score"}], "name": "dromaeo_css", "value": 7215.937639317944, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 169.0, 145.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0], "value": 126.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 146.0, 180.0, 131.0, 112.0, 115.0, 112.0, 145.0, 113.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 197.0, 261.0, 190.0, 186.0, 174.0, 182.0, 184.0, 183.0, 182.0], "value": 192.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 60.0, 96.0, 63.0, 61.0, 58.0, 61.0, 81.0, 57.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 73.0, 92.0, 70.0, 68.0, 70.0, 93.0, 68.0, 70.0, 93.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 89.0, 85.0, 88.0, 87.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 92.0, 94.0, 94.0, 93.0, 92.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 84.0, 83.0, 86.0, 81.0, 90.0, 83.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 68.0, 76.0, 70.0, 69.0, 71.0, 68.0, 69.0, 72.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 104.0, 87.0, 87.0, 86.0, 89.0, 85.0, 87.0, 90.0, 91.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 149.0, 156.0, 159.0, 148.0, 156.0, 149.0, 159.0, 231.0, 147.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 173.0, 173.0, 174.0, 174.0, 171.0, 226.0, 174.0, 176.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 68.0, 69.0, 69.0, 69.0, 71.0, 69.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1486.3999999999999, "alertThreshold": 2.0}]} 05:29:30 INFO - Return code: 0 05:29:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:30 INFO - # TBPL SUCCESS # 05:29:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:30 INFO - 2016-10-04 05:29:30.941 screenresolution[1666:9731] starting screenresolution argv=screenresolution get 05:29:30 INFO - 2016-10-04 05:29:30.944 screenresolution[1666:9731] Display 0: 1600x1200x32@60 05:29:30 INFO - 2016-10-04 05:29:30.950 screenresolution[1667:9734] starting screenresolution argv=screenresolution list 05:29:30 INFO - Available Modes on Display 0 05:29:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:31 INFO - Intel Iris: 05:29:31 INFO - Chipset Model: Intel Iris 05:29:31 INFO - Type: GPU 05:29:31 INFO - Bus: Built-In 05:29:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:31 INFO - Vendor: Intel (0x8086) 05:29:31 INFO - Device ID: 0x0a2e 05:29:31 INFO - Revision ID: 0x0009 05:29:31 INFO - Displays: 05:29:31 INFO - Display: 05:29:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:31 INFO - Display Serial Number: 1600x1200 60 05:29:31 INFO - Main Display: Yes 05:29:31 INFO - Mirror: Off 05:29:31 INFO - Online: Yes 05:29:31 INFO - Rotation: Supported 05:29:31 INFO - Return code: 0 05:29:31 INFO - Running post-action listener: _resource_record_post_action 05:29:31 INFO - [mozharness: 2016-10-04 12:29:31.183929Z] Finished run-tests step (success) 05:29:31 INFO - Running post-run listener: _resource_record_post_run 05:29:31 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 37114880; Write bytes: 706972672; Read time: 242; Write time: 2004 05:29:31 INFO - TinderboxPrint: CPU usage
53.4% 05:29:31 INFO - TinderboxPrint: I/O read bytes / time
37,114,880 / 242 05:29:31 INFO - TinderboxPrint: I/O write bytes / time
706,972,672 / 2,004 05:29:31 INFO - TinderboxPrint: CPU idle
2,259.5 (46.6%) 05:29:31 INFO - TinderboxPrint: CPU system
966.9 (19.9%) 05:29:31 INFO - TinderboxPrint: CPU user
1,627.3 (33.5%) 05:29:31 INFO - TinderboxPrint: Swap in / out
444,878,848 / 0 05:29:31 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397746688; Write bytes: 391497728; Read time: 29500; Write time: 829 05:29:31 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35173376; Write bytes: 296596480; Read time: 225; Write time: 1125 05:29:31 INFO - Running post-run listener: _upload_blobber_files 05:29:31 INFO - Blob upload gear active. 05:29:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:33 INFO - (blobuploader) - INFO - Done attempting. 05:29:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:29:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:29:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:34 INFO - (blobuploader) - INFO - Done attempting. 05:29:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:37 INFO - (blobuploader) - INFO - Done attempting. 05:29:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:37 INFO - Return code: 0 05:29:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5893144f9b44cde35825790a7b57e987c2fa464763c8dd1d30a7157b7a00c8dea465a11f06c700146edd14fa2635e1e9b025cfd6d8570916f1bbf85cbe7de8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f4009674a1572381f5f5e77382981b2b03e2fe7c10756101bec8e04e41bd9ebc23349bb6c1230fbf2d544068fe1c4e7cc40d7b0fbd3e61eb0a61244f865e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80eeab8ca236b64759fd3943f7100ff5d179816666c8a6602eab562723ade257226e8771894e14016a03329f44894f83d8b1f0e737fc86b56f8f80bb0908287"} 05:29:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:37 INFO - Contents: 05:29:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5893144f9b44cde35825790a7b57e987c2fa464763c8dd1d30a7157b7a00c8dea465a11f06c700146edd14fa2635e1e9b025cfd6d8570916f1bbf85cbe7de8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f4009674a1572381f5f5e77382981b2b03e2fe7c10756101bec8e04e41bd9ebc23349bb6c1230fbf2d544068fe1c4e7cc40d7b0fbd3e61eb0a61244f865e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80eeab8ca236b64759fd3943f7100ff5d179816666c8a6602eab562723ade257226e8771894e14016a03329f44894f83d8b1f0e737fc86b56f8f80bb0908287"} 05:29:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:37 INFO - Copying logs to upload dir... 05:29:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.721812 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 05:29:37.257817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 05:29:37.261426) ========= 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.tKENF8I0U3/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.OZckCxaqVo/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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/d5893144f9b44cde35825790a7b57e987c2fa464763c8dd1d30a7157b7a00c8dea465a11f06c700146edd14fa2635e1e9b025cfd6d8570916f1bbf85cbe7de8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f4009674a1572381f5f5e77382981b2b03e2fe7c10756101bec8e04e41bd9ebc23349bb6c1230fbf2d544068fe1c4e7cc40d7b0fbd3e61eb0a61244f865e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80eeab8ca236b64759fd3943f7100ff5d179816666c8a6602eab562723ade257226e8771894e14016a03329f44894f83d8b1f0e737fc86b56f8f80bb0908287"} build_url:https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010832 build_url: 'https://queue.taskcluster.net/v1/task/MrxUmolAQo69kaPYwXYmvA/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/d5893144f9b44cde35825790a7b57e987c2fa464763c8dd1d30a7157b7a00c8dea465a11f06c700146edd14fa2635e1e9b025cfd6d8570916f1bbf85cbe7de8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f4009674a1572381f5f5e77382981b2b03e2fe7c10756101bec8e04e41bd9ebc23349bb6c1230fbf2d544068fe1c4e7cc40d7b0fbd3e61eb0a61244f865e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80eeab8ca236b64759fd3943f7100ff5d179816666c8a6602eab562723ade257226e8771894e14016a03329f44894f83d8b1f0e737fc86b56f8f80bb0908287"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 05:29:37.298104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:29:37.298897) ========= 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.tKENF8I0U3/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.OZckCxaqVo/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.005025 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:29:37.351400) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 05:29:37.352098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 05:29:37.352821) ========= ========= Total master_lag: 0.18 =========