builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0184 starttime: 1479747132.68 results: success (0) buildid: 20161121061709 builduid: 8af0ecf1e765445e942611f487c41a33 revision: cb5d57c8c7547bf5d6d86a04062c10fcd98e6667 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:12.676235) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:12.676648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:12.676931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:12.702271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:12.702602) ========= 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.siJWTE7ASv/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.hM4gj5FICQ/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-21 08:52:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2016-11-21 08:52:13 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.495383 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:13.219756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:13.220078) ========= 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.siJWTE7ASv/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.hM4gj5FICQ/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.021478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:13.271572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-21 08:52:13.271916) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb5d57c8c7547bf5d6d86a04062c10fcd98e6667 --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 cb5d57c8c7547bf5d6d86a04062c10fcd98e6667 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.siJWTE7ASv/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.hM4gj5FICQ/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-21 08:52:13,355 truncating revision to first 12 chars 2016-11-21 08:52:13,355 Setting DEBUG logging. 2016-11-21 08:52:13,355 attempt 1/10 2016-11-21 08:52:13,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb5d57c8c754?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 08:52:15,269 unpacking tar archive at: mozilla-central-cb5d57c8c754/testing/mozharness/ program finished with exit code 0 elapsedTime=2.157328 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-21 08:52:15.455152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:15.455524) ========= script_repo_revision: cb5d57c8c7547bf5d6d86a04062c10fcd98e6667 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:15.456027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:15.456335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 08:52:15.475096) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-21 08:52:15.475437) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.siJWTE7ASv/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.hM4gj5FICQ/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:52:15 INFO - MultiFileLogger online at 20161121 08:52:15 in /builds/slave/test 08:52:15 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 08:52:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:15 INFO - {'append_to_log': False, 08:52:15 INFO - 'base_work_dir': '/builds/slave/test', 08:52:15 INFO - 'blob_upload_branch': 'Firefox', 08:52:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:15 INFO - 'branch': 'Firefox', 08:52:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:15 INFO - 'config_files': ('talos/mac_config.py',), 08:52:15 INFO - 'default_actions': ('clobber', 08:52:15 INFO - 'read-buildbot-config', 08:52:15 INFO - 'download-and-extract', 08:52:15 INFO - 'populate-webroot', 08:52:15 INFO - 'create-virtualenv', 08:52:15 INFO - 'install', 08:52:15 INFO - 'run-tests'), 08:52:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:15 INFO - 'download_minidump_stackwalk': True, 08:52:15 INFO - 'download_symbols': 'ondemand', 08:52:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:15 INFO - 'installer_path': 'installer.exe', 08:52:15 INFO - 'log_level': 'info', 08:52:15 INFO - 'log_name': 'talos', 08:52:15 INFO - 'log_to_console': True, 08:52:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:52:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:52:15 INFO - 'opt_config_files': (), 08:52:15 INFO - 'pip_index': False, 08:52:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:15 INFO - 'cmd': ('bash', 08:52:15 INFO - '-c', 08:52:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:15 INFO - 'enabled': True, 08:52:15 INFO - 'halt_on_failure': False, 08:52:15 INFO - 'name': 'check_screen_resolution'},), 08:52:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:15 INFO - 'cmd': ('bash', 08:52:15 INFO - '-c', 08:52:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:15 INFO - 'enabled': True, 08:52:15 INFO - 'halt_on_failure': False, 08:52:15 INFO - 'name': 'check_screen_resolution'},), 08:52:15 INFO - 'run_cmd_checks_enabled': True, 08:52:15 INFO - 'sps_profile': False, 08:52:15 INFO - 'sps_profile_interval': 0, 08:52:15 INFO - 'suite': 'dromaeojs', 08:52:15 INFO - 'system_bits': '32', 08:52:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:15 INFO - 'title': 't-yosemite-r7-0184', 08:52:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:15 INFO - 'use_talos_json': True, 08:52:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:15 INFO - 'work_dir': 'build'} 08:52:15 INFO - [mozharness: 2016-11-21 16:52:15.679260Z] Running clobber step. 08:52:15 INFO - Running pre-action listener: _resource_record_pre_action 08:52:15 INFO - Running main action method: clobber 08:52:15 INFO - rmtree: /builds/slave/test/build 08:52:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:16 INFO - Running post-action listener: _resource_record_post_action 08:52:16 INFO - [mozharness: 2016-11-21 16:52:16.638716Z] Finished clobber step (success) 08:52:16 INFO - [mozharness: 2016-11-21 16:52:16.638978Z] Running read-buildbot-config step. 08:52:16 INFO - Running pre-action listener: _resource_record_pre_action 08:52:16 INFO - Running main action method: read_buildbot_config 08:52:16 INFO - Using buildbot properties: 08:52:16 INFO - { 08:52:16 INFO - "project": "", 08:52:16 INFO - "product": "firefox", 08:52:16 INFO - "script_repo_revision": "production", 08:52:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:52:16 INFO - "repository": "", 08:52:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:52:16 INFO - "buildid": "20161121061709", 08:52:16 INFO - "pgo_build": "False", 08:52:16 INFO - "basedir": "/builds/slave/test", 08:52:16 INFO - "buildnumber": 20, 08:52:16 INFO - "slavename": "t-yosemite-r7-0184", 08:52:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:52:16 INFO - "platform": "yosemite_r7", 08:52:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:52:16 INFO - "branch": "mozilla-central", 08:52:16 INFO - "repo_path": "mozilla-central", 08:52:16 INFO - "revision": "cb5d57c8c7547bf5d6d86a04062c10fcd98e6667", 08:52:16 INFO - "stage_platform": "macosx64", 08:52:16 INFO - "builduid": "8af0ecf1e765445e942611f487c41a33", 08:52:16 INFO - "slavebuilddir": "test" 08:52:16 INFO - } 08:52:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:52:16 INFO - Running post-action listener: _resource_record_post_action 08:52:16 INFO - [mozharness: 2016-11-21 16:52:16.644624Z] Finished read-buildbot-config step (success) 08:52:16 INFO - [mozharness: 2016-11-21 16:52:16.644861Z] Running download-and-extract step. 08:52:16 INFO - Running pre-action listener: _resource_record_pre_action 08:52:16 INFO - Running main action method: download_and_extract 08:52:16 INFO - mkdir: /builds/slave/test/build/tests 08:52: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')]} 08:52:16 INFO - trying https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:52:16 INFO - Downloading https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:52:18 INFO - Downloaded 1199 bytes. 08:52:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:52:18 INFO - Using the following test package requirements: 08:52:18 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:52:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:52:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:52:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'jsshell-mac.zip'], 08:52:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:52:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:52:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:52:18 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:52:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:52:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:52:18 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:52:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:52:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:52:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:52:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:52:18 INFO - Http code: 200 08:52:18 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 08:52:18 INFO - x-amz-cf-id: 9Xc5p163r3oT1-UujbVit8uAeaX0_bBZR5FKsWSvZESBmd3CdQ7XFw== 08:52:18 INFO - x-amz-version-id: zKxqNosaexmkq.u5sirRi5mNDmEgPfNM 08:52:19 INFO - Expected file size: 16265579 08:52:19 INFO - Obtained file size: 16265579 08:52:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:52:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:52:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:52:25 INFO - Fetch https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:52:26 INFO - Http code: 200 08:52:26 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 08:52:26 INFO - x-amz-cf-id: v4tofh1x5j5rHVNmkMbuIAF0fEPVXYDg3quwE8lTVzg3ndhhpJ6zeA== 08:52:26 INFO - x-amz-version-id: zKxqNosaexmkq.u5sirRi5mNDmEgPfNM 08:52:26 INFO - Expected file size: 16265579 08:52:26 INFO - Obtained file size: 16265579 08:52:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:52:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:52:32 INFO - Fetch https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:52:34 INFO - Http code: 200 08:52:34 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:52:34 INFO - x-amz-cf-id: 2BSIOuks6NwG6UzBuEf227BQdE0vOa5NVzGV3ka6K6RQYNtNEC3EmA== 08:52:34 INFO - x-amz-version-id: iL54nymbQAhBxeHU4X2QkFqnJ7jzHU6J 08:52:34 INFO - Expected file size: 14409392 08:52:34 INFO - Obtained file size: 14409392 08:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:34 INFO - trying https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:52:34 INFO - Downloading https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:52:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:52:37 INFO - Downloaded 107542278 bytes. 08:52:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:52:37 INFO - mkdir: /builds/slave/test/properties 08:52:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:37 INFO - Contents: 08:52:37 INFO - build_url:https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:52:38 INFO - Running post-action listener: _resource_record_post_action 08:52:38 INFO - Running post-action listener: set_extra_try_arguments 08:52:38 INFO - [mozharness: 2016-11-21 16:52:38.028584Z] Finished download-and-extract step (success) 08:52:38 INFO - [mozharness: 2016-11-21 16:52:38.028720Z] Running populate-webroot step. 08:52:38 INFO - Running pre-action listener: _resource_record_pre_action 08:52:38 INFO - Running main action method: populate_webroot 08:52:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:38 INFO - '--tppagecycles', 08:52:38 INFO - '7'], 08:52:38 INFO - 'tests': ['tsvgm']}}, 08:52:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:52:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:52:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:52:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:52:38 INFO - 'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:52:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:52:38 INFO - 'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['damp', 'tps']}, 08:52:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:52:38 INFO - 'tests': ['damp', 'tps']}, 08:52:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['dromaeo_dom']}, 08:52:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['basic_compositor_video']}, 08:52:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:52:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['a11yr', 08:52:38 INFO - 'ts_paint', 08:52:38 INFO - 'tpaint', 08:52:38 INFO - 'sessionrestore', 08:52:38 INFO - 'sessionrestore_no_auto_restore', 08:52:38 INFO - 'tabpaint']}, 08:52:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:52:38 INFO - 'ts_paint', 08:52:38 INFO - 'tpaint', 08:52:38 INFO - 'sessionrestore', 08:52:38 INFO - 'sessionrestore_no_auto_restore', 08:52:38 INFO - 'tabpaint']}, 08:52:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:52:38 INFO - 'ts_paint', 08:52:38 INFO - 'tpaint', 08:52:38 INFO - 'sessionrestore', 08:52:38 INFO - 'sessionrestore_no_auto_restore', 08:52:38 INFO - 'tabpaint']}, 08:52:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:52:38 INFO - 'ts_paint', 08:52:38 INFO - 'tpaint', 08:52:38 INFO - 'sessionrestore', 08:52:38 INFO - 'sessionrestore_no_auto_restore', 08:52:38 INFO - 'tabpaint']}, 08:52:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['a11yr', 08:52:38 INFO - 'ts_paint', 08:52:38 INFO - 'tpaint', 08:52:38 INFO - 'sessionrestore', 08:52:38 INFO - 'sessionrestore_no_auto_restore', 08:52:38 INFO - 'tabpaint']}, 08:52:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['a11yr', 08:52:38 INFO - 'ts_paint', 08:52:38 INFO - 'tpaint', 08:52:38 INFO - 'sessionrestore', 08:52:38 INFO - 'sessionrestore_no_auto_restore', 08:52:38 INFO - 'tabpaint']}, 08:52:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['tsvgx', 08:52:38 INFO - 'tsvgr_opacity', 08:52:38 INFO - 'tart', 08:52:38 INFO - 'tscrollx', 08:52:38 INFO - 'cart']}, 08:52:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:52:38 INFO - 'tsvgr_opacity', 08:52:38 INFO - 'tart', 08:52:38 INFO - 'tscrollx', 08:52:38 INFO - 'cart']}, 08:52:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:52:38 INFO - 'talos_options': ['--disable-e10s'], 08:52:38 INFO - 'tests': ['tp5o']}, 08:52:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:52:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:52:38 INFO - 'talos_options': ['--disable-e10s', 08:52:38 INFO - '--xperf_path', 08:52:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:38 INFO - 'tests': ['tp5n']}, 08:52:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:52:38 INFO - 'talos_options': ['--xperf_path', 08:52:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:38 INFO - 'tests': ['tp5n']}}, 08:52:38 INFO - 'talos.zip': {'path': '', 08:52:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:38 INFO - Running post-action listener: _resource_record_post_action 08:52:38 INFO - [mozharness: 2016-11-21 16:52:38.046669Z] Finished populate-webroot step (success) 08:52:38 INFO - [mozharness: 2016-11-21 16:52:38.046765Z] Running create-virtualenv step. 08:52:38 INFO - Running pre-action listener: _resource_record_pre_action 08:52:38 INFO - Running main action method: create_virtualenv 08:52:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:52:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:38 INFO - Using real prefix '/tools/python27' 08:52:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:41 INFO - Installing pip.................done. 08:52:41 INFO - Return code: 0 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:52:42 INFO - Reading from file tmpfile_stdout 08:52:42 INFO - Output received: 08:52:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:52:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:42 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 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:42 INFO - 'HOME': '/Users/cltbld', 08:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:42 INFO - 'LOGNAME': 'cltbld', 08:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:42 INFO - 'MOZ_NO_REMOTE': '1', 08:52:42 INFO - 'NO_EM_RESTART': '1', 08:52:42 INFO - 'PAGER': '/bin/cat', 08:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:42 INFO - 'PWD': '/builds/slave/test', 08:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:42 INFO - 'SHELL': '/bin/bash', 08:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:52:42 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:42 INFO - 'USER': 'cltbld', 08:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:42 INFO - 'XPC_FLAGS': '0x0', 08:52:42 INFO - 'XPC_SERVICE_NAME': '0', 08:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:52:42 INFO - Cleaning up... 08:52:42 INFO - Return code: 0 08:52:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:42 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 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:42 INFO - 'HOME': '/Users/cltbld', 08:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:42 INFO - 'LOGNAME': 'cltbld', 08:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:42 INFO - 'MOZ_NO_REMOTE': '1', 08:52:42 INFO - 'NO_EM_RESTART': '1', 08:52:42 INFO - 'PAGER': '/bin/cat', 08:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:42 INFO - 'PWD': '/builds/slave/test', 08:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:42 INFO - 'SHELL': '/bin/bash', 08:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:52:42 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:42 INFO - 'USER': 'cltbld', 08:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:42 INFO - 'XPC_FLAGS': '0x0', 08:52:42 INFO - 'XPC_SERVICE_NAME': '0', 08:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:42 INFO - Downloading/unpacking psutil>=3.1.1 08:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:46 INFO - Installing collected packages: psutil 08:52:46 INFO - Running setup.py install for psutil 08:52:46 INFO - building 'psutil._psutil_osx' extension 08:52:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:52:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:52:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:52:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:52:46 INFO - building 'psutil._psutil_posix' extension 08:52:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:52:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:52:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:52:46 INFO - ^ 08:52:46 INFO - 1 warning generated. 08:52:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:52:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:46 INFO - Successfully installed psutil 08:52:46 INFO - Cleaning up... 08:52:46 INFO - Return code: 0 08:52:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:52:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:52:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:46 INFO - 'HOME': '/Users/cltbld', 08:52:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:46 INFO - 'LOGNAME': 'cltbld', 08:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:46 INFO - 'MOZ_NO_REMOTE': '1', 08:52:46 INFO - 'NO_EM_RESTART': '1', 08:52:46 INFO - 'PAGER': '/bin/cat', 08:52:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:46 INFO - 'PWD': '/builds/slave/test', 08:52:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:46 INFO - 'SHELL': '/bin/bash', 08:52:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:52:46 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:52:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:46 INFO - 'USER': 'cltbld', 08:52:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:46 INFO - 'XPC_FLAGS': '0x0', 08:52:46 INFO - 'XPC_SERVICE_NAME': '0', 08:52:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:49 INFO - Installing collected packages: mozsystemmonitor 08:52:49 INFO - Running setup.py install for mozsystemmonitor 08:52:50 INFO - Successfully installed mozsystemmonitor 08:52:50 INFO - Cleaning up... 08:52:50 INFO - Return code: 0 08:52:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:52:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:52:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:50 INFO - 'HOME': '/Users/cltbld', 08:52:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:50 INFO - 'LOGNAME': 'cltbld', 08:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:50 INFO - 'MOZ_NO_REMOTE': '1', 08:52:50 INFO - 'NO_EM_RESTART': '1', 08:52:50 INFO - 'PAGER': '/bin/cat', 08:52:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:50 INFO - 'PWD': '/builds/slave/test', 08:52:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:50 INFO - 'SHELL': '/bin/bash', 08:52:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:52:50 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:52:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:50 INFO - 'USER': 'cltbld', 08:52:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:50 INFO - 'XPC_FLAGS': '0x0', 08:52:50 INFO - 'XPC_SERVICE_NAME': '0', 08:52:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:50 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:53 INFO - warning: no files found matching '*.txt' 08:52:53 INFO - no previously-included directories found matching 'build' 08:52:53 INFO - no previously-included directories found matching 'dist' 08:52:53 INFO - no previously-included directories found matching '.git*' 08:52:53 INFO - Installing collected packages: jsonschema, functools32 08:52:53 INFO - Running setup.py install for functools32 08:52:53 INFO - warning: no files found matching '*.txt' 08:52:53 INFO - no previously-included directories found matching 'build' 08:52:53 INFO - no previously-included directories found matching 'dist' 08:52:53 INFO - no previously-included directories found matching '.git*' 08:52:53 INFO - Successfully installed jsonschema functools32 08:52:53 INFO - Cleaning up... 08:52:53 INFO - Return code: 0 08:52:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:53 INFO - 'HOME': '/Users/cltbld', 08:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:53 INFO - 'LOGNAME': 'cltbld', 08:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:53 INFO - 'MOZ_NO_REMOTE': '1', 08:52:53 INFO - 'NO_EM_RESTART': '1', 08:52:53 INFO - 'PAGER': '/bin/cat', 08:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:53 INFO - 'PWD': '/builds/slave/test', 08:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:53 INFO - 'SHELL': '/bin/bash', 08:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:52:53 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:53 INFO - 'USER': 'cltbld', 08:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:53 INFO - 'XPC_FLAGS': '0x0', 08:52:53 INFO - 'XPC_SERVICE_NAME': '0', 08:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:53 INFO - Cleaning up... 08:52:53 INFO - Return code: 0 08:52:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:53 INFO - 'HOME': '/Users/cltbld', 08:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:53 INFO - 'LOGNAME': 'cltbld', 08:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:53 INFO - 'MOZ_NO_REMOTE': '1', 08:52:53 INFO - 'NO_EM_RESTART': '1', 08:52:53 INFO - 'PAGER': '/bin/cat', 08:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:53 INFO - 'PWD': '/builds/slave/test', 08:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:53 INFO - 'SHELL': '/bin/bash', 08:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:52:53 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:53 INFO - 'USER': 'cltbld', 08:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:53 INFO - 'XPC_FLAGS': '0x0', 08:52:53 INFO - 'XPC_SERVICE_NAME': '0', 08:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52: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 08:52: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 08:52: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 08:52: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 08:52: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 08:52: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 08:52:57 INFO - Downloading docopt-0.6.1.tar.gz 08:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:58 INFO - Running setup.py install for blobuploader 08:52:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:58 INFO - Running setup.py install for requests 08:52:58 INFO - Running setup.py install for docopt 08:52:58 INFO - Successfully installed blobuploader requests docopt 08:52:58 INFO - Cleaning up... 08:52:58 INFO - Return code: 0 08:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:58 INFO - 'HOME': '/Users/cltbld', 08:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:58 INFO - 'LOGNAME': 'cltbld', 08:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:58 INFO - 'MOZ_NO_REMOTE': '1', 08:52:58 INFO - 'NO_EM_RESTART': '1', 08:52:58 INFO - 'PAGER': '/bin/cat', 08:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:58 INFO - 'PWD': '/builds/slave/test', 08:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:58 INFO - 'SHELL': '/bin/bash', 08:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:52:58 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:58 INFO - 'USER': 'cltbld', 08:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:58 INFO - 'XPC_FLAGS': '0x0', 08:52:58 INFO - 'XPC_SERVICE_NAME': '0', 08:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Fuxsss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-EfT7np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-MkMuZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-vhFO7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-mHDyAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-l8YEfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-lwjR4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-FZItWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ZZn1Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-z0YPFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-_QHaPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Q5luzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-OP4SpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2yNaxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-d4Q3OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-a_ptnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:00 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-_rgze2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:00 INFO - Running setup.py install for manifestparser 08:53:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozcrash 08:53:01 INFO - Running setup.py install for mozdebug 08:53:01 INFO - Running setup.py install for mozdevice 08:53:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozfile 08:53:01 INFO - Running setup.py install for mozhttpd 08:53:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozinfo 08:53:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Running setup.py install for mozInstall 08:53:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Running setup.py install for mozleak 08:53:02 INFO - Running setup.py install for mozlog 08:53:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Running setup.py install for moznetwork 08:53:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Running setup.py install for mozprocess 08:53:02 INFO - Running setup.py install for mozprofile 08:53:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Running setup.py install for mozrunner 08:53:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:03 INFO - Running setup.py install for mozscreenshot 08:53:03 INFO - Running setup.py install for moztest 08:53:03 INFO - Running setup.py install for mozversion 08:53:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:03 INFO - Cleaning up... 08:53:03 INFO - Return code: 0 08:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:03 INFO - 'HOME': '/Users/cltbld', 08:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:03 INFO - 'LOGNAME': 'cltbld', 08:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:03 INFO - 'MOZ_NO_REMOTE': '1', 08:53:03 INFO - 'NO_EM_RESTART': '1', 08:53:03 INFO - 'PAGER': '/bin/cat', 08:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:03 INFO - 'PWD': '/builds/slave/test', 08:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:03 INFO - 'SHELL': '/bin/bash', 08:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:53:03 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:03 INFO - 'USER': 'cltbld', 08:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:03 INFO - 'XPC_FLAGS': '0x0', 08:53:03 INFO - 'XPC_SERVICE_NAME': '0', 08:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:03 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-MRtZYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:03 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-OJPsPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-gLFr9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Iqqf2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-MMH8tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-d7t3o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-jLJ9UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ykUppq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-P8x9fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-LNCP3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:04 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-GB0YMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:05 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-qZsRMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:05 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ISzdoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:05 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-T42zEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:05 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-gE21dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:05 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-hxFnWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:05 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-TAqreR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:08 INFO - Downloading blessings-1.6.tar.gz 08:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:08 INFO - Installing collected packages: blessings 08:53:08 INFO - Running setup.py install for blessings 08:53:08 INFO - Successfully installed blessings 08:53:08 INFO - Cleaning up... 08:53:08 INFO - Return code: 0 08:53:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:08 INFO - Reading from file tmpfile_stdout 08:53:08 INFO - Current package versions: 08:53:08 INFO - blessings == 1.6 08:53:08 INFO - blobuploader == 1.2.4 08:53:08 INFO - docopt == 0.6.1 08:53:08 INFO - functools32 == 3.2.3-2 08:53:08 INFO - jsonschema == 2.5.1 08:53:08 INFO - manifestparser == 1.1 08:53:08 INFO - mozInstall == 1.12 08:53:08 INFO - mozcrash == 1.0 08:53:08 INFO - mozdebug == 0.1 08:53:08 INFO - mozdevice == 0.49 08:53:08 INFO - mozfile == 1.2 08:53:08 INFO - mozhttpd == 0.7 08:53:08 INFO - mozinfo == 0.9 08:53:08 INFO - mozleak == 0.1 08:53:08 INFO - mozlog == 3.4 08:53:08 INFO - moznetwork == 0.27 08:53:08 INFO - mozprocess == 0.23 08:53:08 INFO - mozprofile == 0.28 08:53:08 INFO - mozrunner == 6.13 08:53:08 INFO - mozscreenshot == 0.1 08:53:08 INFO - mozsystemmonitor == 0.3 08:53:08 INFO - moztest == 0.7 08:53:08 INFO - mozversion == 1.4 08:53:08 INFO - psutil == 3.1.1 08:53:08 INFO - requests == 1.2.3 08:53:08 INFO - wsgiref == 0.1.2 08:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:53:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:09 INFO - 'HOME': '/Users/cltbld', 08:53:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:09 INFO - 'LOGNAME': 'cltbld', 08:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:09 INFO - 'MOZ_NO_REMOTE': '1', 08:53:09 INFO - 'NO_EM_RESTART': '1', 08:53:09 INFO - 'PAGER': '/bin/cat', 08:53:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:09 INFO - 'PWD': '/builds/slave/test', 08:53:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:09 INFO - 'SHELL': '/bin/bash', 08:53:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:53:09 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:53:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:09 INFO - 'USER': 'cltbld', 08:53:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:09 INFO - 'XPC_FLAGS': '0x0', 08:53:09 INFO - 'XPC_SERVICE_NAME': '0', 08:53:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:53:09 INFO - Cleaning up... 08:53:09 INFO - Return code: 0 08:53:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:10 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 0x1047d83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10474e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf2ad8a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, '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.siJWTE7ASv/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.hM4gj5FICQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:10 INFO - 'HOME': '/Users/cltbld', 08:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:10 INFO - 'LOGNAME': 'cltbld', 08:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:10 INFO - 'MOZ_NO_REMOTE': '1', 08:53:10 INFO - 'NO_EM_RESTART': '1', 08:53:10 INFO - 'PAGER': '/bin/cat', 08:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:10 INFO - 'PWD': '/builds/slave/test', 08:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:10 INFO - 'SHELL': '/bin/bash', 08:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:53:10 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:10 INFO - 'USER': 'cltbld', 08:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:10 INFO - 'XPC_FLAGS': '0x0', 08:53:10 INFO - 'XPC_SERVICE_NAME': '0', 08:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:10 INFO - Cleaning up... 08:53:10 INFO - Return code: 0 08:53:10 INFO - Running post-action listener: _resource_record_post_action 08:53:10 INFO - Running post-action listener: _start_resource_monitoring 08:53:10 INFO - Starting resource monitoring. 08:53:10 INFO - [mozharness: 2016-11-21 16:53:10.776592Z] Finished create-virtualenv step (success) 08:53:10 INFO - [mozharness: 2016-11-21 16:53:10.777591Z] Running install step. 08:53:10 INFO - Running pre-action listener: _resource_record_pre_action 08:53:10 INFO - Running main action method: install 08:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:11 INFO - Reading from file tmpfile_stdout 08:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:11 INFO - Reading from file tmpfile_stdout 08:53:11 INFO - Output received: 08:53:11 INFO - Usage: mozinstall [options] installer 08:53:11 INFO - Options: 08:53:11 INFO - -h, --help show this help message and exit 08:53:11 INFO - -d DEST, --destination=DEST 08:53:11 INFO - Directory to install application into. [default: 08:53:11 INFO - "/builds/slave/test"] 08:53:11 INFO - --app=APP Application being installed. [default: firefox] 08:53:11 INFO - mkdir: /builds/slave/test/build/application 08:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:53:44 INFO - Reading from file tmpfile_stdout 08:53:44 INFO - Output received: 08:53:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:53:44 INFO - Running post-action listener: _resource_record_post_action 08:53:44 INFO - [mozharness: 2016-11-21 16:53:44.369763Z] Finished install step (success) 08:53:44 INFO - [mozharness: 2016-11-21 16:53:44.369915Z] Running run-tests step. 08:53:44 INFO - Running pre-action listener: _resource_record_pre_action 08:53:44 INFO - Running main action method: run_tests 08:53:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:44 INFO - 2016-11-21 08:53:44.385 screenresolution[1947:16034] starting screenresolution argv=screenresolution get 08:53:44 INFO - 2016-11-21 08:53:44.387 screenresolution[1947:16034] Display 0: 1600x1200x32@60 08:53:44 INFO - 2016-11-21 08:53:44.393 screenresolution[1948:16036] starting screenresolution argv=screenresolution list 08:53:44 INFO - Available Modes on Display 0 08:53:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:44 INFO - Intel Iris: 08:53:44 INFO - Chipset Model: Intel Iris 08:53:44 INFO - Type: GPU 08:53:44 INFO - Bus: Built-In 08:53:44 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:44 INFO - Vendor: Intel (0x8086) 08:53:44 INFO - Device ID: 0x0a2e 08:53:44 INFO - Revision ID: 0x0009 08:53:44 INFO - Displays: 08:53:44 INFO - Display: 08:53:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:44 INFO - Display Serial Number: 1600x1200 60 08:53:44 INFO - Main Display: Yes 08:53:44 INFO - Mirror: Off 08:53:44 INFO - Online: Yes 08:53:44 INFO - Rotation: Supported 08:53:44 INFO - Return code: 0 08:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:44 INFO - Python 2.7.3 08:53:44 INFO - Return code: 0 08:53:44 INFO - grabbing minidump binary from tooltool 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045eed30>, '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 0x104455db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:53:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:53:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:53:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:44 INFO - Return code: 0 08:53:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:53:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:53:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 08:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0184 --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 08:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.siJWTE7ASv/Render', 08:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:44 INFO - 'HOME': '/Users/cltbld', 08:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:44 INFO - 'LOGNAME': 'cltbld', 08:53:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:44 INFO - 'MOZ_NO_REMOTE': '1', 08:53:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:44 INFO - 'NO_EM_RESTART': '1', 08:53:44 INFO - 'PAGER': '/bin/cat', 08:53:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:44 INFO - 'PWD': '/builds/slave/test', 08:53:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:44 INFO - 'SHELL': '/bin/bash', 08:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hM4gj5FICQ/Listeners', 08:53:44 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:44 INFO - 'USER': 'cltbld', 08:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:44 INFO - 'XPC_FLAGS': '0x0', 08:53:44 INFO - 'XPC_SERVICE_NAME': '0', 08:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 08:53:44 INFO - mozversion application_buildid: 20161121061709 08:53:44 INFO - mozversion application_changeset: cb5d57c8c7547bf5d6d86a04062c10fcd98e6667 08:53:44 INFO - mozversion application_display_name: Nightly 08:53:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:44 INFO - mozversion application_name: Firefox 08:53:44 INFO - mozversion application_remotingname: firefox 08:53:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:53:44 INFO - mozversion application_vendor: Mozilla 08:53:44 INFO - mozversion application_version: 53.0a1 08:53:44 INFO - mozversion platform_buildid: 20161121061709 08:53:44 INFO - mozversion platform_changeset: cb5d57c8c7547bf5d6d86a04062c10fcd98e6667 08:53:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:53:44 INFO - mozversion platform_version: 53.0a1 08:53:44 INFO - using testdate: 1479747224 08:53:44 INFO - actual date: 1479747224 08:53:44 INFO - starting webserver on 'localhost:52362' 08:53:44 INFO - SUITE-START | Running 2 tests 08:53:44 INFO - TEST-START | dromaeo_css 08:53:44 INFO - operating with platform_type : mac_ 08:53:44 INFO - Initialising browser for dromaeo_css test... 08:53:44 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpYppAvh/profile http://localhost:52362/getInfo.html) 08:53:47 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 08:53:47 INFO - PROCESS | 1958 | colorDepth:24 08:53:47 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 08:53:47 INFO - PROCESS | 1958 | __metrics 08:53:47 INFO - PROCESS | 1958 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:53:47 INFO - PROCESS | 1958 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:53:48 INFO - TEST-INFO | 1958: exit 0 08:53:48 INFO - Browser initialized. 08:53:48 INFO - Running cycle 1/1 for dromaeo_css test... 08:53:48 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpYppAvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:01 INFO - PROCESS | 1960 | RSS: Main: 236584960 08:54:01 INFO - PROCESS | 1960 | 08:54:52 INFO - PROCESS | 1960 | 1479747292568 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:57:07 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52362/tests/dromaeo/cssquery-ext.html) 08:57:08 INFO - PROCESS | 1960 | RSS: Main: 403419136 08:57:08 INFO - PROCESS | 1960 | 09:00:11 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-ext.html (next: http://localhost:52362/tests/dromaeo/cssquery-jquery.html) 09:00:12 INFO - PROCESS | 1960 | RSS: Main: 368128000 09:00:12 INFO - PROCESS | 1960 | 09:03:14 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52362/tests/dromaeo/cssquery-mootools.html) 09:03:15 INFO - PROCESS | 1960 | RSS: Main: 329297920 09:03:15 INFO - PROCESS | 1960 | 09:06:17 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52362/tests/dromaeo/cssquery-prototype.html) 09:06:18 INFO - PROCESS | 1960 | RSS: Main: 340529152 09:06:18 INFO - PROCESS | 1960 | 09:09:21 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52362/tests/dromaeo/cssquery-yui.html) 09:09:22 INFO - PROCESS | 1960 | RSS: Main: 332259328 09:09:22 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:52362/tests/dromaeo/cssquery-yui.html (next: http://localhost:52362/tests/dromaeo/cssquery-dojo.html) 09:12:25 INFO - PROCESS | 1960 | RSS: Main: 473030656 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | __start_tp_report 09:12:25 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 09:12:25 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 09:12:25 INFO - PROCESS | 1960 | |i|pagename|runs| 09:12:25 INFO - PROCESS | 1960 | |0;dojo.html;3155.2585142491516;3205.326881354915;3229.644739078701;3268.7548433867437;3280.393127271455;4609.838655647049;5473.972630136854;5530.6128571;5560.082586373253;5612.971935140324;5547.944520554794;5567.3040869891265;5672.347680016799;5674.631148975313;5677.460641239076;4986.725730084844;5012.448630650625;5044.974775126119;5068.898622027557;5085.66943148696;5069.594432445414;5183.326167598207;5185.325907632003;5185.325907632021;5192.350956130484;4999.75001249936;5152.252923326097;5157.355330583677;5178.456262092483;5234.607404444682;5047.141985862412;5096.980603879239;5106.183010718304;5110.923336149961;5115.923261151049;5010.4739002404585;5059.3169922060415;5066.518680725325;5078.162103252959;5080.983803239367;4428.778561071966;4588.518205588432;5546.944530554683;5547.5007249347755;5548.361938377098;6020.066889632114;6028.788992385289;6034.034554471264;6037.426444487811;6059.878802423927;6101.01170560261;6111.448149658388;6113.27211770912;6115.449609535119;6134.570580059398;5560.082586373243;5628.887422251573;5630.605857589971;5632.493075623213;5640.576956728261;6193.659348735863;6261.7182226799905;6262.2172228471445;6262.467690246289;6308.463780578611;5973.402659734079;5995.0223992035835;6001;6017.578769486094;6063.423974722395;5924.585279030426;5997.940020599738;5998.130271110665;6067.817965461043;6150.630962142286;6020.4280593343565;6080.847978800477;6091;6119.694015299307;6131.96934015327;6098.72555734993;6108.969455152785;6117.197338098354;6124.533510047256;6137.972022034745;4761.666683332202;4787.305840653155;4836.830710925101;4855.053264613366;4865.002674451729;4292.89267768302;4318.589733975267;4328.761918094472;4354.303311470149;4399.64802815774;5565.16522521625;5565.721713914288;5573.69344686038;5574.637648552831;5574.9721251393485;4462.776861156929;6078.483328917003;6088.939110608837;6096.359882212392;6105.755769769248;5494.066008778517;5576.581756368208;5577.972110139423;5579.358373786985;5583.078791999355;5211.166213405837;5227.555657769056;5257.395399529103;5279.260903473517;5280.207968804633;5471.699056551928;6230.7507699691505;6256.812295631138;6266.248050234001;6301.842453938688;6078.392160784063;6107.694615269308;6181.041938499539;6184.257889053342;6190.319064902767;6102.822530595962;6334.3665633436285;6341.49268058545;6343.302236754045;6362.331955144643;5848.590598658223;5855.824325270249;5864.208331875142;5943.227380440515;6061.424164704346;6109.144719739329;6129.754809807736;6133.44798968095;6135.693215339126;6137;5774.566907481872;5900.734466949083;5907;5910.468057874812;5940.6435613863305;5759.884802304015;5809.331926828469;5810.82567522975;5821.825345239649;5863.589548731547;5748.080307150836;5758.62568933018;5776.133579962871;5805.042168042226;5806.622569532967;5806.071028635398;5890.204822349099;5896.823095307148;5904.852378690395;5916.763329466773;5606.074997625509;5667.716614169192;5767.134929760569;5767.163761254511;5783.537317014713 09:12:25 INFO - PROCESS | 1960 | |1;ext.html;438.6359321762937;457.9381783459234;468.3723810094473;529.3013222546238;533.9305890234269;23476.530469390622;38740.225195496074;39719;39737.80131099348;39915.60084399155;40373.7981310093;40985.38521922166;41046.58953410465;41074.58925410745;41082.9729256768;9133.588988495534;9313.254939604816;9330.626774928995;9333.673321433751;9336.579853906556;9211.124943130391;9303.581338839735;9305.11601397866;9309.627614895397;9309.62761489543;9278;9339.299552533554;9346.766330841716;9350.859737103949;9355.953220233889;9249.815003699921;9286.117818807203;9290.396124251902;9298.767530811716;9300.953495232548;7929.881051784228;9230.953845230799;9258.305627077929;9270.675526356612;9276.350655454122;38506.80746596249;38792.418113728316;38861.22277554433;38908.416373754415;38940.61059389398;3260;3264.542963985044;3305.140663427502;3320.5185248138882;3343.5653365062385;24604.72579492236;28895.422091558263;29213.853930730424;29840.70159298401;30475.23811904698;3134.464112584817;3177.830940988822;3202.6957439043485;3239.0930539448755;3239.2387788869596;431532;449927;456244.9999999967;457701;460520;60091.699541502014;60369.396306036375;60452;60462;60477;33647;34406.13984650404;63027.054594180205;63148;63277;15204.391824326904;15717.371305147666;15765.921170394075;15777.447789327318;15781.921090394475;11987.820182697267;12093.637190884288;12101.152919295564;12103.394830258452;12116.15186936906;18487.81512184861;18513.629727405376;18517;18529.722054169197;18542.351017714584;7507.474476786681;7664.4634875559295;7676.846463070819;7709.7301594443925;7791.883121753178;748.2891253309269;917.0783362720423;933.2394098809449;1008.178334657252;1027.2552399510444;22133.66245842564;22707.88646056759;26700;26945.787439565265;28492.002779902603;986.284943416032;1011.5549158370441;1025.220832167558;1025.9281850270559;1040.4069680282166;15022.323995420233;15022.624434389229;15109.168995705122;15357.462488813062;15443.691126177413;629389;634816.651833485;638695;641203;641476;54434.45565544294;54966.450335496935;54970;55000.62498437571;55007.72496137574;1181.7990941539958;1223.0399136677665;1295.4235365262557;1317.2294207888492;1340.6581321762887;28408.43183136367;29398.706012939598;29408.41183176367;30166.547501787052;30331.241718957204;47860.521394787;48290.30983915546;48385.75807120942;48474.75762621305;48587.75706121447;462831;463114;463466;466610;467815;22909.427264318525;23460.061597535907;24976.250712478653;25711.871440642677;25751.742482574933;43850.12299754051;44065;44434.11131777411;44670.88322791956;45239.32141017953;36100.81949590235;36263.456048159824;36578.8171059143;37279.627203727614;37389.06527336838;31370.686293136776;36146;36342;36851;37561.060973475884;18504.814951850847;34602.82698586491;35015.62304711911;36368.27263454769;36734.081647959014;29054.418911621226;32322.191945201557;32516;32609;32828.835855820565;23870.16454424087;23918.88040559786;24475.388115296548;24485.755142448346;24541.14106006281 09:12:25 INFO - PROCESS | 1960 | |2;jquery.html;346.3799798360934;361.3008827917979;366.86792754608337;374.876290824028;397.61232798021933;14448.638784030405;14774;15507.844921550795;18672.439826805217;20165.09257083431;19058.61882762344;19651.31220407286;19737.605247895033;19745.5385011742;19990.90004549975;5570.415106413829;5820.767169313222;5829.766809327643;5837.8832423351505;5842.240508733858;4851.757412129397;5645.54835613152;6343.841403964915;6419.711112999903;6462.612243265419;6127.264728232618;6419.743210271584;6425.775097871576;6428.4857211423205;6433.839154021163;6320.525960552977;6375.362463753657;6385.138006369127;6400.775972840928;6402.551821372459;5312.3890752563175;5492.286002819608;5541.972290138524;5551.583631227633;5560.304961879765;23927;24626;24882.502349952898;24911;25206.61363625;1488.784126301691;2011.4870707969521;2114.3339847947846;2244.1023590563905;2323.8373313868037;7768.728094516665;9684.661036863747;9802.509874506317;10072.194224462026;10278.691639250834;1717.2444124585268;1795.8293962073583;1807.430659342303;1848.4362269507794;1868.6729822281047;99711;116954.66090678224;119857;128905.35547322391;129692.703072969;9983.951685073109;11099.5560177592;11113.944430277797;11164.385958772184;11247.718807029889;13173.27546984925;13654.795178072336;13684;14058.297085145907;14104.647383815487;7402.704526707805;7860;8159.46963447374;8279.751607451666;8285;7531.962340188374;7803.648835802403;7983.12185659577;8030.317423018992;8156.877646835303;4326.0050188456835;4328.588784065509;4355.542668019875;4408.867733967986;4543;1239.9814002789965;1541.3834466213605;1543.7221300165854;1851.5278603955906;1852.1017306606286;712.3090602115939;829.9875501867476;952.547539918547;959.467495539968;966.1304825656965;15438.992930918908;19753.802461975483;20491.282805102048;20500.974951252378;20592.382228533166;876.7413612984185;890.5102193793388;922.6032805893531;959.6842907753694;1003.8694969653898;8793.252573531321;10704.625338113285;10736.516856741466;10741.462926853626;10777.78444431107;563230;565859;570134;575386;578735;103098;128962.35518822346;129802;133654.33172834074;137791.31104344415;951.3768481644533;952.4285428742699;962.100436092256;974.541965276319;976.0532283684814;17367.47897563075;17922.91038544799;18035.278588856298;18126.27494900189;18167.909925404518;51653.70865728387;54298.45701543092;54436;54869;58746.4125358758;81240.59379703064;81906;82042;82983.5850820742;83642.16357836587;7649.885251721117;7835.529868207697;7888.723894663889;7900.604969751605;7955.801104972422;10955.287906286385;11160.665180044612;12032.939835300767;12320.691982700504;12650;10447.216458765775;10879.728006799893;10971.835422468828;11098.2786118902;11203.775924481628;9267.53662316868;9284.164425201765;9450.054994500495;10225.539850706587;10342.913994030518;10906.672799816019;11082.501287442246;11234.573455095948;11395.943020284845;11492.885071149181;6832.726690932307;7140.07179066718;7155.642217889189;7363.226861179499;8164.387670924823;9175.632974681204;10659.680209593724;10750.892491075301;10993.230473866752;11024.338539687644 09:12:25 INFO - PROCESS | 1960 | |3;mootools.html;1467.1563850785797;1490.5677353567467;1645.9588510287242;1791.5162906015385;1831.331563979148;6765.492588055897;8011.31903788178;8449.070602233749;8451.788705282372;8499.830003399944;7356.043714317145;7627.771166865003;7628.160902300757;7979.92020079799;8199.795005124875;2258.141906075693;2295.231097582312;2299.9540009199804;2301.9884900575476;2302.3898666853297;2274.8862556872173;2309.457277539777;2319.478117423583;2325.05835136769;2328.464453175771;2266.4900397410615;2271.772822717723;2294.529621427603;2294.6902168207243;2297.7242730872235;2240.1823334482797;2242.921497747579;2258.0741895822634;2261.0503588492707;2265.909363625461;2275.2377953385635;2295.690081838947;2301.42464383904;2301.9309420717404;2305.8155347572156;8143.633536490872;8226.218509241613;8248.092709801916;8279.58602069894;8314.127016663224;4987.950120498785;5141.640085194038;5143.434222235551;5157.020166168453;5167.379914410257;3079.5842561254167;3113;3164.810111393324;3494.4234201356744;3501.1422201560526;891.8216356728681;1044.2272718188485;1078.8219943709278;1090.8145615245428;1093.3002878157986;10368.429736364496;10635.255532112755;10639.840402393971;10725.195610329178;10825.188110891635;4216;4297.785110744513;4399.032212913154;4418.977905110518;4435.312526558324;8584.184502472255;8584.270337021424;8604.526751028754;8609.311255099577;8609.655613775503;5048.823291184791;5062.215356619729;5063.49365063498;5064.746762661852;5073.720945347967;3575.713942884563;4050.696197785119;4243.405923170759;4380.364847097153;4742.905141897212;2973.3755911258877;3510.420780571228;3608.963910360915;3644.9635503645154;3646.7447278690765;963.9132478077007;1127.3405058040973;1135.3301552084145;1146.4726225936163;1149.40231079838;858.6779957515931;874.2525141004477;885.2342723544087;909.7998440343114;925.5696101312788;5359.516314395674;5601.80393686219;5603.159526071122;5665.405132461032;5800.709964501758;436.85802114312975;442.6834813108643;447.5815112869478;449.341714388416;930.3952430919957;3680.576733675608;3868.2650296443585;3943.191645712622;4005.8798236052967;4010.598940105966;10048.899511004942;10248.026437488426;10270.743231419274;10276.691699249035;10287.971202879802;10105.9494702526;10214.897851021544;10230.846537301946;10237.692869213935;10243.59025638981;7613.096725818546;7853.685852565834;7858.960705196323;7862.371010319161;7866.9213307866185;5359.946400536101;5390.4879036491475;5415.756290966995;5633.408492108433;5807.245058142415;9089.954550227207;9362.578683959102;9375.390599611004;9453.763655908657;9476.194523465307;8984.86522702147;9449.149576538144;9545.904540954501;9603.37578057424;9618.038196180327;7018.368346848808;7079.256678048937;7134.785956421108;7153.606551639502;7203.459740519377;7765.339946104645;7841.647125879464;7846.686132554634;7859;7866.803329916798;6818.386345228953;6955.408790252885;6999.160100787734;7019.859602807813;7081.539699919489;6766.255711871591;6910.274421185904;6966.164060312795;6978.930210697828;6999.580025198505;6252.937470625236;6366.808995730135;6489.837754055998;6508.902366464602;6560.343965603593;4750.501197374226;4759.690620109682;4793.544613261734;4809.519048095302;4905.386826646669;4695.506971767915;4792.664513484162;4887.780049897692;4906.55840974314;5078.695278283315 09:12:25 INFO - PROCESS | 1960 | |4;prototype.html;255.48137281318918;258.37473314578716;297.1471875716693;309.1359649778868;312.9624445066592;4216.47294088239;4537.773111344428;4944.678595891264;5084.822031228908;5121.923171152431;4534.27451607742;4969.304297398367;4985.40467050544;4990.950090499094;4998.350214472122;3449.4135996880464;3704.666580007799;3893.532776066876;3897.1036661567855;3905.8047097645003;3273.216097227005;3835.2511235122693;3944.3886197639413;4003.4195041718935;4013.779242141681;3198.344339410415;3455.533502977091;3472.988698053752;3975.423563583279;3983.8406463741417;3730.850765969358;3760.511133552648;3927.2145570885937;3971.8808435746973;3994.700397470187;3267.640559538449;3370.9494357584654;3381.8140002299865;3384.323135372935;3384.509246159293;3934.9409758853353;4227.133437645275;4871.0014447038275;5034.974825125888;5059.468755780626;4151.4395556599775;4473.776311184428;4494.640428765691;4496.79764410599;4503.256962601167;4201.285781417167;4515.458145022585;4680.7191568506;5039.748012599355;5380.354357477088;2764.6129541864157;3099.11675172577;3680.705768337323;3695.316366472211;3734.6825519830845;4593.471750748673;5082.08522465956;5122.8463146105305;5525.4474552544825;5746.88506229873;3485.3029394121277;3684.705223582107;3692.7045836333027;3705.814709264526;3753.5871054184017;3816.637419445148;3858;3866.33747488577;3867.6325749053794;3870.245302166051;4421.845235416809;4429.5382523767075;4436.467623885154;4441.533638967927;4467.821287148543;5301.867453313698;5424.701641409761;5454.563634909197;5467.641711123121;5497.972510137503;1068.3429690740295;1098.2038022433671;1105.7069876482738;1209.6029086405217;1235.1971218707731;806.2944923192207;826.9379796515285;828.9502629842228;830.3481766813144;837.8198687282263;3798.8346642414112;4380.956190438055;4469.508354081048;4638.796571628517;4758.714477131383;4595.563421474954;4799.0401919616215;5127.820601261731;5140.974295128501;5163.328767260232;4057.9797101014306;4381.605655490957;4683.976580117078;4691.390119284471;4713.528647135327;2326.7789559991775;2358.6462030695534;2705.553583658674;2712.823666461674;2742.9725702743117;4134.64855487281;4677.614416647466;4712;5074.898502029939;5335.279737235423;4648.256903661127;5010.667905842573;5275.892062666806;5279.41926388097;5291.497307755757;5143.71709555978;5215.617861266767;5356.7321633918145;5408;5478.698671573102;4607.562281583244;4758.428988521399;5229.842275390997;5264.552513036435;5310.99091172676;3998.540167880731;4123.49492435253;4820.988635460614;5058.494150584912;5070.949290507047;4504.819807207675;5263.973680131575;5278.81524146653;5287.312649355559;5333.453253586322;3076.5846610707267;3479.251960828333;3496.632853550442;3580.480830279647;3659.4144936809985;4886.240953256895;5377.166539186433;5554.472325129106;5559.469032738467;5577.247071645276;4903.926441103315;5378.2739330189925;5388.218708287198;5413.53984911287;5446.346438427414;5015.974920125522;5133.79464821403;5296.814611488579;5363.731813409236;5369.758360873692;4636.884077898079;5257.974694934451;5258.842234732964;5286.392064912584;5460.358695109126;4849.563539281482;5356.330458692663;5376.462353764592;5405.486478784509;5406.864018869125;4423.977880110579;4486.590191454453;4979.203327467588;5263.236800679674;5276.129438642581 09:12:25 INFO - PROCESS | 1960 | |5;yui.html;669.9028640847077;710.4884483172116;726.7529040126352;757.6098309370675;781.7811012916385;13938.930305348471;14401.135931844083;14807.407703691839;15084.32120554575;15095.547133585997;13335.266560339178;13633.386497607607;13656;13802.30988450576;13815.171089734624;787.5314188058096;804.2038382001834;805.5327909812295;806.2501873257868;806.3468590441731;642.6144313411938;663.6714826161057;665.9800205993828;668.7091115364808;804.3082948664173;689.9172099348085;692.4944790303082;814.1939479914901;844.932405407569;849.5285116760195;839.886615306938;840.0423517190408;840.5713086325957;840.8612578924501;844.8817165596852;622.9657368844712;624.8687775567137;624.9750009999594;625.3808729357949;626.4894111299277;11620.6513804586;12157.148999570034;13464.259465729381;13836.792448113287;14167;13567.05030647855;13883;13999;14049;14092.506762263374;11323.490442930088;11357.488912998935;11363.602273920456;11439.828402573969;11761.588344407905;3654.0499470137956;3661.552212125737;3670.944935825938;3701.1117331840433;3810.733248672594;81622.59188704078;82259.354812904;82600.17399826045;85753.57123214407;87117;10546.630867919586;10554.947225263824;10581.153507719364;10599.735006624742;10791.190660700478;16650.751193660522;20429.591408171753;20434;20434.897825511074;20435.897820511098;6127.601705889103;7631;7797.154038775806;7867.6066196689935;7879.645415956295;4177.310743727312;4356.3683265926265;4445.266531022345;4474.619657329164;4487.932681009787;3303.3888730584918;3414.5902491701154;3429.1427143214196;3432.2449061206494;3435.0210190095704;612.8222815383579;619.4022768028874;631.7694041674847;633.8922383194868;642.7043559962376;562.7311747136898;608.6317777744489;619.8853212155766;645.9709313080923;675.0751470485467;8399.790005249795;8670.046294907555;8719.520426376483;8986.843157642119;9380.108889655472;604.9866473656607;623.4108767214939;630.3948209718629;631.6904716688789;635.8303855281418;3976.2643910876004;4260.765657888784;4266.360045993064;4291.079905259268;4502;89937;92237;93585.5320723392;96698;100374;78430.6078469604;82068;83699;85339;85668;75511.62244188743;76734;78058;78996.99999999885;79312.20687793163;6880.449564034965;8158.714444994397;8245.464044837066;8377.287930525974;8589.914100859161;46496;49156;49318.26022609592;49631.255531167786;49965.75017124891;69270;69503;70852;72570.91143632955;72571.92850893638;10730.356178629307;10864.402457864893;10957.561697532328;10992.560297588007;11382.886171138514;12324.938375308066;13697.383617737027;14080.788788168391;14471.27643617836;14818;12565.93717031409;12604;13016.088873779123;13256.276684031014;13565.59303220905;13071.477140914258;13240.139390939557;13442.126261792951;13662.18026918388;13721.931390342985;12529.850116421776;12868.485260589472;13276;13467.865321347053;13583.52457663977;10681.626143084955;11214.15893807984;11269.943650281695;11347.829782553434;11362.886371136183;10020.34867733595;10421.9478902605;11206.719832004264;11231.943840280746;11471.483783229607 09:12:25 INFO - PROCESS | 1960 | __end_tp_report 09:12:25 INFO - PROCESS | 1960 | __start_cc_report 09:12:25 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,1525 09:12:25 INFO - PROCESS | 1960 | __end_cc_report 09:12:25 INFO - PROCESS | 1960 | __startTimestamp1479748345865__endTimestamp 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | ------- Summary: start ------- 09:12:25 INFO - PROCESS | 1960 | Number of tests: 6 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | [#0] dojo.html Cycles:165 Average:5578.90 Median:5767.13 stddev:651.23 (11.3%) stddev-sans-first:624.86 09:12:25 INFO - PROCESS | 1960 | Values: 3155.3 3205.3 3229.6 3268.8 3280.4 4609.8 5474.0 5530.6 5560.1 5613.0 5547.9 5567.3 5672.3 5674.6 5677.5 4986.7 5012.4 5045.0 5068.9 5085.7 5069.6 5183.3 5185.3 5185.3 5192.4 4999.8 5152.3 5157.4 5178.5 5234.6 5047.1 5097.0 5106.2 5110.9 5115.9 5010.5 5059.3 5066.5 5078.2 5081.0 4428.8 4588.5 5546.9 5547.5 5548.4 6020.1 6028.8 6034.0 6037.4 6059.9 6101.0 6111.4 6113.3 6115.4 6134.6 5560.1 5628.9 5630.6 5632.5 5640.6 6193.7 6261.7 6262.2 6262.5 6308.5 5973.4 5995.0 6001.0 6017.6 6063.4 5924.6 5997.9 5998.1 6067.8 6150.6 6020.4 6080.8 6091.0 6119.7 6132.0 6098.7 6109.0 6117.2 6124.5 6138.0 4761.7 4787.3 4836.8 4855.1 4865.0 4292.9 4318.6 4328.8 4354.3 4399.6 5565.2 5565.7 5573.7 5574.6 5575.0 4462.8 6078.5 6088.9 6096.4 6105.8 5494.1 5576.6 5578.0 5579.4 5583.1 5211.2 5227.6 5257.4 5279.3 5280.2 5471.7 6230.8 6256.8 6266.2 6301.8 6078.4 6107.7 6181.0 6184.3 6190.3 6102.8 6334.4 6341.5 6343.3 6362.3 5848.6 5855.8 5864.2 5943.2 6061.4 6109.1 6129.8 6133.4 6135.7 6137.0 5774.6 5900.7 5907.0 5910.5 5940.6 5759.9 5809.3 5810.8 5821.8 5863.6 5748.1 5758.6 5776.1 5805.0 5806.6 5806.1 5890.2 5896.8 5904.9 5916.8 5606.1 5667.7 5767.1 5767.2 5783.5 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | [#1] ext.html Cycles:180 Average:64526.95 Median:38766.32 stddev:140215.41 (361.7%) stddev-sans-first:140526.19 09:12:25 INFO - PROCESS | 1960 | Values: 438.6 457.9 468.4 529.3 533.9 23476.5 38740.2 39719.0 39737.8 39915.6 40373.8 40985.4 41046.6 41074.6 41083.0 9133.6 9313.3 9330.6 9333.7 9336.6 9211.1 9303.6 9305.1 9309.6 9309.6 9278.0 9339.3 9346.8 9350.9 9356.0 9249.8 9286.1 9290.4 9298.8 9301.0 7929.9 9231.0 9258.3 9270.7 9276.4 38506.8 38792.4 38861.2 38908.4 38940.6 3260.0 3264.5 3305.1 3320.5 3343.6 24604.7 28895.4 29213.9 29840.7 30475.2 3134.5 3177.8 3202.7 3239.1 3239.2 431532.0 449927.0 456245.0 457701.0 460520.0 60091.7 60369.4 60452.0 60462.0 60477.0 33647.0 34406.1 63027.1 63148.0 63277.0 15204.4 15717.4 15765.9 15777.4 15781.9 11987.8 12093.6 12101.2 12103.4 12116.2 18487.8 18513.6 18517.0 18529.7 18542.4 7507.5 7664.5 7676.8 7709.7 7791.9 748.3 917.1 933.2 1008.2 1027.3 22133.7 22707.9 26700.0 26945.8 28492.0 986.3 1011.6 1025.2 1025.9 1040.4 15022.3 15022.6 15109.2 15357.5 15443.7 629389.0 634816.7 638695.0 641203.0 641476.0 54434.5 54966.5 54970.0 55000.6 55007.7 1181.8 1223.0 1295.4 1317.2 1340.7 28408.4 29398.7 29408.4 30166.5 30331.2 47860.5 48290.3 48385.8 48474.8 48587.8 462831.0 463114.0 463466.0 466610.0 467815.0 22909.4 23460.1 24976.3 25711.9 25751.7 43850.1 44065.0 44434.1 44670.9 45239.3 36100.8 36263.5 36578.8 37279.6 37389.1 31370.7 36146.0 36342.0 36851.0 37561.1 18504.8 34602.8 35015.6 36368.3 36734.1 29054.4 32322.2 32516.0 32609.0 32828.8 23870.2 23918.9 24475.4 24485.8 24541.1 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | [#2] jquery.html Cycles:180 Average:34017.08 Median:2361.81 stddev:95695.32 (4051.8%) stddev-sans-first:95930.37 09:12:25 INFO - PROCESS | 1960 | Values: 346.4 361.3 366.9 374.9 397.6 14448.6 14774.0 15507.8 18672.4 20165.1 19058.6 19651.3 19737.6 19745.5 19990.9 5570.4 5820.8 5829.8 5837.9 5842.2 4851.8 5645.5 6343.8 6419.7 6462.6 6127.3 6419.7 6425.8 6428.5 6433.8 6320.5 6375.4 6385.1 6400.8 6402.6 5312.4 5492.3 5542.0 5551.6 5560.3 23927.0 24626.0 24882.5 24911.0 25206.6 1488.8 2011.5 2114.3 2244.1 2323.8 7768.7 9684.7 9802.5 10072.2 10278.7 1717.2 1795.8 1807.4 1848.4 1868.7 99711.0 116954.7 119857.0 128905.4 129692.7 9984.0 11099.6 11113.9 11164.4 11247.7 13173.3 13654.8 13684.0 14058.3 14104.6 7402.7 7860.0 8159.5 8279.8 8285.0 7532.0 7803.6 7983.1 8030.3 8156.9 4326.0 4328.6 4355.5 4408.9 4543.0 1240.0 1541.4 1543.7 1851.5 1852.1 712.3 830.0 952.5 959.5 966.1 15439.0 19753.8 20491.3 20501.0 20592.4 876.7 890.5 922.6 959.7 1003.9 8793.3 10704.6 10736.5 10741.5 10777.8 563230.0 565859.0 570134.0 575386.0 578735.0 103098.0 128962.4 129802.0 133654.3 137791.3 951.4 952.4 962.1 974.5 976.1 17367.5 17922.9 18035.3 18126.3 18167.9 51653.7 54298.5 54436.0 54869.0 58746.4 81240.6 81906.0 82042.0 82983.6 83642.2 7649.9 7835.5 7888.7 7900.6 7955.8 10955.3 11160.7 12032.9 12320.7 12650.0 10447.2 10879.7 10971.8 11098.3 11203.8 9267.5 9284.2 9450.1 10225.5 10342.9 10906.7 11082.5 11234.6 11395.9 11492.9 6832.7 7140.1 7155.6 7363.2 8164.4 9175.6 10659.7 10750.9 10993.2 11024.3 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | [#3] mootools.html Cycles:180 Average:5345.67 Median:4947.25 stddev:2970.99 (60.1%) stddev-sans-first:2965.03 09:12:25 INFO - PROCESS | 1960 | Values: 1467.2 1490.6 1646.0 1791.5 1831.3 6765.5 8011.3 8449.1 8451.8 8499.8 7356.0 7627.8 7628.2 7979.9 8199.8 2258.1 2295.2 2300.0 2302.0 2302.4 2274.9 2309.5 2319.5 2325.1 2328.5 2266.5 2271.8 2294.5 2294.7 2297.7 2240.2 2242.9 2258.1 2261.1 2265.9 2275.2 2295.7 2301.4 2301.9 2305.8 8143.6 8226.2 8248.1 8279.6 8314.1 4988.0 5141.6 5143.4 5157.0 5167.4 3079.6 3113.0 3164.8 3494.4 3501.1 891.8 1044.2 1078.8 1090.8 1093.3 10368.4 10635.3 10639.8 10725.2 10825.2 4216.0 4297.8 4399.0 4419.0 4435.3 8584.2 8584.3 8604.5 8609.3 8609.7 5048.8 5062.2 5063.5 5064.7 5073.7 3575.7 4050.7 4243.4 4380.4 4742.9 2973.4 3510.4 3609.0 3645.0 3646.7 963.9 1127.3 1135.3 1146.5 1149.4 858.7 874.3 885.2 909.8 925.6 5359.5 5601.8 5603.2 5665.4 5800.7 436.9 442.7 447.6 449.3 930.4 3680.6 3868.3 3943.2 4005.9 4010.6 10048.9 10248.0 10270.7 10276.7 10288.0 10105.9 10214.9 10230.8 10237.7 10243.6 7613.1 7853.7 7859.0 7862.4 7866.9 5359.9 5390.5 5415.8 5633.4 5807.2 9090.0 9362.6 9375.4 9453.8 9476.2 8984.9 9449.1 9545.9 9603.4 9618.0 7018.4 7079.3 7134.8 7153.6 7203.5 7765.3 7841.6 7846.7 7859.0 7866.8 6818.4 6955.4 6999.2 7019.9 7081.5 6766.3 6910.3 6966.2 6978.9 6999.6 6252.9 6366.8 6489.8 6508.9 6560.3 4750.5 4759.7 4793.5 4809.5 4905.4 4695.5 4792.7 4887.8 4906.6 5078.7 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | [#4] prototype.html Cycles:180 Average:4204.37 Median:4622.22 stddev:1287.89 (27.9%) stddev-sans-first:1256.94 09:12:25 INFO - PROCESS | 1960 | Values: 255.5 258.4 297.1 309.1 313.0 4216.5 4537.8 4944.7 5084.8 5121.9 4534.3 4969.3 4985.4 4991.0 4998.4 3449.4 3704.7 3893.5 3897.1 3905.8 3273.2 3835.3 3944.4 4003.4 4013.8 3198.3 3455.5 3473.0 3975.4 3983.8 3730.9 3760.5 3927.2 3971.9 3994.7 3267.6 3370.9 3381.8 3384.3 3384.5 3934.9 4227.1 4871.0 5035.0 5059.5 4151.4 4473.8 4494.6 4496.8 4503.3 4201.3 4515.5 4680.7 5039.7 5380.4 2764.6 3099.1 3680.7 3695.3 3734.7 4593.5 5082.1 5122.8 5525.4 5746.9 3485.3 3684.7 3692.7 3705.8 3753.6 3816.6 3858.0 3866.3 3867.6 3870.2 4421.8 4429.5 4436.5 4441.5 4467.8 5301.9 5424.7 5454.6 5467.6 5498.0 1068.3 1098.2 1105.7 1209.6 1235.2 806.3 826.9 829.0 830.3 837.8 3798.8 4381.0 4469.5 4638.8 4758.7 4595.6 4799.0 5127.8 5141.0 5163.3 4058.0 4381.6 4684.0 4691.4 4713.5 2326.8 2358.6 2705.6 2712.8 2743.0 4134.6 4677.6 4712.0 5074.9 5335.3 4648.3 5010.7 5275.9 5279.4 5291.5 5143.7 5215.6 5356.7 5408.0 5478.7 4607.6 4758.4 5229.8 5264.6 5311.0 3998.5 4123.5 4821.0 5058.5 5070.9 4504.8 5264.0 5278.8 5287.3 5333.5 3076.6 3479.3 3496.6 3580.5 3659.4 4886.2 5377.2 5554.5 5559.5 5577.2 4903.9 5378.3 5388.2 5413.5 5446.3 5016.0 5133.8 5296.8 5363.7 5369.8 4636.9 5258.0 5258.8 5286.4 5460.4 4849.6 5356.3 5376.5 5405.5 5406.9 4424.0 4486.6 4979.2 5263.2 5276.1 09:12:25 INFO - PROCESS | 1960 | 09:12:25 INFO - PROCESS | 1960 | [#5] yui.html Cycles:180 Average:19139.07 Median:25499.00 stddev:26913.16 (105.5%) stddev-sans-first:26952.92 09:12:25 INFO - PROCESS | 1960 | Values: 669.9 710.5 726.8 757.6 781.8 13938.9 14401.1 14807.4 15084.3 15095.5 13335.3 13633.4 13656.0 13802.3 13815.2 787.5 804.2 805.5 806.3 806.3 642.6 663.7 666.0 668.7 804.3 689.9 692.5 814.2 844.9 849.5 839.9 840.0 840.6 840.9 844.9 623.0 624.9 625.0 625.4 626.5 11620.7 12157.1 13464.3 13836.8 14167.0 13567.1 13883.0 13999.0 14049.0 14092.5 11323.5 11357.5 11363.6 11439.8 11761.6 3654.0 3661.6 3670.9 3701.1 3810.7 81622.6 82259.4 82600.2 85753.6 87117.0 10546.6 10554.9 10581.2 10599.7 10791.2 16650.8 20429.6 20434.0 20434.9 20435.9 6127.6 7631.0 7797.2 7867.6 7879.6 4177.3 4356.4 4445.3 4474.6 4487.9 3303.4 3414.6 3429.1 3432.2 3435.0 612.8 619.4 631.8 633.9 642.7 562.7 608.6 619.9 646.0 675.1 8399.8 8670.0 8719.5 8986.8 9380.1 605.0 623.4 630.4 631.7 635.8 3976.3 4260.8 4266.4 4291.1 4502.0 89937.0 92237.0 93585.5 96698.0 100374.0 78430.6 82068.0 83699.0 85339.0 85668.0 75511.6 76734.0 78058.0 78997.0 79312.2 6880.4 8158.7 8245.5 8377.3 8589.9 46496.0 49156.0 49318.3 49631.3 49965.8 69270.0 69503.0 70852.0 72570.9 72571.9 10730.4 10864.4 10957.6 10992.6 11382.9 12324.9 13697.4 14080.8 14471.3 14818.0 12565.9 12604.0 13016.1 13256.3 13565.6 13071.5 13240.1 13442.1 13662.2 13721.9 12529.9 12868.5 13276.0 13467.9 13583.5 10681.6 11214.2 11269.9 11347.8 11362.9 10020.3 10421.9 11206.7 11231.9 11471.5 09:12:25 INFO - PROCESS | 1960 | -------- Summary: end -------- 09:12:25 INFO - PROCESS | 1960 | 09:12:26 INFO - TEST-INFO | 1960: exit 0 09:12:26 INFO - TEST-OK | dromaeo_css | took 1121570ms 09:12:26 INFO - TEST-START | kraken 09:12:26 INFO - operating with platform_type : mac_ 09:12:26 INFO - Initialising browser for kraken test... 09:12:26 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpjqJ0kY/profile http://localhost:52362/getInfo.html) 09:12:29 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 09:12:29 INFO - PROCESS | 1964 | colorDepth:24 09:12:29 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 09:12:29 INFO - PROCESS | 1964 | __metrics 09:12:29 INFO - PROCESS | 1964 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:12:29 INFO - PROCESS | 1964 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:30 INFO - TEST-INFO | 1964: exit 0 09:12:30 INFO - Browser initialized. 09:12:30 INFO - Running cycle 1/1 for kraken test... 09:12:30 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpjqJ0kY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:42 INFO - PROCESS | 1965 | RSS: Main: 237727744 09:12:42 INFO - PROCESS | 1965 | 09:12:45 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-beat-detection) 09:12:46 INFO - PROCESS | 1965 | RSS: Main: 296030208 09:12:46 INFO - PROCESS | 1965 | 09:12:49 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-dft) 09:12:50 INFO - PROCESS | 1965 | RSS: Main: 299094016 09:12:50 INFO - PROCESS | 1965 | 09:12:53 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-fft) 09:12:54 INFO - PROCESS | 1965 | RSS: Main: 388292608 09:12:54 INFO - PROCESS | 1965 | 09:12:56 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52362/tests/kraken/driver.html?testName=audio-oscillator) 09:12:56 INFO - PROCESS | 1965 | RSS: Main: 288768000 09:12:56 INFO - PROCESS | 1965 | 09:12:58 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:12:59 INFO - PROCESS | 1965 | RSS: Main: 293203968 09:12:59 INFO - PROCESS | 1965 | 09:13:02 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52362/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:03 INFO - PROCESS | 1965 | RSS: Main: 336912384 09:13:03 INFO - PROCESS | 1965 | 09:13:05 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52362/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:06 INFO - PROCESS | 1965 | RSS: Main: 336338944 09:13:06 INFO - PROCESS | 1965 | 09:13:09 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52362/tests/kraken/driver.html?testName=json-parse-financial) 09:13:09 INFO - PROCESS | 1965 | RSS: Main: 335925248 09:13:09 INFO - PROCESS | 1965 | 09:13:11 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:12 INFO - PROCESS | 1965 | RSS: Main: 309088256 09:13:12 INFO - PROCESS | 1965 | 09:13:14 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:14 INFO - PROCESS | 1965 | RSS: Main: 311373824 09:13:14 INFO - PROCESS | 1965 | 09:13:16 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:17 INFO - PROCESS | 1965 | RSS: Main: 313303040 09:13:17 INFO - PROCESS | 1965 | 09:13:20 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:21 INFO - PROCESS | 1965 | RSS: Main: 329854976 09:13:21 INFO - PROCESS | 1965 | 09:13:24 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:25 INFO - PROCESS | 1965 | RSS: Main: 324198400 09:13:25 INFO - PROCESS | 1965 | 09:13:26 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52362/tests/kraken/driver.html?testName=ai-astar) 09:13:27 INFO - PROCESS | 1965 | RSS: Main: 367071232 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | __start_tp_report 09:13:27 INFO - PROCESS | 1965 | _x_x_mozilla_page_load 09:13:27 INFO - PROCESS | 1965 | _x_x_mozilla_page_load_details 09:13:27 INFO - PROCESS | 1965 | |i|pagename|runs| 09:13:27 INFO - PROCESS | 1965 | |0;ai-astar;100;155;163;113;112;112;112;113;112;112 09:13:27 INFO - PROCESS | 1965 | |1;audio-beat-detection;150;113;114;152;112;114;110;129;163;139 09:13:27 INFO - PROCESS | 1965 | |2;audio-dft;186;185;183;186;181;184;183;183;185;182 09:13:27 INFO - PROCESS | 1965 | |3;audio-fft;81;59;59;89;60;59;59;59;83;58 09:13:27 INFO - PROCESS | 1965 | |4;audio-oscillator;92;70;92;70;67;69;91;69;69;93 09:13:27 INFO - PROCESS | 1965 | |5;imaging-gaussian-blur;89;86;90;86;89;85;89;93;135;107 09:13:27 INFO - PROCESS | 1965 | |6;imaging-darkroom;97;99;98;99;98;97;98;98;97;98 09:13:27 INFO - PROCESS | 1965 | |7;imaging-desaturate;85;88;86;86;85;87;88;86;85;86 09:13:27 INFO - PROCESS | 1965 | |8;json-parse-financial;56;55;53;54;56;54;55;54;54;56 09:13:27 INFO - PROCESS | 1965 | |9;json-stringify-tinderbox;67;77;76;77;74;70;71;71;71;71 09:13:27 INFO - PROCESS | 1965 | |10;stanford-crypto-aes;89;83;88;88;88;88;86;88;88;88 09:13:27 INFO - PROCESS | 1965 | |11;stanford-crypto-ccm;157;156;158;150;149;141;155;156;212;162 09:13:27 INFO - PROCESS | 1965 | |12;stanford-crypto-pbkdf2;177;160;234;230;195;174;175;177;173;173 09:13:27 INFO - PROCESS | 1965 | |13;stanford-crypto-sha256-iterative;68;68;67;68;68;67;68;67;68;68 09:13:27 INFO - PROCESS | 1965 | __end_tp_report 09:13:27 INFO - PROCESS | 1965 | __start_cc_report 09:13:27 INFO - PROCESS | 1965 | _x_x_mozilla_cycle_collect,1972 09:13:27 INFO - PROCESS | 1965 | __end_cc_report 09:13:27 INFO - PROCESS | 1965 | __startTimestamp1479748407051__endTimestamp 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | ------- Summary: start ------- 09:13:27 INFO - PROCESS | 1965 | Number of tests: 14 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#0] ai-astar Cycles:10 Average:120.40 Median:112.50 stddev:20.79 (18.5%) stddev-sans-first:20.70 09:13:27 INFO - PROCESS | 1965 | Values: 100.0 155.0 163.0 113.0 112.0 112.0 112.0 113.0 112.0 112.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:134.00 stddev:19.94 (14.9%) stddev-sans-first:19.74 09:13:27 INFO - PROCESS | 1965 | Values: 150.0 113.0 114.0 152.0 112.0 114.0 110.0 129.0 163.0 139.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.69 (0.9%) stddev-sans-first:1.59 09:13:27 INFO - PROCESS | 1965 | Values: 186.0 185.0 183.0 186.0 181.0 184.0 183.0 183.0 185.0 182.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#3] audio-fft Cycles:10 Average:66.60 Median:59.50 stddev:12.40 (20.8%) stddev-sans-first:12.01 09:13:27 INFO - PROCESS | 1965 | Values: 81.0 59.0 59.0 89.0 60.0 59.0 59.0 59.0 83.0 58.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:80.50 stddev:11.91 (14.8%) stddev-sans-first:11.54 09:13:27 INFO - PROCESS | 1965 | Values: 92.0 70.0 92.0 70.0 67.0 69.0 91.0 69.0 69.0 93.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:89.00 stddev:15.43 (17.3%) stddev-sans-first:16.22 09:13:27 INFO - PROCESS | 1965 | Values: 89.0 86.0 90.0 86.0 89.0 85.0 89.0 93.0 135.0 107.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:98.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 09:13:27 INFO - PROCESS | 1965 | Values: 97.0 99.0 98.0 99.0 98.0 97.0 98.0 98.0 97.0 98.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.12 09:13:27 INFO - PROCESS | 1965 | Values: 85.0 88.0 86.0 86.0 85.0 87.0 88.0 86.0 85.0 86.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.01 09:13:27 INFO - PROCESS | 1965 | Values: 56.0 55.0 53.0 54.0 56.0 54.0 55.0 54.0 54.0 56.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.50 stddev:3.34 (4.6%) stddev-sans-first:2.89 09:13:27 INFO - PROCESS | 1965 | Values: 67.0 77.0 76.0 77.0 74.0 70.0 71.0 71.0 71.0 71.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:88.00 stddev:1.71 (1.9%) stddev-sans-first:1.72 09:13:27 INFO - PROCESS | 1965 | Values: 89.0 83.0 88.0 88.0 88.0 88.0 86.0 88.0 88.0 88.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#11] stanford-crypto-ccm Cycles:10 Average:159.60 Median:156.50 stddev:19.32 (12.3%) stddev-sans-first:20.47 09:13:27 INFO - PROCESS | 1965 | Values: 157.0 156.0 158.0 150.0 149.0 141.0 155.0 156.0 212.0 162.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.80 Median:177.00 stddev:25.29 (14.3%) stddev-sans-first:26.57 09:13:27 INFO - PROCESS | 1965 | Values: 177.0 160.0 234.0 230.0 195.0 174.0 175.0 177.0 173.0 173.0 09:13:27 INFO - PROCESS | 1965 | 09:13:27 INFO - PROCESS | 1965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 09:13:27 INFO - PROCESS | 1965 | Values: 68.0 68.0 67.0 68.0 68.0 67.0 68.0 67.0 68.0 68.0 09:13:27 INFO - PROCESS | 1965 | -------- Summary: end -------- 09:13:27 INFO - PROCESS | 1965 | 09:13:28 INFO - TEST-INFO | 1965: exit 0 09:13:28 INFO - TEST-OK | kraken | took 61605ms 09:13:28 INFO - SUITE-END | took 1183s 09:13:28 INFO - Completed test suite (00:19:43) 09:13:28 INFO - javascript benchmark 09:13:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.2585142491516, 3205.326881354915, 3229.644739078701, 3268.7548433867437, 3280.393127271455, 4609.838655647049, 5473.972630136854, 5530.6128571, 5560.082586373253, 5612.971935140324, 5547.944520554794, 5567.3040869891265, 5672.347680016799, 5674.631148975313, 5677.460641239076, 4986.725730084844, 5012.448630650625, 5044.974775126119, 5068.898622027557, 5085.66943148696, 5069.594432445414, 5183.326167598207, 5185.325907632003, 5185.325907632021, 5192.350956130484, 4999.75001249936, 5152.252923326097, 5157.355330583677, 5178.456262092483, 5234.607404444682, 5047.141985862412, 5096.980603879239, 5106.183010718304, 5110.923336149961, 5115.923261151049, 5010.4739002404585, 5059.3169922060415, 5066.518680725325, 5078.162103252959, 5080.983803239367, 4428.778561071966, 4588.518205588432, 5546.944530554683, 5547.5007249347755, 5548.361938377098, 6020.066889632114, 6028.788992385289, 6034.034554471264, 6037.426444487811, 6059.878802423927, 6101.01170560261, 6111.448149658388, 6113.27211770912, 6115.449609535119, 6134.570580059398, 5560.082586373243, 5628.887422251573, 5630.605857589971, 5632.493075623213, 5640.576956728261, 6193.659348735863, 6261.7182226799905, 6262.2172228471445, 6262.467690246289, 6308.463780578611, 5973.402659734079, 5995.0223992035835, 6001.0, 6017.578769486094, 6063.423974722395, 5924.585279030426, 5997.940020599738, 5998.130271110665, 6067.817965461043, 6150.630962142286, 6020.4280593343565, 6080.847978800477, 6091.0, 6119.694015299307, 6131.96934015327, 6098.72555734993, 6108.969455152785, 6117.197338098354, 6124.533510047256, 6137.972022034745, 4761.666683332202, 4787.305840653155, 4836.830710925101, 4855.053264613366, 4865.002674451729, 4292.89267768302, 4318.589733975267, 4328.761918094472, 4354.303311470149, 4399.64802815774, 5565.16522521625, 5565.721713914288, 5573.69344686038, 5574.637648552831, 5574.9721251393485, 4462.776861156929, 6078.483328917003, 6088.939110608837, 6096.359882212392, 6105.755769769248, 5494.066008778517, 5576.581756368208, 5577.972110139423, 5579.358373786985, 5583.078791999355, 5211.166213405837, 5227.555657769056, 5257.395399529103, 5279.260903473517, 5280.207968804633, 5471.699056551928, 6230.7507699691505, 6256.812295631138, 6266.248050234001, 6301.842453938688, 6078.392160784063, 6107.694615269308, 6181.041938499539, 6184.257889053342, 6190.319064902767, 6102.822530595962, 6334.3665633436285, 6341.49268058545, 6343.302236754045, 6362.331955144643, 5848.590598658223, 5855.824325270249, 5864.208331875142, 5943.227380440515, 6061.424164704346, 6109.144719739329, 6129.754809807736, 6133.44798968095, 6135.693215339126, 6137.0, 5774.566907481872, 5900.734466949083, 5907.0, 5910.468057874812, 5940.6435613863305, 5759.884802304015, 5809.331926828469, 5810.82567522975, 5821.825345239649, 5863.589548731547, 5748.080307150836, 5758.62568933018, 5776.133579962871, 5805.042168042226, 5806.622569532967, 5806.071028635398, 5890.204822349099, 5896.823095307148, 5904.852378690395, 5916.763329466773, 5606.074997625509, 5667.716614169192, 5767.134929760569, 5767.163761254511, 5783.537317014713], "value": 5537.195658683547, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.6359321762937, 457.9381783459234, 468.3723810094473, 529.3013222546238, 533.9305890234269, 23476.530469390622, 38740.225195496074, 39719.0, 39737.80131099348, 39915.60084399155, 40373.7981310093, 40985.38521922166, 41046.58953410465, 41074.58925410745, 41082.9729256768, 9133.588988495534, 9313.254939604816, 9330.626774928995, 9333.673321433751, 9336.579853906556, 9211.124943130391, 9303.581338839735, 9305.11601397866, 9309.627614895397, 9309.62761489543, 9278.0, 9339.299552533554, 9346.766330841716, 9350.859737103949, 9355.953220233889, 9249.815003699921, 9286.117818807203, 9290.396124251902, 9298.767530811716, 9300.953495232548, 7929.881051784228, 9230.953845230799, 9258.305627077929, 9270.675526356612, 9276.350655454122, 38506.80746596249, 38792.418113728316, 38861.22277554433, 38908.416373754415, 38940.61059389398, 3260.0, 3264.542963985044, 3305.140663427502, 3320.5185248138882, 3343.5653365062385, 24604.72579492236, 28895.422091558263, 29213.853930730424, 29840.70159298401, 30475.23811904698, 3134.464112584817, 3177.830940988822, 3202.6957439043485, 3239.0930539448755, 3239.2387788869596, 431532.0, 449927.0, 456244.9999999967, 457701.0, 460520.0, 60091.699541502014, 60369.396306036375, 60452.0, 60462.0, 60477.0, 33647.0, 34406.13984650404, 63027.054594180205, 63148.0, 63277.0, 15204.391824326904, 15717.371305147666, 15765.921170394075, 15777.447789327318, 15781.921090394475, 11987.820182697267, 12093.637190884288, 12101.152919295564, 12103.394830258452, 12116.15186936906, 18487.81512184861, 18513.629727405376, 18517.0, 18529.722054169197, 18542.351017714584, 7507.474476786681, 7664.4634875559295, 7676.846463070819, 7709.7301594443925, 7791.883121753178, 748.2891253309269, 917.0783362720423, 933.2394098809449, 1008.178334657252, 1027.2552399510444, 22133.66245842564, 22707.88646056759, 26700.0, 26945.787439565265, 28492.002779902603, 986.284943416032, 1011.5549158370441, 1025.220832167558, 1025.9281850270559, 1040.4069680282166, 15022.323995420233, 15022.624434389229, 15109.168995705122, 15357.462488813062, 15443.691126177413, 629389.0, 634816.651833485, 638695.0, 641203.0, 641476.0, 54434.45565544294, 54966.450335496935, 54970.0, 55000.62498437571, 55007.72496137574, 1181.7990941539958, 1223.0399136677665, 1295.4235365262557, 1317.2294207888492, 1340.6581321762887, 28408.43183136367, 29398.706012939598, 29408.41183176367, 30166.547501787052, 30331.241718957204, 47860.521394787, 48290.30983915546, 48385.75807120942, 48474.75762621305, 48587.75706121447, 462831.0, 463114.0, 463466.0, 466610.0, 467815.0, 22909.427264318525, 23460.061597535907, 24976.250712478653, 25711.871440642677, 25751.742482574933, 43850.12299754051, 44065.0, 44434.11131777411, 44670.88322791956, 45239.32141017953, 36100.81949590235, 36263.456048159824, 36578.8171059143, 37279.627203727614, 37389.06527336838, 31370.686293136776, 36146.0, 36342.0, 36851.0, 37561.060973475884, 18504.814951850847, 34602.82698586491, 35015.62304711911, 36368.27263454769, 36734.081647959014, 29054.418911621226, 32322.191945201557, 32516.0, 32609.0, 32828.835855820565, 23870.16454424087, 23918.88040559786, 24475.388115296548, 24485.755142448346, 24541.14106006281], "value": 18855.078413099112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.3799798360934, 361.3008827917979, 366.86792754608337, 374.876290824028, 397.61232798021933, 14448.638784030405, 14774.0, 15507.844921550795, 18672.439826805217, 20165.09257083431, 19058.61882762344, 19651.31220407286, 19737.605247895033, 19745.5385011742, 19990.90004549975, 5570.415106413829, 5820.767169313222, 5829.766809327643, 5837.8832423351505, 5842.240508733858, 4851.757412129397, 5645.54835613152, 6343.841403964915, 6419.711112999903, 6462.612243265419, 6127.264728232618, 6419.743210271584, 6425.775097871576, 6428.4857211423205, 6433.839154021163, 6320.525960552977, 6375.362463753657, 6385.138006369127, 6400.775972840928, 6402.551821372459, 5312.3890752563175, 5492.286002819608, 5541.972290138524, 5551.583631227633, 5560.304961879765, 23927.0, 24626.0, 24882.502349952898, 24911.0, 25206.61363625, 1488.784126301691, 2011.4870707969521, 2114.3339847947846, 2244.1023590563905, 2323.8373313868037, 7768.728094516665, 9684.661036863747, 9802.509874506317, 10072.194224462026, 10278.691639250834, 1717.2444124585268, 1795.8293962073583, 1807.430659342303, 1848.4362269507794, 1868.6729822281047, 99711.0, 116954.66090678224, 119857.0, 128905.35547322391, 129692.703072969, 9983.951685073109, 11099.5560177592, 11113.944430277797, 11164.385958772184, 11247.718807029889, 13173.27546984925, 13654.795178072336, 13684.0, 14058.297085145907, 14104.647383815487, 7402.704526707805, 7860.0, 8159.46963447374, 8279.751607451666, 8285.0, 7531.962340188374, 7803.648835802403, 7983.12185659577, 8030.317423018992, 8156.877646835303, 4326.0050188456835, 4328.588784065509, 4355.542668019875, 4408.867733967986, 4543.0, 1239.9814002789965, 1541.3834466213605, 1543.7221300165854, 1851.5278603955906, 1852.1017306606286, 712.3090602115939, 829.9875501867476, 952.547539918547, 959.467495539968, 966.1304825656965, 15438.992930918908, 19753.802461975483, 20491.282805102048, 20500.974951252378, 20592.382228533166, 876.7413612984185, 890.5102193793388, 922.6032805893531, 959.6842907753694, 1003.8694969653898, 8793.252573531321, 10704.625338113285, 10736.516856741466, 10741.462926853626, 10777.78444431107, 563230.0, 565859.0, 570134.0, 575386.0, 578735.0, 103098.0, 128962.35518822346, 129802.0, 133654.33172834074, 137791.31104344415, 951.3768481644533, 952.4285428742699, 962.100436092256, 974.541965276319, 976.0532283684814, 17367.47897563075, 17922.91038544799, 18035.278588856298, 18126.27494900189, 18167.909925404518, 51653.70865728387, 54298.45701543092, 54436.0, 54869.0, 58746.4125358758, 81240.59379703064, 81906.0, 82042.0, 82983.5850820742, 83642.16357836587, 7649.885251721117, 7835.529868207697, 7888.723894663889, 7900.604969751605, 7955.801104972422, 10955.287906286385, 11160.665180044612, 12032.939835300767, 12320.691982700504, 12650.0, 10447.216458765775, 10879.728006799893, 10971.835422468828, 11098.2786118902, 11203.775924481628, 9267.53662316868, 9284.164425201765, 9450.054994500495, 10225.539850706587, 10342.913994030518, 10906.672799816019, 11082.501287442246, 11234.573455095948, 11395.943020284845, 11492.885071149181, 6832.726690932307, 7140.07179066718, 7155.642217889189, 7363.226861179499, 8164.387670924823, 9175.632974681204, 10659.680209593724, 10750.892491075301, 10993.230473866752, 11024.338539687644], "value": 9206.417783673758, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.1563850785797, 1490.5677353567467, 1645.9588510287242, 1791.5162906015385, 1831.331563979148, 6765.492588055897, 8011.31903788178, 8449.070602233749, 8451.788705282372, 8499.830003399944, 7356.043714317145, 7627.771166865003, 7628.160902300757, 7979.92020079799, 8199.795005124875, 2258.141906075693, 2295.231097582312, 2299.9540009199804, 2301.9884900575476, 2302.3898666853297, 2274.8862556872173, 2309.457277539777, 2319.478117423583, 2325.05835136769, 2328.464453175771, 2266.4900397410615, 2271.772822717723, 2294.529621427603, 2294.6902168207243, 2297.7242730872235, 2240.1823334482797, 2242.921497747579, 2258.0741895822634, 2261.0503588492707, 2265.909363625461, 2275.2377953385635, 2295.690081838947, 2301.42464383904, 2301.9309420717404, 2305.8155347572156, 8143.633536490872, 8226.218509241613, 8248.092709801916, 8279.58602069894, 8314.127016663224, 4987.950120498785, 5141.640085194038, 5143.434222235551, 5157.020166168453, 5167.379914410257, 3079.5842561254167, 3113.0, 3164.810111393324, 3494.4234201356744, 3501.1422201560526, 891.8216356728681, 1044.2272718188485, 1078.8219943709278, 1090.8145615245428, 1093.3002878157986, 10368.429736364496, 10635.255532112755, 10639.840402393971, 10725.195610329178, 10825.188110891635, 4216.0, 4297.785110744513, 4399.032212913154, 4418.977905110518, 4435.312526558324, 8584.184502472255, 8584.270337021424, 8604.526751028754, 8609.311255099577, 8609.655613775503, 5048.823291184791, 5062.215356619729, 5063.49365063498, 5064.746762661852, 5073.720945347967, 3575.713942884563, 4050.696197785119, 4243.405923170759, 4380.364847097153, 4742.905141897212, 2973.3755911258877, 3510.420780571228, 3608.963910360915, 3644.9635503645154, 3646.7447278690765, 963.9132478077007, 1127.3405058040973, 1135.3301552084145, 1146.4726225936163, 1149.40231079838, 858.6779957515931, 874.2525141004477, 885.2342723544087, 909.7998440343114, 925.5696101312788, 5359.516314395674, 5601.80393686219, 5603.159526071122, 5665.405132461032, 5800.709964501758, 436.85802114312975, 442.6834813108643, 447.5815112869478, 449.341714388416, 930.3952430919957, 3680.576733675608, 3868.2650296443585, 3943.191645712622, 4005.8798236052967, 4010.598940105966, 10048.899511004942, 10248.026437488426, 10270.743231419274, 10276.691699249035, 10287.971202879802, 10105.9494702526, 10214.897851021544, 10230.846537301946, 10237.692869213935, 10243.59025638981, 7613.096725818546, 7853.685852565834, 7858.960705196323, 7862.371010319161, 7866.9213307866185, 5359.946400536101, 5390.4879036491475, 5415.756290966995, 5633.408492108433, 5807.245058142415, 9089.954550227207, 9362.578683959102, 9375.390599611004, 9453.763655908657, 9476.194523465307, 8984.86522702147, 9449.149576538144, 9545.904540954501, 9603.37578057424, 9618.038196180327, 7018.368346848808, 7079.256678048937, 7134.785956421108, 7153.606551639502, 7203.459740519377, 7765.339946104645, 7841.647125879464, 7846.686132554634, 7859.0, 7866.803329916798, 6818.386345228953, 6955.408790252885, 6999.160100787734, 7019.859602807813, 7081.539699919489, 6766.255711871591, 6910.274421185904, 6966.164060312795, 6978.930210697828, 6999.580025198505, 6252.937470625236, 6366.808995730135, 6489.837754055998, 6508.902366464602, 6560.343965603593, 4750.501197374226, 4759.690620109682, 4793.544613261734, 4809.519048095302, 4905.386826646669, 4695.506971767915, 4792.664513484162, 4887.780049897692, 4906.55840974314, 5078.695278283315], "value": 4273.655366660963, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.48137281318918, 258.37473314578716, 297.1471875716693, 309.1359649778868, 312.9624445066592, 4216.47294088239, 4537.773111344428, 4944.678595891264, 5084.822031228908, 5121.923171152431, 4534.27451607742, 4969.304297398367, 4985.40467050544, 4990.950090499094, 4998.350214472122, 3449.4135996880464, 3704.666580007799, 3893.532776066876, 3897.1036661567855, 3905.8047097645003, 3273.216097227005, 3835.2511235122693, 3944.3886197639413, 4003.4195041718935, 4013.779242141681, 3198.344339410415, 3455.533502977091, 3472.988698053752, 3975.423563583279, 3983.8406463741417, 3730.850765969358, 3760.511133552648, 3927.2145570885937, 3971.8808435746973, 3994.700397470187, 3267.640559538449, 3370.9494357584654, 3381.8140002299865, 3384.323135372935, 3384.509246159293, 3934.9409758853353, 4227.133437645275, 4871.0014447038275, 5034.974825125888, 5059.468755780626, 4151.4395556599775, 4473.776311184428, 4494.640428765691, 4496.79764410599, 4503.256962601167, 4201.285781417167, 4515.458145022585, 4680.7191568506, 5039.748012599355, 5380.354357477088, 2764.6129541864157, 3099.11675172577, 3680.705768337323, 3695.316366472211, 3734.6825519830845, 4593.471750748673, 5082.08522465956, 5122.8463146105305, 5525.4474552544825, 5746.88506229873, 3485.3029394121277, 3684.705223582107, 3692.7045836333027, 3705.814709264526, 3753.5871054184017, 3816.637419445148, 3858.0, 3866.33747488577, 3867.6325749053794, 3870.245302166051, 4421.845235416809, 4429.5382523767075, 4436.467623885154, 4441.533638967927, 4467.821287148543, 5301.867453313698, 5424.701641409761, 5454.563634909197, 5467.641711123121, 5497.972510137503, 1068.3429690740295, 1098.2038022433671, 1105.7069876482738, 1209.6029086405217, 1235.1971218707731, 806.2944923192207, 826.9379796515285, 828.9502629842228, 830.3481766813144, 837.8198687282263, 3798.8346642414112, 4380.956190438055, 4469.508354081048, 4638.796571628517, 4758.714477131383, 4595.563421474954, 4799.0401919616215, 5127.820601261731, 5140.974295128501, 5163.328767260232, 4057.9797101014306, 4381.605655490957, 4683.976580117078, 4691.390119284471, 4713.528647135327, 2326.7789559991775, 2358.6462030695534, 2705.553583658674, 2712.823666461674, 2742.9725702743117, 4134.64855487281, 4677.614416647466, 4712.0, 5074.898502029939, 5335.279737235423, 4648.256903661127, 5010.667905842573, 5275.892062666806, 5279.41926388097, 5291.497307755757, 5143.71709555978, 5215.617861266767, 5356.7321633918145, 5408.0, 5478.698671573102, 4607.562281583244, 4758.428988521399, 5229.842275390997, 5264.552513036435, 5310.99091172676, 3998.540167880731, 4123.49492435253, 4820.988635460614, 5058.494150584912, 5070.949290507047, 4504.819807207675, 5263.973680131575, 5278.81524146653, 5287.312649355559, 5333.453253586322, 3076.5846610707267, 3479.251960828333, 3496.632853550442, 3580.480830279647, 3659.4144936809985, 4886.240953256895, 5377.166539186433, 5554.472325129106, 5559.469032738467, 5577.247071645276, 4903.926441103315, 5378.2739330189925, 5388.218708287198, 5413.53984911287, 5446.346438427414, 5015.974920125522, 5133.79464821403, 5296.814611488579, 5363.731813409236, 5369.758360873692, 4636.884077898079, 5257.974694934451, 5258.842234732964, 5286.392064912584, 5460.358695109126, 4849.563539281482, 5356.330458692663, 5376.462353764592, 5405.486478784509, 5406.864018869125, 4423.977880110579, 4486.590191454453, 4979.203327467588, 5263.236800679674, 5276.129438642581], "value": 3791.5560221352453, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.9028640847077, 710.4884483172116, 726.7529040126352, 757.6098309370675, 781.7811012916385, 13938.930305348471, 14401.135931844083, 14807.407703691839, 15084.32120554575, 15095.547133585997, 13335.266560339178, 13633.386497607607, 13656.0, 13802.30988450576, 13815.171089734624, 787.5314188058096, 804.2038382001834, 805.5327909812295, 806.2501873257868, 806.3468590441731, 642.6144313411938, 663.6714826161057, 665.9800205993828, 668.7091115364808, 804.3082948664173, 689.9172099348085, 692.4944790303082, 814.1939479914901, 844.932405407569, 849.5285116760195, 839.886615306938, 840.0423517190408, 840.5713086325957, 840.8612578924501, 844.8817165596852, 622.9657368844712, 624.8687775567137, 624.9750009999594, 625.3808729357949, 626.4894111299277, 11620.6513804586, 12157.148999570034, 13464.259465729381, 13836.792448113287, 14167.0, 13567.05030647855, 13883.0, 13999.0, 14049.0, 14092.506762263374, 11323.490442930088, 11357.488912998935, 11363.602273920456, 11439.828402573969, 11761.588344407905, 3654.0499470137956, 3661.552212125737, 3670.944935825938, 3701.1117331840433, 3810.733248672594, 81622.59188704078, 82259.354812904, 82600.17399826045, 85753.57123214407, 87117.0, 10546.630867919586, 10554.947225263824, 10581.153507719364, 10599.735006624742, 10791.190660700478, 16650.751193660522, 20429.591408171753, 20434.0, 20434.897825511074, 20435.897820511098, 6127.601705889103, 7631.0, 7797.154038775806, 7867.6066196689935, 7879.645415956295, 4177.310743727312, 4356.3683265926265, 4445.266531022345, 4474.619657329164, 4487.932681009787, 3303.3888730584918, 3414.5902491701154, 3429.1427143214196, 3432.2449061206494, 3435.0210190095704, 612.8222815383579, 619.4022768028874, 631.7694041674847, 633.8922383194868, 642.7043559962376, 562.7311747136898, 608.6317777744489, 619.8853212155766, 645.9709313080923, 675.0751470485467, 8399.790005249795, 8670.046294907555, 8719.520426376483, 8986.843157642119, 9380.108889655472, 604.9866473656607, 623.4108767214939, 630.3948209718629, 631.6904716688789, 635.8303855281418, 3976.2643910876004, 4260.765657888784, 4266.360045993064, 4291.079905259268, 4502.0, 89937.0, 92237.0, 93585.5320723392, 96698.0, 100374.0, 78430.6078469604, 82068.0, 83699.0, 85339.0, 85668.0, 75511.62244188743, 76734.0, 78058.0, 78996.99999999885, 79312.20687793163, 6880.449564034965, 8158.714444994397, 8245.464044837066, 8377.287930525974, 8589.914100859161, 46496.0, 49156.0, 49318.26022609592, 49631.255531167786, 49965.75017124891, 69270.0, 69503.0, 70852.0, 72570.91143632955, 72571.92850893638, 10730.356178629307, 10864.402457864893, 10957.561697532328, 10992.560297588007, 11382.886171138514, 12324.938375308066, 13697.383617737027, 14080.788788168391, 14471.27643617836, 14818.0, 12565.93717031409, 12604.0, 13016.088873779123, 13256.276684031014, 13565.59303220905, 13071.477140914258, 13240.139390939557, 13442.126261792951, 13662.18026918388, 13721.931390342985, 12529.850116421776, 12868.485260589472, 13276.0, 13467.865321347053, 13583.52457663977, 10681.626143084955, 11214.15893807984, 11269.943650281695, 11347.829782553434, 11362.886371136183, 10020.34867733595, 10421.9478902605, 11206.719832004264, 11231.943840280746, 11471.483783229607], "value": 7044.84559054741, "unit": "score"}], "name": "dromaeo_css", "value": 6919.231539026303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 155.0, 163.0, 113.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 114.0, 152.0, 112.0, 114.0, 110.0, 129.0, 163.0, 139.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 183.0, 186.0, 181.0, 184.0, 183.0, 183.0, 185.0, 182.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 89.0, 60.0, 59.0, 59.0, 59.0, 83.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 92.0, 70.0, 67.0, 69.0, 91.0, 69.0, 69.0, 93.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 86.0, 89.0, 85.0, 89.0, 93.0, 135.0, 107.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 98.0, 99.0, 98.0, 97.0, 98.0, 98.0, 97.0, 98.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 86.0, 86.0, 85.0, 87.0, 88.0, 86.0, 85.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 54.0, 56.0, 54.0, 55.0, 54.0, 54.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 76.0, 77.0, 74.0, 70.0, 71.0, 71.0, 71.0, 71.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 88.0, 88.0, 88.0, 88.0, 86.0, 88.0, 88.0, 88.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 158.0, 150.0, 149.0, 141.0, 155.0, 156.0, 212.0, 162.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 160.0, 234.0, 230.0, 195.0, 174.0, 175.0, 177.0, 173.0, 173.0], "value": 186.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1486.3, "alertThreshold": 2.0}]} 09:13:28 INFO - Return code: 0 09:13:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:28 INFO - # TBPL SUCCESS # 09:13:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:13:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:13:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:13:28 INFO - 2016-11-21 09:13:28.366 screenresolution[1969:18053] starting screenresolution argv=screenresolution get 09:13:28 INFO - 2016-11-21 09:13:28.368 screenresolution[1969:18053] Display 0: 1600x1200x32@60 09:13:28 INFO - 2016-11-21 09:13:28.375 screenresolution[1970:18056] starting screenresolution argv=screenresolution list 09:13:28 INFO - Available Modes on Display 0 09:13:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:13:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:13:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:13:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:13:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:13:28 INFO - Intel Iris: 09:13:28 INFO - Chipset Model: Intel Iris 09:13:28 INFO - Type: GPU 09:13:28 INFO - Bus: Built-In 09:13:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:13:28 INFO - Vendor: Intel (0x8086) 09:13:28 INFO - Device ID: 0x0a2e 09:13:28 INFO - Revision ID: 0x0009 09:13:28 INFO - Displays: 09:13:28 INFO - Display: 09:13:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:13:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:13:28 INFO - Display Serial Number: 1600x1200 60 09:13:28 INFO - Main Display: Yes 09:13:28 INFO - Mirror: Off 09:13:28 INFO - Online: Yes 09:13:28 INFO - Rotation: Supported 09:13:28 INFO - Return code: 0 09:13:28 INFO - Running post-action listener: _resource_record_post_action 09:13:28 INFO - [mozharness: 2016-11-21 17:13:28.622417Z] Finished run-tests step (success) 09:13:28 INFO - Running post-run listener: _resource_record_post_run 09:13:28 INFO - Total resource usage - Wall time: 1217s; CPU: 54.0%; Read bytes: 831488; Write bytes: 692275200; Read time: 11; Write time: 1973 09:13:28 INFO - TinderboxPrint: CPU usage
53.7% 09:13:28 INFO - TinderboxPrint: I/O read bytes / time
831,488 / 11 09:13:28 INFO - TinderboxPrint: I/O write bytes / time
692,275,200 / 1,973 09:13:28 INFO - TinderboxPrint: CPU idle
2,254.0 (46.3%) 09:13:28 INFO - TinderboxPrint: CPU system
976.6 (20.1%) 09:13:28 INFO - TinderboxPrint: CPU user
1,639.1 (33.7%) 09:13:28 INFO - TinderboxPrint: Swap in / out
384,274,432 / 0 09:13:28 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 372113920; Write bytes: 368371200; Read time: 28643; Write time: 687 09:13:28 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 831488; Write bytes: 304345600; Read time: 11; Write time: 1241 09:13:29 INFO - Running post-run listener: _upload_blobber_files 09:13:29 INFO - Blob upload gear active. 09:13:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:29 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 09:13:29 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'] 09:13:29 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 09:13:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:13:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:30 INFO - (blobuploader) - INFO - Done attempting. 09:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:13:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:31 INFO - (blobuploader) - INFO - Done attempting. 09:13:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:34 INFO - (blobuploader) - INFO - Done attempting. 09:13:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:34 INFO - Return code: 0 09:13:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/325b8e0483008dc5c0cbd1a17d9d26705ad04b5c997aa4b7392cc353db542224cf1318440783d1955a7af0d97b6d1eb89598fe4fb05bac25ce3b16257d24b23e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df48fc32aa70ffc2699de6f4f339560ed3332f0cd50ea10713a329f0ef16ffd9d1bfe99d1d8bfc9a07b8f8a9da52c32f015cd76f13ac1896aa9f693446e78395", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f443e4435fbd7dcf53a564b00bc431afd7ebfcc7f67902e3e1c2a630e1e95f11998eb3aaaf8f2fc384479a56f41b0f3c9bfdfd8ea5b74f5e81974bf07ef709"} 09:13:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:34 INFO - Contents: 09:13:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/325b8e0483008dc5c0cbd1a17d9d26705ad04b5c997aa4b7392cc353db542224cf1318440783d1955a7af0d97b6d1eb89598fe4fb05bac25ce3b16257d24b23e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df48fc32aa70ffc2699de6f4f339560ed3332f0cd50ea10713a329f0ef16ffd9d1bfe99d1d8bfc9a07b8f8a9da52c32f015cd76f13ac1896aa9f693446e78395", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f443e4435fbd7dcf53a564b00bc431afd7ebfcc7f67902e3e1c2a630e1e95f11998eb3aaaf8f2fc384479a56f41b0f3c9bfdfd8ea5b74f5e81974bf07ef709"} 09:13:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:34 INFO - Copying logs to upload dir... 09:13:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.590600 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-21 09:13:34.118325) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 09:13:34.123371) ========= 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.siJWTE7ASv/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.hM4gj5FICQ/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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/325b8e0483008dc5c0cbd1a17d9d26705ad04b5c997aa4b7392cc353db542224cf1318440783d1955a7af0d97b6d1eb89598fe4fb05bac25ce3b16257d24b23e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df48fc32aa70ffc2699de6f4f339560ed3332f0cd50ea10713a329f0ef16ffd9d1bfe99d1d8bfc9a07b8f8a9da52c32f015cd76f13ac1896aa9f693446e78395", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f443e4435fbd7dcf53a564b00bc431afd7ebfcc7f67902e3e1c2a630e1e95f11998eb3aaaf8f2fc384479a56f41b0f3c9bfdfd8ea5b74f5e81974bf07ef709"} build_url:https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/bTSVeDjSSbyZ2aTKQVfqKg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/325b8e0483008dc5c0cbd1a17d9d26705ad04b5c997aa4b7392cc353db542224cf1318440783d1955a7af0d97b6d1eb89598fe4fb05bac25ce3b16257d24b23e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df48fc32aa70ffc2699de6f4f339560ed3332f0cd50ea10713a329f0ef16ffd9d1bfe99d1d8bfc9a07b8f8a9da52c32f015cd76f13ac1896aa9f693446e78395", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f443e4435fbd7dcf53a564b00bc431afd7ebfcc7f67902e3e1c2a630e1e95f11998eb3aaaf8f2fc384479a56f41b0f3c9bfdfd8ea5b74f5e81974bf07ef709"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 09:13:34.157135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:13:34.157456) ========= 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.siJWTE7ASv/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.hM4gj5FICQ/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005247 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:13:34.205725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 09:13:34.206063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 09:13:34.206370) ========= ========= Total master_lag: 0.20 =========