builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0107 starttime: 1468345803.55 results: success (0) buildid: 20160712074627 builduid: 74ecc4fb6a064df586a53655f8f96751 revision: b4484a7069fbc7b6131fa370d96301b00a57b9e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:03.545819) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:03.546279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:03.546567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:03.591749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:03.592071) ========= 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.LViiSDLBuO/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.f0p04kNVfg/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-12 10:50:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-07-12 10:50:04 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.455286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:04.068804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:04.069156) ========= 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.LViiSDLBuO/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.f0p04kNVfg/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.028765 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:04.120071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 10:50:04.120500) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b4484a7069fbc7b6131fa370d96301b00a57b9e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b4484a7069fbc7b6131fa370d96301b00a57b9e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LViiSDLBuO/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.f0p04kNVfg/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-12 10:50:04,195 truncating revision to first 12 chars 2016-07-12 10:50:04,195 Setting DEBUG logging. 2016-07-12 10:50:04,195 attempt 1/10 2016-07-12 10:50:04,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b4484a7069fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 10:50:05,397 unpacking tar archive at: autoland-b4484a7069fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.469171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 10:50:05.613198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:05.613674) ========= script_repo_revision: b4484a7069fbc7b6131fa370d96301b00a57b9e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:05.614212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:05.614502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 10:50:05.634437) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-07-12 10:50:05.635085) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LViiSDLBuO/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.f0p04kNVfg/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:50:05 INFO - MultiFileLogger online at 20160712 10:50:05 in /builds/slave/test 10:50:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:50:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:05 INFO - {'append_to_log': False, 10:50:05 INFO - 'base_work_dir': '/builds/slave/test', 10:50:05 INFO - 'blob_upload_branch': 'Autoland', 10:50:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:05 INFO - 'branch': 'Autoland', 10:50:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:05 INFO - 'config_files': ('talos/mac_config.py',), 10:50:05 INFO - 'default_actions': ('clobber', 10:50:05 INFO - 'read-buildbot-config', 10:50:05 INFO - 'download-and-extract', 10:50:05 INFO - 'populate-webroot', 10:50:05 INFO - 'create-virtualenv', 10:50:05 INFO - 'install', 10:50:05 INFO - 'run-tests'), 10:50:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:05 INFO - 'download_minidump_stackwalk': True, 10:50:05 INFO - 'download_symbols': 'ondemand', 10:50:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:05 INFO - 'installer_path': 'installer.exe', 10:50:05 INFO - 'log_level': 'info', 10:50:05 INFO - 'log_name': 'talos', 10:50:05 INFO - 'log_to_console': True, 10:50:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:50:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:50:05 INFO - 'opt_config_files': (), 10:50:05 INFO - 'pip_index': False, 10:50:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:05 INFO - 'cmd': ('bash', 10:50:05 INFO - '-c', 10:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:05 INFO - 'enabled': True, 10:50:05 INFO - 'halt_on_failure': False, 10:50:05 INFO - 'name': 'check_screen_resolution'},), 10:50:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:05 INFO - 'cmd': ('bash', 10:50:05 INFO - '-c', 10:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:05 INFO - 'enabled': True, 10:50:05 INFO - 'halt_on_failure': False, 10:50:05 INFO - 'name': 'check_screen_resolution'},), 10:50:05 INFO - 'run_cmd_checks_enabled': True, 10:50:05 INFO - 'sps_profile': False, 10:50:05 INFO - 'sps_profile_interval': 0, 10:50:05 INFO - 'suite': 'dromaeojs', 10:50:05 INFO - 'system_bits': '32', 10:50:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:05 INFO - 'title': 't-yosemite-r7-0107', 10:50:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:05 INFO - 'use_talos_json': True, 10:50:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:05 INFO - 'work_dir': 'build'} 10:50:05 INFO - ##### 10:50:05 INFO - ##### Running clobber step. 10:50:05 INFO - ##### 10:50:05 INFO - Running pre-action listener: _resource_record_pre_action 10:50:05 INFO - Running main action method: clobber 10:50:05 INFO - rmtree: /builds/slave/test/build 10:50:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:07 INFO - Running post-action listener: _resource_record_post_action 10:50:07 INFO - ##### 10:50:07 INFO - ##### Finished clobber step (success) 10:50:07 INFO - ##### 10:50:07 INFO - ##### 10:50:07 INFO - ##### Running read-buildbot-config step. 10:50:07 INFO - ##### 10:50:07 INFO - Running pre-action listener: _resource_record_pre_action 10:50:07 INFO - Running main action method: read_buildbot_config 10:50:07 INFO - Using buildbot properties: 10:50:07 INFO - { 10:50:07 INFO - "project": "", 10:50:07 INFO - "product": "firefox", 10:50:07 INFO - "script_repo_revision": "production", 10:50:07 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 10:50:07 INFO - "repository": "", 10:50:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 10:50:07 INFO - "buildid": "20160712074627", 10:50:07 INFO - "pgo_build": "False", 10:50:07 INFO - "basedir": "/builds/slave/test", 10:50:07 INFO - "buildnumber": 65, 10:50:07 INFO - "slavename": "t-yosemite-r7-0107", 10:50:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:50:07 INFO - "platform": "yosemite_r7", 10:50:07 INFO - "scheduler": "tests-autoland-macosx64-talos", 10:50:07 INFO - "branch": "autoland", 10:50:07 INFO - "repo_path": "integration/autoland", 10:50:07 INFO - "revision": "b4484a7069fbc7b6131fa370d96301b00a57b9e8", 10:50:07 INFO - "stage_platform": "macosx64", 10:50:07 INFO - "builduid": "74ecc4fb6a064df586a53655f8f96751", 10:50:07 INFO - "slavebuilddir": "test" 10:50:07 INFO - } 10:50:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:50:07 INFO - Running post-action listener: _resource_record_post_action 10:50:07 INFO - ##### 10:50:07 INFO - ##### Finished read-buildbot-config step (success) 10:50:07 INFO - ##### 10:50:07 INFO - ##### 10:50:07 INFO - ##### Running download-and-extract step. 10:50:07 INFO - ##### 10:50:07 INFO - Running pre-action listener: _resource_record_pre_action 10:50:07 INFO - Running main action method: download_and_extract 10:50:07 INFO - mkdir: /builds/slave/test/build/tests 10:50:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:07 INFO - https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 10:50:12 INFO - Downloaded 1199 bytes. 10:50:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:50:12 INFO - Using the following test package requirements: 10:50:12 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:50:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:50:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:50:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'jsshell-mac.zip'], 10:50:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:50:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:50:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:50:12 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:50:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:50:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:50:12 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:50:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:50:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:12 INFO - https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:50:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:50:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:50:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:50:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:50:13 INFO - Downloaded 18772474 bytes. 10:50:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:50:16 INFO - Return code: 0 10:50:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:50: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:16 INFO - https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:50:24 INFO - Downloaded 18772474 bytes. 10:50:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:50:28 INFO - Return code: 0 10:50:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:28 INFO - https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:50:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:50:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:50:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:50:29 INFO - Downloaded 14403317 bytes. 10:50:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:50:29 INFO - Return code: 0 10:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:29 INFO - https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:50:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:50:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:50:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 10:50:39 INFO - Downloaded 112462677 bytes. 10:50:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:50:39 INFO - mkdir: /builds/slave/test/properties 10:50:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:39 INFO - Contents: 10:50:39 INFO - build_url:https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:50:40 INFO - Running post-action listener: _resource_record_post_action 10:50:40 INFO - Running post-action listener: set_extra_try_arguments 10:50:40 INFO - ##### 10:50:40 INFO - ##### Finished download-and-extract step (success) 10:50:40 INFO - ##### 10:50:40 INFO - ##### 10:50:40 INFO - ##### Running populate-webroot step. 10:50:40 INFO - ##### 10:50:40 INFO - Running pre-action listener: _resource_record_pre_action 10:50:40 INFO - Running main action method: populate_webroot 10:50:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:40 INFO - '--tppagecycles', 10:50:40 INFO - '7'], 10:50:40 INFO - 'tests': ['tsvgm']}}, 10:50:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:50:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['damp', 'tps']}, 10:50:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'tests': ['damp', 'tps']}, 10:50:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['dromaeo_dom']}, 10:50:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['basic_compositor_video']}, 10:50:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:50:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['a11yr', 10:50:40 INFO - 'ts_paint', 10:50:40 INFO - 'tpaint', 10:50:40 INFO - 'sessionrestore', 10:50:40 INFO - 'sessionrestore_no_auto_restore', 10:50:40 INFO - 'tabpaint']}, 10:50:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:40 INFO - 'ts_paint', 10:50:40 INFO - 'tpaint', 10:50:40 INFO - 'sessionrestore', 10:50:40 INFO - 'sessionrestore_no_auto_restore', 10:50:40 INFO - 'tabpaint']}, 10:50:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:50:40 INFO - 'ts_paint', 10:50:40 INFO - 'tpaint', 10:50:40 INFO - 'sessionrestore', 10:50:40 INFO - 'sessionrestore_no_auto_restore', 10:50:40 INFO - 'tabpaint']}, 10:50:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:50:40 INFO - 'ts_paint', 10:50:40 INFO - 'tpaint', 10:50:40 INFO - 'sessionrestore', 10:50:40 INFO - 'sessionrestore_no_auto_restore', 10:50:40 INFO - 'tabpaint']}, 10:50:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['a11yr', 10:50:40 INFO - 'ts_paint', 10:50:40 INFO - 'tpaint', 10:50:40 INFO - 'sessionrestore', 10:50:40 INFO - 'sessionrestore_no_auto_restore', 10:50:40 INFO - 'tabpaint']}, 10:50:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['a11yr', 10:50:40 INFO - 'ts_paint', 10:50:40 INFO - 'tpaint', 10:50:40 INFO - 'sessionrestore', 10:50:40 INFO - 'sessionrestore_no_auto_restore', 10:50:40 INFO - 'tabpaint']}, 10:50:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['tsvgx', 10:50:40 INFO - 'tsvgr_opacity', 10:50:40 INFO - 'tart', 10:50:40 INFO - 'tscrollx', 10:50:40 INFO - 'cart']}, 10:50:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:40 INFO - 'tsvgr_opacity', 10:50:40 INFO - 'tart', 10:50:40 INFO - 'tscrollx', 10:50:40 INFO - 'cart']}, 10:50:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'talos_options': ['--disable-e10s'], 10:50:40 INFO - 'tests': ['tp5o']}, 10:50:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'tests': ['tp5o']}, 10:50:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'talos_options': ['--disable-e10s', 10:50:40 INFO - '--xperf_path', 10:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:40 INFO - 'tests': ['tp5n']}, 10:50:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:40 INFO - 'talos_options': ['--xperf_path', 10:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:40 INFO - 'tests': ['tp5n']}}, 10:50:40 INFO - 'talos.zip': {'path': '', 10:50:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:40 INFO - Running post-action listener: _resource_record_post_action 10:50:40 INFO - ##### 10:50:40 INFO - ##### Finished populate-webroot step (success) 10:50:40 INFO - ##### 10:50:40 INFO - ##### 10:50:40 INFO - ##### Running create-virtualenv step. 10:50:40 INFO - ##### 10:50:40 INFO - Running pre-action listener: _resource_record_pre_action 10:50:40 INFO - Running main action method: create_virtualenv 10:50:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:40 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 10:50:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:40 INFO - Using real prefix '/tools/python27' 10:50:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:44 INFO - Installing pip.................done. 10:50:44 INFO - Return code: 0 10:50:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:44 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:50:44 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 10:50:44 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 10:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:44 INFO - 'HOME': '/Users/cltbld', 10:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:44 INFO - 'LOGNAME': 'cltbld', 10:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:44 INFO - 'MOZ_NO_REMOTE': '1', 10:50:44 INFO - 'NO_EM_RESTART': '1', 10:50:44 INFO - 'PAGER': '/bin/cat', 10:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:44 INFO - 'PWD': '/builds/slave/test', 10:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:44 INFO - 'SHELL': '/bin/bash', 10:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:50:44 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:44 INFO - 'USER': 'cltbld', 10:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:44 INFO - 'XPC_FLAGS': '0x0', 10:50:44 INFO - 'XPC_SERVICE_NAME': '0', 10:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:44 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 10:50:44 INFO - Cleaning up... 10:50:44 INFO - Return code: 0 10:50:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:44 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:50:44 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 10:50:44 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 10:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:44 INFO - 'HOME': '/Users/cltbld', 10:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:44 INFO - 'LOGNAME': 'cltbld', 10:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:44 INFO - 'MOZ_NO_REMOTE': '1', 10:50:44 INFO - 'NO_EM_RESTART': '1', 10:50:44 INFO - 'PAGER': '/bin/cat', 10:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:44 INFO - 'PWD': '/builds/slave/test', 10:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:44 INFO - 'SHELL': '/bin/bash', 10:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:50:44 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:44 INFO - 'USER': 'cltbld', 10:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:44 INFO - 'XPC_FLAGS': '0x0', 10:50:44 INFO - 'XPC_SERVICE_NAME': '0', 10:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:45 INFO - Downloading/unpacking psutil>=3.1.1 10:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:48 INFO - Installing collected packages: psutil 10:50:48 INFO - Running setup.py install for psutil 10:50:48 INFO - building 'psutil._psutil_osx' extension 10:50:48 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 10:50:49 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 10:50:49 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 10:50:49 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 10:50:49 INFO - building 'psutil._psutil_posix' extension 10:50:49 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 10:50:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:50:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:50:49 INFO - ^ 10:50:49 INFO - 1 warning generated. 10:50:49 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 10:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:49 INFO - Successfully installed psutil 10:50:49 INFO - Cleaning up... 10:50:49 INFO - Return code: 0 10:50:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:50:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:50:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:49 INFO - 'HOME': '/Users/cltbld', 10:50:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:49 INFO - 'LOGNAME': 'cltbld', 10:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:49 INFO - 'MOZ_NO_REMOTE': '1', 10:50:49 INFO - 'NO_EM_RESTART': '1', 10:50:49 INFO - 'PAGER': '/bin/cat', 10:50:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:49 INFO - 'PWD': '/builds/slave/test', 10:50:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:49 INFO - 'SHELL': '/bin/bash', 10:50:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:50:49 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:50:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:49 INFO - 'USER': 'cltbld', 10:50:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:49 INFO - 'XPC_FLAGS': '0x0', 10:50:49 INFO - 'XPC_SERVICE_NAME': '0', 10:50:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:52 INFO - Installing collected packages: mozsystemmonitor 10:50:52 INFO - Running setup.py install for mozsystemmonitor 10:50:52 INFO - Successfully installed mozsystemmonitor 10:50:52 INFO - Cleaning up... 10:50:52 INFO - Return code: 0 10:50:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:52 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:50:52 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 10:50:52 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 10:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:52 INFO - 'HOME': '/Users/cltbld', 10:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:52 INFO - 'LOGNAME': 'cltbld', 10:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:52 INFO - 'MOZ_NO_REMOTE': '1', 10:50:52 INFO - 'NO_EM_RESTART': '1', 10:50:52 INFO - 'PAGER': '/bin/cat', 10:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:52 INFO - 'PWD': '/builds/slave/test', 10:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:52 INFO - 'SHELL': '/bin/bash', 10:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:50:52 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:52 INFO - 'USER': 'cltbld', 10:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:52 INFO - 'XPC_FLAGS': '0x0', 10:50:52 INFO - 'XPC_SERVICE_NAME': '0', 10:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:52 INFO - Downloading/unpacking jsonschema==2.5.1 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:55 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 10:50:55 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 10:50:55 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 10:50:55 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 10:50:55 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 10:50:55 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 10:50:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:55 INFO - warning: no files found matching '*.txt' 10:50:55 INFO - no previously-included directories found matching 'build' 10:50:55 INFO - no previously-included directories found matching 'dist' 10:50:55 INFO - no previously-included directories found matching '.git*' 10:50:55 INFO - Installing collected packages: jsonschema, functools32 10:50:55 INFO - Running setup.py install for functools32 10:50:56 INFO - warning: no files found matching '*.txt' 10:50:56 INFO - no previously-included directories found matching 'build' 10:50:56 INFO - no previously-included directories found matching 'dist' 10:50:56 INFO - no previously-included directories found matching '.git*' 10:50:56 INFO - Successfully installed jsonschema functools32 10:50:56 INFO - Cleaning up... 10:50:56 INFO - Return code: 0 10:50:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:56 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:50:56 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 10:50:56 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 10:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:56 INFO - 'HOME': '/Users/cltbld', 10:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:56 INFO - 'LOGNAME': 'cltbld', 10:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:56 INFO - 'MOZ_NO_REMOTE': '1', 10:50:56 INFO - 'NO_EM_RESTART': '1', 10:50:56 INFO - 'PAGER': '/bin/cat', 10:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:56 INFO - 'PWD': '/builds/slave/test', 10:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:56 INFO - 'SHELL': '/bin/bash', 10:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:50:56 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:56 INFO - 'USER': 'cltbld', 10:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:56 INFO - 'XPC_FLAGS': '0x0', 10:50:56 INFO - 'XPC_SERVICE_NAME': '0', 10:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50:58 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 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 10:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:59 INFO - Downloading docopt-0.6.1.tar.gz 10:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:00 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:00 INFO - Running setup.py install for blobuploader 10:51:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:00 INFO - Running setup.py install for requests 10:51:00 INFO - Running setup.py install for docopt 10:51:00 INFO - Successfully installed blobuploader requests docopt 10:51:00 INFO - Cleaning up... 10:51:00 INFO - Return code: 0 10:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:01 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:01 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 10:51:01 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 10:51:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:51:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:01 INFO - 'HOME': '/Users/cltbld', 10:51:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:01 INFO - 'LOGNAME': 'cltbld', 10:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:01 INFO - 'MOZ_NO_REMOTE': '1', 10:51:01 INFO - 'NO_EM_RESTART': '1', 10:51:01 INFO - 'PAGER': '/bin/cat', 10:51:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:01 INFO - 'PWD': '/builds/slave/test', 10:51:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:01 INFO - 'SHELL': '/bin/bash', 10:51:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:51:01 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:51:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:01 INFO - 'USER': 'cltbld', 10:51:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:01 INFO - 'XPC_FLAGS': '0x0', 10:51:01 INFO - 'XPC_SERVICE_NAME': '0', 10:51:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-IEwnqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-1jbnft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-sqw6Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-X2jA7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-TKjKAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-oy2zUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-SG6LpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:01 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-7d_sJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-rnIh6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-WVtp9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-sFhiYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-i0I0JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Eqt4Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-qk1yWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-OoL2HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-zAHxMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:02 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-R7Ouku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:03 INFO - Running setup.py install for manifestparser 10:51:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:03 INFO - Running setup.py install for mozcrash 10:51:03 INFO - Running setup.py install for mozdebug 10:51:03 INFO - Running setup.py install for mozdevice 10:51:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:03 INFO - Running setup.py install for mozfile 10:51:03 INFO - Running setup.py install for mozhttpd 10:51:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:03 INFO - Running setup.py install for mozinfo 10:51:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Running setup.py install for mozInstall 10:51:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Running setup.py install for mozleak 10:51:04 INFO - Running setup.py install for mozlog 10:51:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Running setup.py install for moznetwork 10:51:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Running setup.py install for mozprocess 10:51:04 INFO - Running setup.py install for mozprofile 10:51:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:04 INFO - Running setup.py install for mozrunner 10:51:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:05 INFO - Running setup.py install for mozscreenshot 10:51:05 INFO - Running setup.py install for moztest 10:51:05 INFO - Running setup.py install for mozversion 10:51:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:05 INFO - Cleaning up... 10:51:05 INFO - Return code: 0 10:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:05 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:05 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 10:51:05 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 10:51:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:51:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:05 INFO - 'HOME': '/Users/cltbld', 10:51:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:05 INFO - 'LOGNAME': 'cltbld', 10:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:05 INFO - 'MOZ_NO_REMOTE': '1', 10:51:05 INFO - 'NO_EM_RESTART': '1', 10:51:05 INFO - 'PAGER': '/bin/cat', 10:51:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:05 INFO - 'PWD': '/builds/slave/test', 10:51:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:05 INFO - 'SHELL': '/bin/bash', 10:51:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:51:05 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:51:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:05 INFO - 'USER': 'cltbld', 10:51:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:05 INFO - 'XPC_FLAGS': '0x0', 10:51:05 INFO - 'XPC_SERVICE_NAME': '0', 10:51:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-_PoqCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Qsxe26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-br7_hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ALbvnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-LHVZKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-jyXyf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-43NGpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-WQQSQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-b6EWBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:06 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-P3GEtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-4NdEjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Xzoz3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-5OHP5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-2V0Kij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Zf5mkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-rw9Z08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:07 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-5H2Yt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:07 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)) 10:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:07 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)) 10:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:07 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 10:51:07 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 10:51:07 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 10:51:07 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 10:51:07 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 10:51:07 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 10:51:10 INFO - Downloading blessings-1.6.tar.gz 10:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:10 INFO - Installing collected packages: blessings 10:51:10 INFO - Running setup.py install for blessings 10:51:10 INFO - Successfully installed blessings 10:51:10 INFO - Cleaning up... 10:51:10 INFO - Return code: 0 10:51:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:10 INFO - Reading from file tmpfile_stdout 10:51:10 INFO - Current package versions: 10:51:10 INFO - blessings == 1.6 10:51:10 INFO - blobuploader == 1.2.4 10:51:10 INFO - docopt == 0.6.1 10:51:10 INFO - functools32 == 3.2.3-2 10:51:10 INFO - jsonschema == 2.5.1 10:51:10 INFO - manifestparser == 1.1 10:51:10 INFO - mozInstall == 1.12 10:51:10 INFO - mozcrash == 0.17 10:51:10 INFO - mozdebug == 0.1 10:51:10 INFO - mozdevice == 0.48 10:51:10 INFO - mozfile == 1.2 10:51:10 INFO - mozhttpd == 0.7 10:51:10 INFO - mozinfo == 0.9 10:51:10 INFO - mozleak == 0.1 10:51:10 INFO - mozlog == 3.2 10:51:10 INFO - moznetwork == 0.27 10:51:10 INFO - mozprocess == 0.23 10:51:10 INFO - mozprofile == 0.28 10:51:10 INFO - mozrunner == 6.12 10:51:10 INFO - mozscreenshot == 0.1 10:51:10 INFO - mozsystemmonitor == 0.3 10:51:10 INFO - moztest == 0.7 10:51:10 INFO - mozversion == 1.4 10:51:10 INFO - psutil == 3.1.1 10:51:10 INFO - requests == 1.2.3 10:51:10 INFO - wsgiref == 0.1.2 10:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:10 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:10 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 10:51:10 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 10:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:10 INFO - 'HOME': '/Users/cltbld', 10:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:10 INFO - 'LOGNAME': 'cltbld', 10:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:10 INFO - 'MOZ_NO_REMOTE': '1', 10:51:10 INFO - 'NO_EM_RESTART': '1', 10:51:10 INFO - 'PAGER': '/bin/cat', 10:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:10 INFO - 'PWD': '/builds/slave/test', 10:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:10 INFO - 'SHELL': '/bin/bash', 10:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:51:10 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:10 INFO - 'USER': 'cltbld', 10:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:10 INFO - 'XPC_FLAGS': '0x0', 10:51:10 INFO - 'XPC_SERVICE_NAME': '0', 10:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 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)) 10:51:11 INFO - Cleaning up... 10:51:11 INFO - Return code: 0 10:51:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:11 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 0x10ed40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10edd5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda9b5856d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, '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.LViiSDLBuO/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.f0p04kNVfg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:11 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 10:51:11 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 10:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:11 INFO - 'HOME': '/Users/cltbld', 10:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:11 INFO - 'LOGNAME': 'cltbld', 10:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:11 INFO - 'MOZ_NO_REMOTE': '1', 10:51:11 INFO - 'NO_EM_RESTART': '1', 10:51:11 INFO - 'PAGER': '/bin/cat', 10:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:11 INFO - 'PWD': '/builds/slave/test', 10:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:11 INFO - 'SHELL': '/bin/bash', 10:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:51:11 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:11 INFO - 'USER': 'cltbld', 10:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:11 INFO - 'XPC_FLAGS': '0x0', 10:51:11 INFO - 'XPC_SERVICE_NAME': '0', 10:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:11 INFO - Cleaning up... 10:51:11 INFO - Return code: 0 10:51:11 INFO - Running post-action listener: _resource_record_post_action 10:51:11 INFO - Running post-action listener: _start_resource_monitoring 10:51:11 INFO - Starting resource monitoring. 10:51:11 INFO - ##### 10:51:11 INFO - ##### Finished create-virtualenv step (success) 10:51:11 INFO - ##### 10:51:11 INFO - ##### 10:51:11 INFO - ##### Running install step. 10:51:11 INFO - ##### 10:51:11 INFO - Running pre-action listener: _resource_record_pre_action 10:51:11 INFO - Running main action method: install 10:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:11 INFO - Reading from file tmpfile_stdout 10:51:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:11 INFO - Reading from file tmpfile_stdout 10:51:11 INFO - Output received: 10:51:11 INFO - Usage: mozinstall [options] installer 10:51:11 INFO - Options: 10:51:11 INFO - -h, --help show this help message and exit 10:51:11 INFO - -d DEST, --destination=DEST 10:51:11 INFO - Directory to install application into. [default: 10:51:11 INFO - "/builds/slave/test"] 10:51:11 INFO - --app=APP Application being installed. [default: firefox] 10:51:11 INFO - mkdir: /builds/slave/test/build/application 10:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:51:47 INFO - Reading from file tmpfile_stdout 10:51:47 INFO - Output received: 10:51:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:51:47 INFO - Running post-action listener: _resource_record_post_action 10:51:47 INFO - ##### 10:51:47 INFO - ##### Finished install step (success) 10:51:47 INFO - ##### 10:51:47 INFO - ##### 10:51:47 INFO - ##### Running run-tests step. 10:51:47 INFO - ##### 10:51:47 INFO - Running pre-action listener: _resource_record_pre_action 10:51:47 INFO - Running main action method: run_tests 10:51:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:51:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:51:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:51:47 INFO - 2016-07-12 10:51:47.429 screenresolution[1644:7679] starting screenresolution argv=screenresolution get 10:51:47 INFO - 2016-07-12 10:51:47.431 screenresolution[1644:7679] Display 0: 1600x1200x32@60 10:51:47 INFO - 2016-07-12 10:51:47.436 screenresolution[1645:7682] starting screenresolution argv=screenresolution list 10:51:47 INFO - Available Modes on Display 0 10:51:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:51:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:51:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:51:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:51:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:51:47 INFO - Intel Iris: 10:51:47 INFO - Chipset Model: Intel Iris 10:51:47 INFO - Type: GPU 10:51:47 INFO - Bus: Built-In 10:51:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:51:47 INFO - Vendor: Intel (0x8086) 10:51:47 INFO - Device ID: 0x0a2e 10:51:47 INFO - Revision ID: 0x0009 10:51:47 INFO - Displays: 10:51:47 INFO - Display: 10:51:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:51:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:51:47 INFO - Display Serial Number: 1600x1200 60 10:51:47 INFO - Main Display: Yes 10:51:47 INFO - Mirror: Off 10:51:47 INFO - Online: Yes 10:51:47 INFO - Rotation: Supported 10:51:47 INFO - Return code: 0 10:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:51:47 INFO - Python 2.7.3 10:51:47 INFO - Return code: 0 10:51:47 INFO - grabbing minidump binary from tooltool 10:51:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:47 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 0x10eca4d30>, '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 0x10ea09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:51:47 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 10:51:47 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 10:51:47 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 10:51:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:47 INFO - Return code: 0 10:51:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:51:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:51:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:51:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:51:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LViiSDLBuO/Render', 10:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:47 INFO - 'HOME': '/Users/cltbld', 10:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:47 INFO - 'LOGNAME': 'cltbld', 10:51:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:51:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:47 INFO - 'MOZ_NO_REMOTE': '1', 10:51:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:51:47 INFO - 'NO_EM_RESTART': '1', 10:51:47 INFO - 'PAGER': '/bin/cat', 10:51:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:47 INFO - 'PWD': '/builds/slave/test', 10:51:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:47 INFO - 'SHELL': '/bin/bash', 10:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f0p04kNVfg/Listeners', 10:51:47 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 10:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:47 INFO - 'USER': 'cltbld', 10:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:47 INFO - 'XPC_FLAGS': '0x0', 10:51:47 INFO - 'XPC_SERVICE_NAME': '0', 10:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:51:48 INFO - mozversion application_buildid: 20160712074627 10:51:48 INFO - mozversion application_changeset: b4484a7069fbc7b6131fa370d96301b00a57b9e8 10:51:48 INFO - mozversion application_display_name: Nightly 10:51:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:48 INFO - mozversion application_name: Firefox 10:51:48 INFO - mozversion application_remotingname: firefox 10:51:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:51:48 INFO - mozversion application_vendor: Mozilla 10:51:48 INFO - mozversion application_version: 50.0a1 10:51:48 INFO - mozversion platform_buildid: 20160712074627 10:51:48 INFO - mozversion platform_changeset: b4484a7069fbc7b6131fa370d96301b00a57b9e8 10:51:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:51:48 INFO - mozversion platform_version: 50.0a1 10:51:48 INFO - using testdate: 1468345908 10:51:48 INFO - actual date: 1468345908 10:51:48 INFO - starting webserver on 'localhost:49266' 10:51:48 INFO - SUITE-START | Running 2 tests 10:51:48 INFO - TEST-START | dromaeo_css 10:51:48 INFO - operating with platform_type : mac_ 10:51:48 INFO - Initialising browser for dromaeo_css test... 10:51:48 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpsM5GBL/profile http://localhost:49266/getInfo.html) 10:51:50 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 10:51:50 INFO - PROCESS | 1655 | colorDepth:24 10:51:50 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 10:51:50 INFO - PROCESS | 1655 | __metrics 10:51:50 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:51:50 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:51:51 INFO - TEST-INFO | 1655: exit 0 10:51:51 INFO - Browser initialized. 10:51:51 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:51 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpsM5GBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:03 INFO - PROCESS | 1657 | RSS: Main: 243892224 10:52:03 INFO - PROCESS | 1657 | 10:52:54 INFO - PROCESS | 1657 | 1468345974573 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] 10:55:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 10:55:06 INFO - PROCESS | 1657 | RSS: Main: 383983616 10:55:06 INFO - PROCESS | 1657 | 10:58:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 10:58:10 INFO - PROCESS | 1657 | RSS: Main: 381194240 10:58:10 INFO - PROCESS | 1657 | 11:01:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 11:01:12 INFO - PROCESS | 1657 | RSS: Main: 372056064 11:01:12 INFO - PROCESS | 1657 | 11:04:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 11:04:15 INFO - PROCESS | 1657 | RSS: Main: 371023872 11:04:15 INFO - PROCESS | 1657 | 11:07:19 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 11:07:19 INFO - PROCESS | 1657 | RSS: Main: 338087936 11:07:19 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 11:10:22 INFO - PROCESS | 1657 | RSS: Main: 383217664 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | __start_tp_report 11:10:22 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 11:10:22 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 11:10:22 INFO - PROCESS | 1657 | |i|pagename|runs| 11:10:22 INFO - PROCESS | 1657 | |0;dojo.html;3349.9665003349965;3364.8990530284086;3380.171857894816;3390.016895100421;3431.828408579572;4608.377868987685;5606.299212598426;5711.143328500727;5733.168690539875;5783.913241301373;5611.579131565129;5700.344460387047;5718.9428105719035;5732.369439361677;5740.655560666363;5077.771500282496;5080.898382032357;5144.8971020579565;5184.611154163434;5279.1817268323475;5252.080885844981;5264.736763161845;5280.445553216895;5286.497782710656;5315.548178404821;5101.770420331094;5141.2288156776785;5159.767810448501;5181.922271165936;5203.9219411708855;5143.8456846294675;5151.4333423323405;5176;5193.350831146106;5244.711540865251;5095.439501654815;5139.922901156486;5169.715665638389;5229.816956406507;5239.083160446907;5635.126555383922;5703.201551782754;5723.313202415737;5765.452282033242;5834.27071616048;6220.004799232146;6258.780942666985;6277.560570760049;6289.182406287199;6316.399942005502;5815.156802263648;6348.650824204667;6359.586626869239;6366.77716279928;6386.776462823779;5640;5697.4587414195585;5704.1443783432815;5881.411858814085;5886.293644762613;6350.301466838644;6357.841053973688;6366.9681651591445;6372.872542549123;6373.71318290678;6047.788327408608;6070.453659170696;6071.057614416239;6084.04871231781;6087.569421186018;6258.624482530971;6280.717367718464;6304.5586808922935;6310.432061114522;6318.336574659595;6210.099535567318;6235.158253635792;6243.500519958392;6246.15676883624;6247.375262473716;6088.238970128734;6092.372385476703;6105.084237364342;6121.981350123568;6261.686915654199;4654.301854721819;4680.3915490985955;4886.60907127429;4917.360743103373;4935.531124543163;4345.3699213613845;4409.911801763947;4421.557844215553;4428.490723566767;4466.486354069324;5712.714364281769;5719.056355701346;5756.539476841843;5759.1937128802;5814.941850581525;6133.570650054453;6144.648177401054;6153.969230153821;6208.72060757267;6221.4089661482085;5717.4854263115685;5739.110437882135;5743.655380677173;5755.740991655385;5776.306843178845;5280.023195708806;5374.811881584125;5384.300040994645;5403.70279634616;5410.377806552218;6239.594426362272;6255;6256.468200203034;6308.7476500940365;6312.842178945563;6240.625562466266;6291.087792270187;6294.433500984934;6298.401651843067;6302.968485157545;6264.718087686157;6287.842803929939;6298.244210694746;6299.433051025429;6308;5341.092014357646;5638.746256418389;6071.878562428815;6103.640733310809;6152.138700582012;5170.741462926914;6292.433680968735;6295.968520157553;6299.653519056313;6315.242170939517;5959.22530071088;6070.605410648293;6082.118092876596;6127.234095738033;6141.723622437091;6055.273367195965;6108.08378743192;6126.693665316806;6126.908096378647;6133.987891997949;4912.852614421573;5933.732982015733;5943.108533719804;5962.850928726816;6041.486473649789;5975.984082705863;6019.969900150471;6144.692765361625;6151.108089326933;6154.815355539341;5844.707764611668;5927.4665280125;5941.049432090845;6016.969915150396;6031.4270144336215 11:10:22 INFO - PROCESS | 1657 | |1;ext.html;503.1446540880502;509.2386881611989;509.9872503187422;527.7836087204246;566.8724536979178;29968.850155749216;41478.58521414789;42553.148937021244;42616.9345766356;44881.32678009832;43128.13743725124;43441.78279108608;43486.08625223729;43560.3465948011;43580.56419435813;9620.134187923102;9837.213022958145;9837.606495740198;9844.704658860246;9845.310828242025;9637.229021678284;9749.756256093584;9758;9782.16851567614;9788.119069283763;9734.269929755297;9776.071273229032;9821.312508124434;9823.90176098237;9825.263105267099;9741.17200037994;9774.21806255505;9791.167750741195;9795.06946840049;9807.215422766161;9679.177269932065;9699.854502182472;9761.609535618567;9761.65834195807;9763.511824408823;40707.98230044243;40986.79506602478;41048.38427423591;41109.588904110875;41190.38214426786;3423.3495635829363;3943.191645712622;4084.8570300039655;4142.026623743418;4329.5453977332245;25930.74069259321;32201.677983220103;32852.6714732852;32903.01290961275;32927.341453171044;2950.3509227970026;3160.8146944895666;3287;3364.9158771030675;3426.43463828468;463638;464178.6791066023;464628;465464;468780.185387023;57348.71325643345;57417.425825742044;57827.71086144543;57840.8431831361;57887;59934;60207.397926021054;60239;60379;60537.09194362088;16023.759643605355;16230.756538651929;16264;16271.430499932445;16276.43032493857;11011.28426652281;12695.492180312684;12720.872791272153;12727.10910236293;12757.489700412065;14757.77863332051;15220.934534582473;15233.466828660943;15238.542843714706;15436.845631543541;6204.658743769046;6293.716782744787;6376.39424254695;6397.776077837253;6398.520110991694;942.5428667096453;995.6963126246565;1061.6443491430457;1090.8527348807968;1090.9018188362927;30262;30413.391732165233;30599.059027795138;30893.84553077265;31880.521792173135;1042.3902017319801;1065.7868426314767;1085.0993675249524;1106.9446527673583;1113.693734223079;14052.156870587798;14997.65021148102;15801.762973555406;15812.92093539525;16303.347866085462;144203;158721;162256;162831;162967.18516407342;60255.09617355743;60614.060086094265;60617.393826061176;60687.69656151779;60726.39273607208;1293.2886912198253;1329.860364661716;1399.671077296814;1426.9643258918402;1458.6061763324055;29371.41257174887;30567.54148687727;30576.388472229984;31020.379592407575;31393.215169620944;48944.75527622339;49527.50472495373;49583.760405988694;49584;49738.75130624323;404497;412043;429740.851295754;430812;431721;34593.30813383769;35427.82286088553;39045;39314.80342598269;41490;48361;48362.75818620884;48777;49730.502694974035;49897;40129.39805902972;40602.39096413497;40945.79527102345;41010;41704.791476042425;34576;37360.25279494449;37941.81029094837;40164.59835401725;41020.79489602533;38407.80796096002;39132.413013804246;39246;39279.80360098295;39328.0167995791;34300.39588915108;34718.65281347154;34973.47539786854;35074.473882892285;35628.46557301695;24546.263612091665;25741.3564660885;25841.22476325713;26041.869790650926;26225.213243602724 11:10:22 INFO - PROCESS | 1657 | |2;jquery.html;335.3594634248586;358.21372088266236;388.80948335315696;393.8090026337228;411.138664497877;14866.77699834502;15161.241937903116;20880.37358879232;21953.792541410217;22229.888850555726;20539.383818485432;21385.465363365925;21415.57168856626;21549.892250538764;21935;5390.110631745767;5572.832815015556;5614.3543492498475;5628.493435590796;5634.746436410351;3846;3849.9037524061982;5515.365732940703;5951.137085122655;6183.9381606183815;6159.199304090462;6199.225096862892;6199.225096862892;6204.193454850863;6210.472109870644;5923.792667256647;6178.598391104564;6187.133801267826;6196.659183744915;6202.286737025254;3114.6418161911215;4626.653001024936;5930.55520835939;5945.108233764927;6037.094435834616;13542.661433464144;13580.796288055688;13712.17726936387;13715;13764.449422023106;2150.7849215078522;2223.055201539339;2277.2485079923586;2358.705161854768;2902.4050069735654;10216.540255688511;10639.946800265949;10718.196135289885;10723.410212438313;13668.93165534166;1926.566522532419;1950.3758797184908;1963.8330741886957;2068.844836637258;2156.989215053915;113374;117106.41446792711;120031;120923;120951;8372.120927302545;9335.486548239776;9473.431594104239;10466;10604.840927386096;13525.932370338282;13815.963802714836;13817.654558635913;13831.30843457823;13850.376733047036;7392.96303518479;7440.330370266702;8232.50604963692;8813.986391564924;8891.110888911056;8729.738107856774;8742.431741936754;8769;8824.911750882537;8923.241524470493;4582.702124361906;4584.816607335736;4587.72473651582;4613.215753321943;4688.437387513521;1885.8774179678278;1919.8272155506072;1920.9423717288503;1951.5121219695077;1965.213914434209;873.3275377958936;957.9568919398644;966.0629189685993;973.5764942250144;984.640606178754;20959.68560471594;21812.781872181393;21858.89070554637;21886.89056554707;21908.671369929463;854.5001174313096;930.3766476460787;987.4519641598981;1021.918246540275;1023.0638965346773;11293.774124517464;11413.144014198968;11557.075433965263;11593.420328983517;11636.709082273012;456497;457082;461042;541186.8228565131;542219;95032;117710.41144794221;120402.3979880095;120505.39747301207;127821;938.4228699349851;958.1376760915232;979.9314048016713;983.7294743945472;994.5325696922434;18985;19048.523786904883;19111.80888191156;19216.71174932349;19334;54176;54427.63930901759;55416.722916386774;55497.72251138718;56444.71777641086;74068.25931740613;81377;83452.16547834687;84911.5754421224;91520.08479915382;7879.684812607661;8344.624491897757;8352.498850069016;8448.704295349633;8593.52735599548;12294.262344259372;13453.529126480526;13468;13647.317634118453;13716.725665486834;11453.541858325574;11593.594224202112;11671.241369310968;11843.58547450835;11897.94051029774;10134.746631334276;10896.564137434414;11162.330260184415;11537.88462115368;11548.133889958119;11802.586909458129;11933.940330298641;11947.342896140795;11992.940035299767;12141;8333.250007499355;8388.161183881562;8580.442271252348;12288.815667764811;12620;11252.043576296106;11620.767674351626;12205.511779528719;12307.87692123103;12355.814662779885 11:10:22 INFO - PROCESS | 1657 | |3;mootools.html;1397.0011441819097;1422.4168091082654;1553.7358649029663;1760.542259012657;1773.6541374431984;7445.888311675322;8499.617517211725;8771.386002979794;8774.47353158811;8881.067487913773;8542.786430339245;8665.133486651332;8793.516356600385;8794.560271986407;8796.91203087969;2350.9529809403844;2383.4398916254668;2386.0813586769045;2389;2389.6415537669313;2343.5078633486987;2375.9168429104984;2386.558486679961;2388.22382725614;2388.8208384371155;2341.988290058547;2362.728286247078;2368.490774483486;2379.7501262367464;2380.4286971126976;2330.370799884022;2355.846869953456;2360.9527809443716;2362.373970897722;2366.455715185517;2323;2353.1411034972284;2355.187460326185;2357.39886328985;2357.9174728884577;8640.13598640131;8683.826323473559;8839.29285657146;8845.911540884574;8848.380613357067;5229.816956406507;5379.112446446332;5389.757460914268;5391.083515802323;5396.757145928443;3572.1248294167835;3575;3645.54430696163;3649.8540058397634;3651.9817400912825;1089.3953855610134;1091.9290246133976;1099.4612639806517;1113.4098927568402;1113.8273567597034;11444.198906076577;11524.94237528807;11537.365444900528;11565.595204167814;11580.594679186188;4322.265214913472;4396.472423309159;4530.048689775184;4534.047849951481;4627.745473998895;9179.58691858868;9181.81636367269;9186.26509879208;9212.769680758034;9225;4598.896264896401;5212.270282160501;5260.026895024433;5261.868453288698;5264.078786212397;4365.956340436618;4523.592876641118;4694.882627934329;4898.069366820364;4922.581580565692;3303.801771893694;3747.9437808432895;3769.7361184717356;3847.5960024197057;3878.437626544135;1003.3428104591504;1141.57191053355;1144.5135817277624;1149.413798962535;1150.26957881744;661.6195687479718;840.2269911681268;942.1285311087354;972.1785091597588;974.0647782956917;5873.794417195378;5957.79147729836;6079.726412311456;6126.264848218153;6127.632342059491;471.76647559457604;475.7050628610215;490.4066080043188;505.5222814440319;654.188805880714;3950.58518855516;4111.218868414991;4159.604837540429;4203.495580530294;4233.343831706091;10264.486775661187;10657.520411581498;10777.245592808427;10783.191260655482;10785.56857725698;10722.463876806129;10727.570897164025;10727.83908241377;10738.946305268424;10741.409222492837;7899.526028438312;8325.916740832636;8342.916570834335;8348.833023339621;8355.331573474108;5389.83830485086;5761.193432919478;5787.189793429007;5944.554158438048;6040.909386359121;9963;10084.445355505517;10105.797884042426;10107.444090575089;10107.54516046765;9926.751831203988;9938.10557049869;10102;10298;10306.587736490756;7059.541129826544;7080.221175670775;7173.10336207974;7173.210946795953;7185.676644550903;7920.683172673029;8293.543855088028;8394.832103357776;8433.578321083798;8435.072142064246;7491.3632341251605;7497.175310715926;7505.587192704454;7610.429217808797;7697.0378702662165;6492.156019717407;7325.816854578465;7416.25837416254;7472.439567032603;7564.319211271012;7060.505764596429;7130.358267755927;7147.392471639969;7154.284571542804;7171.390431813145;4937.259411088366;5062.721550314768;5086.237064440364;5139.177731562932;5144.871378215575;5116.130257856099;5140.871478212925;5147.099257629975;5237.502437268454;5289.57683385336 11:10:22 INFO - PROCESS | 1657 | |4;prototype.html;265.3168092162681;295.2235620318562;309.9628044634644;314.58631899052745;315.1255266635089;4445.333200019994;4485.439320084989;5082.949170508294;5249.501297376743;5264.921026184601;5091.287219789223;5153.587712982961;5166.43169251382;5166.844994650157;5183.585313174937;3272.8527216275206;3846.8461261549573;3969.7816620085882;3982.1637456134245;4038.2327357801923;3448.069021364243;3939.9803000984957;4001.359782434811;4014.7992600369867;4028.919421611566;3461.3250416168858;3478.9478157827652;3807.505024346831;3850.614938506155;4019.537753158395;3289.851956661956;3411.6630108375844;3890.533136023667;3966.801659917007;3974.582668819776;3446.2418267981;3452.2405070884365;3464.9133771655656;3471.89584312471;3485.4074807282823;5064.050040968051;5075.949240507584;5086.719066202316;5170.1727723564045;5183.326167598226;3837.1366442550484;4328.372386004012;4612.492625811192;4620.983383655624;4632;5470.781168753245;5489.176623506466;5497.367802702701;5530.225768392428;5536.114221724545;3725.310817498744;3827.425886117077;3830.3296923038633;3853.614638536152;3871.8190951759984;4749.4775574686755;5384.5692344612335;5454.645448045904;5524.806631767909;5822.767089316422;3074.738647215012;3372.9494057589154;3969.583193764613;4038.959610403917;4052.594740525924;4065.390191471303;4104.527979282361;4105.568915263914;4138.530821558364;4139.296319625671;3623.8006909620226;4458;4671.182543054952;4671.929921051187;4728.621710263171;4588.036512332381;5519.558435325244;5539.086050801653;5565.220869078333;5592.972035139798;1204.7590481903653;1343.818584491081;1345.2399394342165;1386.6325423762712;1392.8119703840055;749.9227140819899;810.2707563193173;840.7771940435789;847.8601030829844;856.7986523167051;3614.813038111957;3654.7076233901225;3892.785896775648;4264.296391095497;4276.914461710749;4140.544540100586;4253.3194688849635;4597.6437200843575;4636.00651719757;4720.223820943232;3682.9079273018388;3827.4498827974717;4060.7563546186734;4256.021115143534;4366.310467654826;2002.0490267123;2211.966820497694;2408.867512286806;2463.938401539976;2467.79078251659;4212.736179146244;4511.796969136397;4740.620750339965;4817.759112044454;4829.106615276185;4336.436263285753;4752.0279084180365;4782.521747825259;4846.903061938741;4909.337239472697;4759.595434388116;4833.709977401297;5268.894622107537;5290.418054013979;5931.377205393372;5511.751971161227;5756.56825738063;5806.012977793701;5814.680192589448;5818.359980402068;5433.891322173614;5667.518260947865;5694.943050569441;5696.319585722139;5792.623479473821;4860.392450943632;5438.75525601341;5700.3444603871085;5837.708114594338;6021.638701677914;3218.4850423932057;3366.259422926952;3384.441567141394;3820.3696390095324;3891.6886649068574;4884.877878053077;5109.540141387293;5328.280682107866;5733.827985160452;5899.734511947058;4510.9323360148965;5449;5479.178123281539;5514.172874068761;5645.181448689999;5524;5643.548516118783;5644.491995720405;5647.407022262603;5659.03796354629;4881.926771098508;4964.180910149929;5262.368515778131;5467.4532546745;5539.396483652677;5360.249565060816;5481.561475081904;5503.697296648563;5517.806876759294;5663.971680141738;5395.919061214164;5419.268398766116;5465.781368745205;5500.972495137658;5523.254360661259 11:10:22 INFO - PROCESS | 1657 | |5;yui.html;723.8552289542092;767.5509826751351;805.5609692717472;823.2549542663887;832.883396324515;13809.654758631026;17500.737488937677;17515.82484175158;17518.737218941726;17549.561260968483;16485.83514164858;16595.83404165958;16728.916355418205;16750.83249167508;16752.916235418805;698.259844564763;715.6815217228335;871.3073106880014;880.3177537408511;908.3142227618139;897.349421669291;904.6788390121511;906.7415786500849;907.7322189953946;907.850204716221;950.8858936927578;950.9524523773819;952.4761381240324;954.2032402943515;954.4368822394786;737.1854101218157;911.3757076402619;940.6566603189855;944.4474982135459;947.4031360243038;695.9756408525728;696.3245651717825;696.7352406085706;696.864111498258;696.9963252915785;15045.699086018218;15085.39658413662;15093.094414335064;15093.169875656835;15098.24508774568;13384.397702103428;13533.932330338384;13560.45758169672;13582.728345433035;13708.588742337746;11551.375424682894;11999.100067494974;12801.487940482462;12846.486140554367;13004.869951300461;4549.47681016684;4553.658475614309;4614.30785382192;4776.044791041805;4789.30555069513;108138.45930770374;108568.45715771371;108918;109747.45126274317;110181.44909275482;10623.20325975555;10631.415272159951;10765.784684306427;10854.240203185702;10891.727706807393;20212.494687632927;20262;20282.884441355865;20329.593408131754;20336.898315508624;7698.42261830365;7729.845403092019;7781.41639377049;7902.841943161105;8001.839963200703;3784.0918179637238;4313.41768861206;4373.978130109393;4407.6914615976575;4556.931646025312;3195.1053704962646;3312.1719570107475;3386.762926595164;3427.211741299515;3434.7767395119236;544.7439703339503;603.3935894426073;632.7121159872247;641.201703878674;642.195430839343;556.3768579191251;566.5807302596049;617.4751461257985;662.0769303524979;692.1693967239333;9332.860007099898;9416.340856140141;9592.808143837085;9594.232461403071;9649.807003860024;617.7714245729109;621.176940553759;621.4222455310498;627.9748810047638;693.769945885937;4275.40144379787;4340.414044104069;4594.839180628662;4622.583967442946;4656.650751193674;150000;151958.48041519665;155103;155327;157488.21255893877;120748;130452.47737613082;131569;132602;133997.29017613825;89744;115161.42419288018;117757;118550.4072479632;119763;7319.890201647086;8950.552472376225;8961.820763584823;8993.730188094367;8995.325350598601;50169.24746128884;58854.70572647281;60135;61990;62586.374136259874;88109;89753.65369519593;90159.54920225356;92632;95853.49758029082;11657.591984280509;11832.645020649394;11839.230450020721;11960.820587691365;12405.193662411913;12717.87282127204;12981.221126732426;13017.934910325388;13380.264085475003;13515.391807368494;12316.322602256962;12337.198082124632;12340.3212823292;12459.93770031144;12581.496740130293;12183.147179697336;12205.572804951784;12322.691932701755;12327.69180770488;12472.812907806208;11873.762524749629;12081.335526546125;12108.878911210775;12416.875831241934;12614.243145411305;10322.587096516356;10551.472426378803;10556.313839600401;10661.466926653791;10851;10155.593776248867;10604.522796474022;10609.416482093558;10612.946935265274;10640.733981650521 11:10:22 INFO - PROCESS | 1657 | __end_tp_report 11:10:22 INFO - PROCESS | 1657 | __start_cc_report 11:10:22 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1383 11:10:22 INFO - PROCESS | 1657 | __end_cc_report 11:10:22 INFO - PROCESS | 1657 | __startTimestamp1468347022943__endTimestamp 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | ------- Summary: start ------- 11:10:22 INFO - PROCESS | 1657 | Number of tests: 6 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5717.87 Median:5933.73 stddev:654.76 (11.0%) stddev-sans-first:629.86 11:10:22 INFO - PROCESS | 1657 | Values: 3350.0 3364.9 3380.2 3390.0 3431.8 4608.4 5606.3 5711.1 5733.2 5783.9 5611.6 5700.3 5718.9 5732.4 5740.7 5077.8 5080.9 5144.9 5184.6 5279.2 5252.1 5264.7 5280.4 5286.5 5315.5 5101.8 5141.2 5159.8 5181.9 5203.9 5143.8 5151.4 5176.0 5193.4 5244.7 5095.4 5139.9 5169.7 5229.8 5239.1 5635.1 5703.2 5723.3 5765.5 5834.3 6220.0 6258.8 6277.6 6289.2 6316.4 5815.2 6348.7 6359.6 6366.8 6386.8 5640.0 5697.5 5704.1 5881.4 5886.3 6350.3 6357.8 6367.0 6372.9 6373.7 6047.8 6070.5 6071.1 6084.0 6087.6 6258.6 6280.7 6304.6 6310.4 6318.3 6210.1 6235.2 6243.5 6246.2 6247.4 6088.2 6092.4 6105.1 6122.0 6261.7 4654.3 4680.4 4886.6 4917.4 4935.5 4345.4 4409.9 4421.6 4428.5 4466.5 5712.7 5719.1 5756.5 5759.2 5814.9 6133.6 6144.6 6154.0 6208.7 6221.4 5717.5 5739.1 5743.7 5755.7 5776.3 5280.0 5374.8 5384.3 5403.7 5410.4 6239.6 6255.0 6256.5 6308.7 6312.8 6240.6 6291.1 6294.4 6298.4 6303.0 6264.7 6287.8 6298.2 6299.4 6308.0 5341.1 5638.7 6071.9 6103.6 6152.1 5170.7 6292.4 6296.0 6299.7 6315.2 5959.2 6070.6 6082.1 6127.2 6141.7 6055.3 6108.1 6126.7 6126.9 6134.0 4912.9 5933.7 5943.1 5962.9 6041.5 5976.0 6020.0 6144.7 6151.1 6154.8 5844.7 5927.5 5941.0 6017.0 6031.4 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:52282.47 Median:40998.40 stddev:99471.88 (242.6%) stddev-sans-first:99674.95 11:10:22 INFO - PROCESS | 1657 | Values: 503.1 509.2 510.0 527.8 566.9 29968.9 41478.6 42553.1 42616.9 44881.3 43128.1 43441.8 43486.1 43560.3 43580.6 9620.1 9837.2 9837.6 9844.7 9845.3 9637.2 9749.8 9758.0 9782.2 9788.1 9734.3 9776.1 9821.3 9823.9 9825.3 9741.2 9774.2 9791.2 9795.1 9807.2 9679.2 9699.9 9761.6 9761.7 9763.5 40708.0 40986.8 41048.4 41109.6 41190.4 3423.3 3943.2 4084.9 4142.0 4329.5 25930.7 32201.7 32852.7 32903.0 32927.3 2950.4 3160.8 3287.0 3364.9 3426.4 463638.0 464178.7 464628.0 465464.0 468780.2 57348.7 57417.4 57827.7 57840.8 57887.0 59934.0 60207.4 60239.0 60379.0 60537.1 16023.8 16230.8 16264.0 16271.4 16276.4 11011.3 12695.5 12720.9 12727.1 12757.5 14757.8 15220.9 15233.5 15238.5 15436.8 6204.7 6293.7 6376.4 6397.8 6398.5 942.5 995.7 1061.6 1090.9 1090.9 30262.0 30413.4 30599.1 30893.8 31880.5 1042.4 1065.8 1085.1 1106.9 1113.7 14052.2 14997.7 15801.8 15812.9 16303.3 144203.0 158721.0 162256.0 162831.0 162967.2 60255.1 60614.1 60617.4 60687.7 60726.4 1293.3 1329.9 1399.7 1427.0 1458.6 29371.4 30567.5 30576.4 31020.4 31393.2 48944.8 49527.5 49583.8 49584.0 49738.8 404497.0 412043.0 429740.9 430812.0 431721.0 34593.3 35427.8 39045.0 39314.8 41490.0 48361.0 48362.8 48777.0 49730.5 49897.0 40129.4 40602.4 40945.8 41010.0 41704.8 34576.0 37360.3 37941.8 40164.6 41020.8 38407.8 39132.4 39246.0 39279.8 39328.0 34300.4 34718.7 34973.5 35074.5 35628.5 24546.3 25741.4 25841.2 26041.9 26225.2 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:31755.83 Median:12226.47 stddev:83290.59 (681.2%) stddev-sans-first:83490.83 11:10:22 INFO - PROCESS | 1657 | Values: 335.4 358.2 388.8 393.8 411.1 14866.8 15161.2 20880.4 21953.8 22229.9 20539.4 21385.5 21415.6 21549.9 21935.0 5390.1 5572.8 5614.4 5628.5 5634.7 3846.0 3849.9 5515.4 5951.1 6183.9 6159.2 6199.2 6199.2 6204.2 6210.5 5923.8 6178.6 6187.1 6196.7 6202.3 3114.6 4626.7 5930.6 5945.1 6037.1 13542.7 13580.8 13712.2 13715.0 13764.4 2150.8 2223.1 2277.2 2358.7 2902.4 10216.5 10639.9 10718.2 10723.4 13668.9 1926.6 1950.4 1963.8 2068.8 2157.0 113374.0 117106.4 120031.0 120923.0 120951.0 8372.1 9335.5 9473.4 10466.0 10604.8 13525.9 13816.0 13817.7 13831.3 13850.4 7393.0 7440.3 8232.5 8814.0 8891.1 8729.7 8742.4 8769.0 8824.9 8923.2 4582.7 4584.8 4587.7 4613.2 4688.4 1885.9 1919.8 1920.9 1951.5 1965.2 873.3 958.0 966.1 973.6 984.6 20959.7 21812.8 21858.9 21886.9 21908.7 854.5 930.4 987.5 1021.9 1023.1 11293.8 11413.1 11557.1 11593.4 11636.7 456497.0 457082.0 461042.0 541186.8 542219.0 95032.0 117710.4 120402.4 120505.4 127821.0 938.4 958.1 979.9 983.7 994.5 18985.0 19048.5 19111.8 19216.7 19334.0 54176.0 54427.6 55416.7 55497.7 56444.7 74068.3 81377.0 83452.2 84911.6 91520.1 7879.7 8344.6 8352.5 8448.7 8593.5 12294.3 13453.5 13468.0 13647.3 13716.7 11453.5 11593.6 11671.2 11843.6 11897.9 10134.7 10896.6 11162.3 11537.9 11548.1 11802.6 11933.9 11947.3 11992.9 12141.0 8333.3 8388.2 8580.4 12288.8 12620.0 11252.0 11620.8 12205.5 12307.9 12355.8 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5669.48 Median:4929.92 stddev:3190.20 (64.7%) stddev-sans-first:3182.99 11:10:22 INFO - PROCESS | 1657 | Values: 1397.0 1422.4 1553.7 1760.5 1773.7 7445.9 8499.6 8771.4 8774.5 8881.1 8542.8 8665.1 8793.5 8794.6 8796.9 2351.0 2383.4 2386.1 2389.0 2389.6 2343.5 2375.9 2386.6 2388.2 2388.8 2342.0 2362.7 2368.5 2379.8 2380.4 2330.4 2355.8 2361.0 2362.4 2366.5 2323.0 2353.1 2355.2 2357.4 2357.9 8640.1 8683.8 8839.3 8845.9 8848.4 5229.8 5379.1 5389.8 5391.1 5396.8 3572.1 3575.0 3645.5 3649.9 3652.0 1089.4 1091.9 1099.5 1113.4 1113.8 11444.2 11524.9 11537.4 11565.6 11580.6 4322.3 4396.5 4530.0 4534.0 4627.7 9179.6 9181.8 9186.3 9212.8 9225.0 4598.9 5212.3 5260.0 5261.9 5264.1 4366.0 4523.6 4694.9 4898.1 4922.6 3303.8 3747.9 3769.7 3847.6 3878.4 1003.3 1141.6 1144.5 1149.4 1150.3 661.6 840.2 942.1 972.2 974.1 5873.8 5957.8 6079.7 6126.3 6127.6 471.8 475.7 490.4 505.5 654.2 3950.6 4111.2 4159.6 4203.5 4233.3 10264.5 10657.5 10777.2 10783.2 10785.6 10722.5 10727.6 10727.8 10738.9 10741.4 7899.5 8325.9 8342.9 8348.8 8355.3 5389.8 5761.2 5787.2 5944.6 6040.9 9963.0 10084.4 10105.8 10107.4 10107.5 9926.8 9938.1 10102.0 10298.0 10306.6 7059.5 7080.2 7173.1 7173.2 7185.7 7920.7 8293.5 8394.8 8433.6 8435.1 7491.4 7497.2 7505.6 7610.4 7697.0 6492.2 7325.8 7416.3 7472.4 7564.3 7060.5 7130.4 7147.4 7154.3 7171.4 4937.3 5062.7 5086.2 5139.2 5144.9 5116.1 5140.9 5147.1 5237.5 5289.6 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4314.23 Median:4724.42 stddev:1359.58 (28.8%) stddev-sans-first:1329.00 11:10:22 INFO - PROCESS | 1657 | Values: 265.3 295.2 310.0 314.6 315.1 4445.3 4485.4 5082.9 5249.5 5264.9 5091.3 5153.6 5166.4 5166.8 5183.6 3272.9 3846.8 3969.8 3982.2 4038.2 3448.1 3940.0 4001.4 4014.8 4028.9 3461.3 3478.9 3807.5 3850.6 4019.5 3289.9 3411.7 3890.5 3966.8 3974.6 3446.2 3452.2 3464.9 3471.9 3485.4 5064.1 5075.9 5086.7 5170.2 5183.3 3837.1 4328.4 4612.5 4621.0 4632.0 5470.8 5489.2 5497.4 5530.2 5536.1 3725.3 3827.4 3830.3 3853.6 3871.8 4749.5 5384.6 5454.6 5524.8 5822.8 3074.7 3372.9 3969.6 4039.0 4052.6 4065.4 4104.5 4105.6 4138.5 4139.3 3623.8 4458.0 4671.2 4671.9 4728.6 4588.0 5519.6 5539.1 5565.2 5593.0 1204.8 1343.8 1345.2 1386.6 1392.8 749.9 810.3 840.8 847.9 856.8 3614.8 3654.7 3892.8 4264.3 4276.9 4140.5 4253.3 4597.6 4636.0 4720.2 3682.9 3827.4 4060.8 4256.0 4366.3 2002.0 2212.0 2408.9 2463.9 2467.8 4212.7 4511.8 4740.6 4817.8 4829.1 4336.4 4752.0 4782.5 4846.9 4909.3 4759.6 4833.7 5268.9 5290.4 5931.4 5511.8 5756.6 5806.0 5814.7 5818.4 5433.9 5667.5 5694.9 5696.3 5792.6 4860.4 5438.8 5700.3 5837.7 6021.6 3218.5 3366.3 3384.4 3820.4 3891.7 4884.9 5109.5 5328.3 5733.8 5899.7 4510.9 5449.0 5479.2 5514.2 5645.2 5524.0 5643.5 5644.5 5647.4 5659.0 4881.9 4964.2 5262.4 5467.5 5539.4 5360.2 5481.6 5503.7 5517.8 5664.0 5395.9 5419.3 5465.8 5501.0 5523.3 11:10:22 INFO - PROCESS | 1657 | 11:10:22 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24821.27 Median:3349.47 stddev:40185.76 (1199.8%) stddev-sans-first:40257.76 11:10:22 INFO - PROCESS | 1657 | Values: 723.9 767.6 805.6 823.3 832.9 13809.7 17500.7 17515.8 17518.7 17549.6 16485.8 16595.8 16728.9 16750.8 16752.9 698.3 715.7 871.3 880.3 908.3 897.3 904.7 906.7 907.7 907.9 950.9 951.0 952.5 954.2 954.4 737.2 911.4 940.7 944.4 947.4 696.0 696.3 696.7 696.9 697.0 15045.7 15085.4 15093.1 15093.2 15098.2 13384.4 13533.9 13560.5 13582.7 13708.6 11551.4 11999.1 12801.5 12846.5 13004.9 4549.5 4553.7 4614.3 4776.0 4789.3 108138.5 108568.5 108918.0 109747.5 110181.4 10623.2 10631.4 10765.8 10854.2 10891.7 20212.5 20262.0 20282.9 20329.6 20336.9 7698.4 7729.8 7781.4 7902.8 8001.8 3784.1 4313.4 4374.0 4407.7 4556.9 3195.1 3312.2 3386.8 3427.2 3434.8 544.7 603.4 632.7 641.2 642.2 556.4 566.6 617.5 662.1 692.2 9332.9 9416.3 9592.8 9594.2 9649.8 617.8 621.2 621.4 628.0 693.8 4275.4 4340.4 4594.8 4622.6 4656.7 150000.0 151958.5 155103.0 155327.0 157488.2 120748.0 130452.5 131569.0 132602.0 133997.3 89744.0 115161.4 117757.0 118550.4 119763.0 7319.9 8950.6 8961.8 8993.7 8995.3 50169.2 58854.7 60135.0 61990.0 62586.4 88109.0 89753.7 90159.5 92632.0 95853.5 11657.6 11832.6 11839.2 11960.8 12405.2 12717.9 12981.2 13017.9 13380.3 13515.4 12316.3 12337.2 12340.3 12459.9 12581.5 12183.1 12205.6 12322.7 12327.7 12472.8 11873.8 12081.3 12108.9 12416.9 12614.2 10322.6 10551.5 10556.3 10661.5 10851.0 10155.6 10604.5 10609.4 10612.9 10640.7 11:10:22 INFO - PROCESS | 1657 | -------- Summary: end -------- 11:10:22 INFO - PROCESS | 1657 | 11:10:23 INFO - TEST-INFO | 1657: exit 0 11:10:23 INFO - TEST-OK | dromaeo_css | took 1115532ms 11:10:23 INFO - TEST-START | kraken 11:10:23 INFO - operating with platform_type : mac_ 11:10:23 INFO - Initialising browser for kraken test... 11:10:23 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmp1oMNIn/profile http://localhost:49266/getInfo.html) 11:10:25 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 11:10:25 INFO - PROCESS | 1664 | colorDepth:24 11:10:25 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 11:10:25 INFO - PROCESS | 1664 | __metrics 11:10:25 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:10:25 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:10:26 INFO - TEST-INFO | 1664: exit 0 11:10:26 INFO - Browser initialized. 11:10:26 INFO - Running cycle 1/1 for kraken test... 11:10:26 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmp1oMNIn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:38 INFO - PROCESS | 1665 | RSS: Main: 243957760 11:10:38 INFO - PROCESS | 1665 | 11:10:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:42 INFO - PROCESS | 1665 | RSS: Main: 293896192 11:10:42 INFO - PROCESS | 1665 | 11:10:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 11:10:45 INFO - PROCESS | 1665 | RSS: Main: 304615424 11:10:45 INFO - PROCESS | 1665 | 11:10:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 11:10:49 INFO - PROCESS | 1665 | RSS: Main: 392589312 11:10:49 INFO - PROCESS | 1665 | 11:10:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 11:10:52 INFO - PROCESS | 1665 | RSS: Main: 293093376 11:10:52 INFO - PROCESS | 1665 | 11:10:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:54 INFO - PROCESS | 1665 | RSS: Main: 297058304 11:10:54 INFO - PROCESS | 1665 | 11:10:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:58 INFO - PROCESS | 1665 | RSS: Main: 334086144 11:10:58 INFO - PROCESS | 1665 | 11:11:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:01 INFO - PROCESS | 1665 | RSS: Main: 335527936 11:11:01 INFO - PROCESS | 1665 | 11:11:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 11:11:05 INFO - PROCESS | 1665 | RSS: Main: 333271040 11:11:05 INFO - PROCESS | 1665 | 11:11:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:07 INFO - PROCESS | 1665 | RSS: Main: 312115200 11:11:07 INFO - PROCESS | 1665 | 11:11:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:10 INFO - PROCESS | 1665 | RSS: Main: 319488000 11:11:10 INFO - PROCESS | 1665 | 11:11:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:13 INFO - PROCESS | 1665 | RSS: Main: 316026880 11:11:13 INFO - PROCESS | 1665 | 11:11:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:16 INFO - PROCESS | 1665 | RSS: Main: 325058560 11:11:16 INFO - PROCESS | 1665 | 11:11:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:19 INFO - PROCESS | 1665 | RSS: Main: 326512640 11:11:19 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 11:11:21 INFO - PROCESS | 1665 | RSS: Main: 369938432 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | __start_tp_report 11:11:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 11:11:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 11:11:21 INFO - PROCESS | 1665 | |i|pagename|runs| 11:11:21 INFO - PROCESS | 1665 | |0;ai-astar;103;113;124;164;148;113;113;112;112;112 11:11:21 INFO - PROCESS | 1665 | |1;audio-beat-detection;143;110;105;161;109;134;152;105;160;107 11:11:21 INFO - PROCESS | 1665 | |2;audio-dft;189;257;226;184;185;183;183;182;183;182 11:11:21 INFO - PROCESS | 1665 | |3;audio-fft;78;73;70;95;48;78;85;90;92;58 11:11:21 INFO - PROCESS | 1665 | |4;audio-oscillator;82;95;92;72;70;68;95;69;67;100 11:11:21 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;93;86;91;89;89;85;90;86;91;87 11:11:21 INFO - PROCESS | 1665 | |6;imaging-darkroom;95;95;96;101;94;91;136;131;96;95 11:11:21 INFO - PROCESS | 1665 | |7;imaging-desaturate;87;84;85;84;84;105;144;143;85;87 11:11:21 INFO - PROCESS | 1665 | |8;json-parse-financial;56;53;54;55;57;54;55;54;55;56 11:11:21 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;62;65;83;78;72;70;70;69;70;71 11:11:21 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;84;84;82;85;83;78;81;83;86;86 11:11:21 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;137;138;137;157;148;132;137;137;183;138 11:11:21 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;164;166;164;170;161;163;163;162;161;167 11:11:21 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;66;64;67;67;65;66;66;65;65;66 11:11:21 INFO - PROCESS | 1665 | __end_tp_report 11:11:21 INFO - PROCESS | 1665 | __start_cc_report 11:11:21 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2024 11:11:21 INFO - PROCESS | 1665 | __end_cc_report 11:11:21 INFO - PROCESS | 1665 | __startTimestamp1468347081783__endTimestamp 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | ------- Summary: start ------- 11:11:21 INFO - PROCESS | 1665 | Number of tests: 14 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:121.40 Median:113.00 stddev:19.28 (17.1%) stddev-sans-first:19.26 11:11:21 INFO - PROCESS | 1665 | Values: 103.0 113.0 124.0 164.0 148.0 113.0 113.0 112.0 112.0 112.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:138.50 stddev:23.88 (17.2%) stddev-sans-first:24.75 11:11:21 INFO - PROCESS | 1665 | Values: 143.0 110.0 105.0 161.0 109.0 134.0 152.0 105.0 160.0 107.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:195.40 Median:184.50 stddev:25.45 (13.8%) stddev-sans-first:26.89 11:11:21 INFO - PROCESS | 1665 | Values: 189.0 257.0 226.0 184.0 185.0 183.0 183.0 182.0 183.0 182.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:76.70 Median:81.50 stddev:15.09 (18.5%) stddev-sans-first:16.00 11:11:21 INFO - PROCESS | 1665 | Values: 78.0 73.0 70.0 95.0 48.0 78.0 85.0 90.0 92.0 58.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:77.00 stddev:13.27 (17.2%) stddev-sans-first:14.08 11:11:21 INFO - PROCESS | 1665 | Values: 82.0 95.0 92.0 72.0 70.0 68.0 95.0 69.0 67.0 100.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.50 stddev:2.63 (2.9%) stddev-sans-first:2.28 11:11:21 INFO - PROCESS | 1665 | Values: 93.0 86.0 91.0 89.0 89.0 85.0 90.0 86.0 91.0 87.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:95.00 stddev:16.30 (17.2%) stddev-sans-first:17.03 11:11:21 INFO - PROCESS | 1665 | Values: 95.0 95.0 96.0 101.0 94.0 91.0 136.0 131.0 96.0 95.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:84.50 stddev:24.38 (28.9%) stddev-sans-first:25.49 11:11:21 INFO - PROCESS | 1665 | Values: 87.0 84.0 85.0 84.0 84.0 105.0 144.0 143.0 85.0 87.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:1.20 11:11:21 INFO - PROCESS | 1665 | Values: 56.0 53.0 54.0 55.0 57.0 54.0 55.0 54.0 55.0 56.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:70.50 stddev:5.94 (8.4%) stddev-sans-first:5.34 11:11:21 INFO - PROCESS | 1665 | Values: 62.0 65.0 83.0 78.0 72.0 70.0 70.0 69.0 70.0 71.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:2.44 (2.9%) stddev-sans-first:2.57 11:11:21 INFO - PROCESS | 1665 | Values: 84.0 84.0 82.0 85.0 83.0 78.0 81.0 83.0 86.0 86.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:138.00 stddev:15.33 (11.1%) stddev-sans-first:16.03 11:11:21 INFO - PROCESS | 1665 | Values: 137.0 138.0 137.0 157.0 148.0 132.0 137.0 137.0 183.0 138.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:2.85 (1.7%) stddev-sans-first:3.02 11:11:21 INFO - PROCESS | 1665 | Values: 164.0 166.0 164.0 170.0 161.0 163.0 163.0 162.0 161.0 167.0 11:11:21 INFO - PROCESS | 1665 | 11:11:21 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 11:11:21 INFO - PROCESS | 1665 | Values: 66.0 64.0 67.0 67.0 65.0 66.0 66.0 65.0 65.0 66.0 11:11:21 INFO - PROCESS | 1665 | -------- Summary: end -------- 11:11:21 INFO - PROCESS | 1665 | 11:11:22 INFO - TEST-INFO | 1665: exit 0 11:11:22 INFO - TEST-OK | kraken | took 59061ms 11:11:22 INFO - SUITE-END | took 1174s 11:11:22 INFO - Completed test suite (00:19:34) 11:11:22 INFO - javascript benchmark 11:11:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.9665003349965, 3364.8990530284086, 3380.171857894816, 3390.016895100421, 3431.828408579572, 4608.377868987685, 5606.299212598426, 5711.143328500727, 5733.168690539875, 5783.913241301373, 5611.579131565129, 5700.344460387047, 5718.9428105719035, 5732.369439361677, 5740.655560666363, 5077.771500282496, 5080.898382032357, 5144.8971020579565, 5184.611154163434, 5279.1817268323475, 5252.080885844981, 5264.736763161845, 5280.445553216895, 5286.497782710656, 5315.548178404821, 5101.770420331094, 5141.2288156776785, 5159.767810448501, 5181.922271165936, 5203.9219411708855, 5143.8456846294675, 5151.4333423323405, 5176.0, 5193.350831146106, 5244.711540865251, 5095.439501654815, 5139.922901156486, 5169.715665638389, 5229.816956406507, 5239.083160446907, 5635.126555383922, 5703.201551782754, 5723.313202415737, 5765.452282033242, 5834.27071616048, 6220.004799232146, 6258.780942666985, 6277.560570760049, 6289.182406287199, 6316.399942005502, 5815.156802263648, 6348.650824204667, 6359.586626869239, 6366.77716279928, 6386.776462823779, 5640.0, 5697.4587414195585, 5704.1443783432815, 5881.411858814085, 5886.293644762613, 6350.301466838644, 6357.841053973688, 6366.9681651591445, 6372.872542549123, 6373.71318290678, 6047.788327408608, 6070.453659170696, 6071.057614416239, 6084.04871231781, 6087.569421186018, 6258.624482530971, 6280.717367718464, 6304.5586808922935, 6310.432061114522, 6318.336574659595, 6210.099535567318, 6235.158253635792, 6243.500519958392, 6246.15676883624, 6247.375262473716, 6088.238970128734, 6092.372385476703, 6105.084237364342, 6121.981350123568, 6261.686915654199, 4654.301854721819, 4680.3915490985955, 4886.60907127429, 4917.360743103373, 4935.531124543163, 4345.3699213613845, 4409.911801763947, 4421.557844215553, 4428.490723566767, 4466.486354069324, 5712.714364281769, 5719.056355701346, 5756.539476841843, 5759.1937128802, 5814.941850581525, 6133.570650054453, 6144.648177401054, 6153.969230153821, 6208.72060757267, 6221.4089661482085, 5717.4854263115685, 5739.110437882135, 5743.655380677173, 5755.740991655385, 5776.306843178845, 5280.023195708806, 5374.811881584125, 5384.300040994645, 5403.70279634616, 5410.377806552218, 6239.594426362272, 6255.0, 6256.468200203034, 6308.7476500940365, 6312.842178945563, 6240.625562466266, 6291.087792270187, 6294.433500984934, 6298.401651843067, 6302.968485157545, 6264.718087686157, 6287.842803929939, 6298.244210694746, 6299.433051025429, 6308.0, 5341.092014357646, 5638.746256418389, 6071.878562428815, 6103.640733310809, 6152.138700582012, 5170.741462926914, 6292.433680968735, 6295.968520157553, 6299.653519056313, 6315.242170939517, 5959.22530071088, 6070.605410648293, 6082.118092876596, 6127.234095738033, 6141.723622437091, 6055.273367195965, 6108.08378743192, 6126.693665316806, 6126.908096378647, 6133.987891997949, 4912.852614421573, 5933.732982015733, 5943.108533719804, 5962.850928726816, 6041.486473649789, 5975.984082705863, 6019.969900150471, 6144.692765361625, 6151.108089326933, 6154.815355539341, 5844.707764611668, 5927.4665280125, 5941.049432090845, 6016.969915150396, 6031.4270144336215], "value": 5676.3683721943125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.1446540880502, 509.2386881611989, 509.9872503187422, 527.7836087204246, 566.8724536979178, 29968.850155749216, 41478.58521414789, 42553.148937021244, 42616.9345766356, 44881.32678009832, 43128.13743725124, 43441.78279108608, 43486.08625223729, 43560.3465948011, 43580.56419435813, 9620.134187923102, 9837.213022958145, 9837.606495740198, 9844.704658860246, 9845.310828242025, 9637.229021678284, 9749.756256093584, 9758.0, 9782.16851567614, 9788.119069283763, 9734.269929755297, 9776.071273229032, 9821.312508124434, 9823.90176098237, 9825.263105267099, 9741.17200037994, 9774.21806255505, 9791.167750741195, 9795.06946840049, 9807.215422766161, 9679.177269932065, 9699.854502182472, 9761.609535618567, 9761.65834195807, 9763.511824408823, 40707.98230044243, 40986.79506602478, 41048.38427423591, 41109.588904110875, 41190.38214426786, 3423.3495635829363, 3943.191645712622, 4084.8570300039655, 4142.026623743418, 4329.5453977332245, 25930.74069259321, 32201.677983220103, 32852.6714732852, 32903.01290961275, 32927.341453171044, 2950.3509227970026, 3160.8146944895666, 3287.0, 3364.9158771030675, 3426.43463828468, 463638.0, 464178.6791066023, 464628.0, 465464.0, 468780.185387023, 57348.71325643345, 57417.425825742044, 57827.71086144543, 57840.8431831361, 57887.0, 59934.0, 60207.397926021054, 60239.0, 60379.0, 60537.09194362088, 16023.759643605355, 16230.756538651929, 16264.0, 16271.430499932445, 16276.43032493857, 11011.28426652281, 12695.492180312684, 12720.872791272153, 12727.10910236293, 12757.489700412065, 14757.77863332051, 15220.934534582473, 15233.466828660943, 15238.542843714706, 15436.845631543541, 6204.658743769046, 6293.716782744787, 6376.39424254695, 6397.776077837253, 6398.520110991694, 942.5428667096453, 995.6963126246565, 1061.6443491430457, 1090.8527348807968, 1090.9018188362927, 30262.0, 30413.391732165233, 30599.059027795138, 30893.84553077265, 31880.521792173135, 1042.3902017319801, 1065.7868426314767, 1085.0993675249524, 1106.9446527673583, 1113.693734223079, 14052.156870587798, 14997.65021148102, 15801.762973555406, 15812.92093539525, 16303.347866085462, 144203.0, 158721.0, 162256.0, 162831.0, 162967.18516407342, 60255.09617355743, 60614.060086094265, 60617.393826061176, 60687.69656151779, 60726.39273607208, 1293.2886912198253, 1329.860364661716, 1399.671077296814, 1426.9643258918402, 1458.6061763324055, 29371.41257174887, 30567.54148687727, 30576.388472229984, 31020.379592407575, 31393.215169620944, 48944.75527622339, 49527.50472495373, 49583.760405988694, 49584.0, 49738.75130624323, 404497.0, 412043.0, 429740.851295754, 430812.0, 431721.0, 34593.30813383769, 35427.82286088553, 39045.0, 39314.80342598269, 41490.0, 48361.0, 48362.75818620884, 48777.0, 49730.502694974035, 49897.0, 40129.39805902972, 40602.39096413497, 40945.79527102345, 41010.0, 41704.791476042425, 34576.0, 37360.25279494449, 37941.81029094837, 40164.59835401725, 41020.79489602533, 38407.80796096002, 39132.413013804246, 39246.0, 39279.80360098295, 39328.0167995791, 34300.39588915108, 34718.65281347154, 34973.47539786854, 35074.473882892285, 35628.46557301695, 24546.263612091665, 25741.3564660885, 25841.22476325713, 26041.869790650926, 26225.213243602724], "value": 19311.25257973078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.3594634248586, 358.21372088266236, 388.80948335315696, 393.8090026337228, 411.138664497877, 14866.77699834502, 15161.241937903116, 20880.37358879232, 21953.792541410217, 22229.888850555726, 20539.383818485432, 21385.465363365925, 21415.57168856626, 21549.892250538764, 21935.0, 5390.110631745767, 5572.832815015556, 5614.3543492498475, 5628.493435590796, 5634.746436410351, 3846.0, 3849.9037524061982, 5515.365732940703, 5951.137085122655, 6183.9381606183815, 6159.199304090462, 6199.225096862892, 6199.225096862892, 6204.193454850863, 6210.472109870644, 5923.792667256647, 6178.598391104564, 6187.133801267826, 6196.659183744915, 6202.286737025254, 3114.6418161911215, 4626.653001024936, 5930.55520835939, 5945.108233764927, 6037.094435834616, 13542.661433464144, 13580.796288055688, 13712.17726936387, 13715.0, 13764.449422023106, 2150.7849215078522, 2223.055201539339, 2277.2485079923586, 2358.705161854768, 2902.4050069735654, 10216.540255688511, 10639.946800265949, 10718.196135289885, 10723.410212438313, 13668.93165534166, 1926.566522532419, 1950.3758797184908, 1963.8330741886957, 2068.844836637258, 2156.989215053915, 113374.0, 117106.41446792711, 120031.0, 120923.0, 120951.0, 8372.120927302545, 9335.486548239776, 9473.431594104239, 10466.0, 10604.840927386096, 13525.932370338282, 13815.963802714836, 13817.654558635913, 13831.30843457823, 13850.376733047036, 7392.96303518479, 7440.330370266702, 8232.50604963692, 8813.986391564924, 8891.110888911056, 8729.738107856774, 8742.431741936754, 8769.0, 8824.911750882537, 8923.241524470493, 4582.702124361906, 4584.816607335736, 4587.72473651582, 4613.215753321943, 4688.437387513521, 1885.8774179678278, 1919.8272155506072, 1920.9423717288503, 1951.5121219695077, 1965.213914434209, 873.3275377958936, 957.9568919398644, 966.0629189685993, 973.5764942250144, 984.640606178754, 20959.68560471594, 21812.781872181393, 21858.89070554637, 21886.89056554707, 21908.671369929463, 854.5001174313096, 930.3766476460787, 987.4519641598981, 1021.918246540275, 1023.0638965346773, 11293.774124517464, 11413.144014198968, 11557.075433965263, 11593.420328983517, 11636.709082273012, 456497.0, 457082.0, 461042.0, 541186.8228565131, 542219.0, 95032.0, 117710.41144794221, 120402.3979880095, 120505.39747301207, 127821.0, 938.4228699349851, 958.1376760915232, 979.9314048016713, 983.7294743945472, 994.5325696922434, 18985.0, 19048.523786904883, 19111.80888191156, 19216.71174932349, 19334.0, 54176.0, 54427.63930901759, 55416.722916386774, 55497.72251138718, 56444.71777641086, 74068.25931740613, 81377.0, 83452.16547834687, 84911.5754421224, 91520.08479915382, 7879.684812607661, 8344.624491897757, 8352.498850069016, 8448.704295349633, 8593.52735599548, 12294.262344259372, 13453.529126480526, 13468.0, 13647.317634118453, 13716.725665486834, 11453.541858325574, 11593.594224202112, 11671.241369310968, 11843.58547450835, 11897.94051029774, 10134.746631334276, 10896.564137434414, 11162.330260184415, 11537.88462115368, 11548.133889958119, 11802.586909458129, 11933.940330298641, 11947.342896140795, 11992.940035299767, 12141.0, 8333.250007499355, 8388.161183881562, 8580.442271252348, 12288.815667764811, 12620.0, 11252.043576296106, 11620.767674351626, 12205.511779528719, 12307.87692123103, 12355.814662779885], "value": 9474.632058600162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.0011441819097, 1422.4168091082654, 1553.7358649029663, 1760.542259012657, 1773.6541374431984, 7445.888311675322, 8499.617517211725, 8771.386002979794, 8774.47353158811, 8881.067487913773, 8542.786430339245, 8665.133486651332, 8793.516356600385, 8794.560271986407, 8796.91203087969, 2350.9529809403844, 2383.4398916254668, 2386.0813586769045, 2389.0, 2389.6415537669313, 2343.5078633486987, 2375.9168429104984, 2386.558486679961, 2388.22382725614, 2388.8208384371155, 2341.988290058547, 2362.728286247078, 2368.490774483486, 2379.7501262367464, 2380.4286971126976, 2330.370799884022, 2355.846869953456, 2360.9527809443716, 2362.373970897722, 2366.455715185517, 2323.0, 2353.1411034972284, 2355.187460326185, 2357.39886328985, 2357.9174728884577, 8640.13598640131, 8683.826323473559, 8839.29285657146, 8845.911540884574, 8848.380613357067, 5229.816956406507, 5379.112446446332, 5389.757460914268, 5391.083515802323, 5396.757145928443, 3572.1248294167835, 3575.0, 3645.54430696163, 3649.8540058397634, 3651.9817400912825, 1089.3953855610134, 1091.9290246133976, 1099.4612639806517, 1113.4098927568402, 1113.8273567597034, 11444.198906076577, 11524.94237528807, 11537.365444900528, 11565.595204167814, 11580.594679186188, 4322.265214913472, 4396.472423309159, 4530.048689775184, 4534.047849951481, 4627.745473998895, 9179.58691858868, 9181.81636367269, 9186.26509879208, 9212.769680758034, 9225.0, 4598.896264896401, 5212.270282160501, 5260.026895024433, 5261.868453288698, 5264.078786212397, 4365.956340436618, 4523.592876641118, 4694.882627934329, 4898.069366820364, 4922.581580565692, 3303.801771893694, 3747.9437808432895, 3769.7361184717356, 3847.5960024197057, 3878.437626544135, 1003.3428104591504, 1141.57191053355, 1144.5135817277624, 1149.413798962535, 1150.26957881744, 661.6195687479718, 840.2269911681268, 942.1285311087354, 972.1785091597588, 974.0647782956917, 5873.794417195378, 5957.79147729836, 6079.726412311456, 6126.264848218153, 6127.632342059491, 471.76647559457604, 475.7050628610215, 490.4066080043188, 505.5222814440319, 654.188805880714, 3950.58518855516, 4111.218868414991, 4159.604837540429, 4203.495580530294, 4233.343831706091, 10264.486775661187, 10657.520411581498, 10777.245592808427, 10783.191260655482, 10785.56857725698, 10722.463876806129, 10727.570897164025, 10727.83908241377, 10738.946305268424, 10741.409222492837, 7899.526028438312, 8325.916740832636, 8342.916570834335, 8348.833023339621, 8355.331573474108, 5389.83830485086, 5761.193432919478, 5787.189793429007, 5944.554158438048, 6040.909386359121, 9963.0, 10084.445355505517, 10105.797884042426, 10107.444090575089, 10107.54516046765, 9926.751831203988, 9938.10557049869, 10102.0, 10298.0, 10306.587736490756, 7059.541129826544, 7080.221175670775, 7173.10336207974, 7173.210946795953, 7185.676644550903, 7920.683172673029, 8293.543855088028, 8394.832103357776, 8433.578321083798, 8435.072142064246, 7491.3632341251605, 7497.175310715926, 7505.587192704454, 7610.429217808797, 7697.0378702662165, 6492.156019717407, 7325.816854578465, 7416.25837416254, 7472.439567032603, 7564.319211271012, 7060.505764596429, 7130.358267755927, 7147.392471639969, 7154.284571542804, 7171.390431813145, 4937.259411088366, 5062.721550314768, 5086.237064440364, 5139.177731562932, 5144.871378215575, 5116.130257856099, 5140.871478212925, 5147.099257629975, 5237.502437268454, 5289.57683385336], "value": 4487.31080377989, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.3168092162681, 295.2235620318562, 309.9628044634644, 314.58631899052745, 315.1255266635089, 4445.333200019994, 4485.439320084989, 5082.949170508294, 5249.501297376743, 5264.921026184601, 5091.287219789223, 5153.587712982961, 5166.43169251382, 5166.844994650157, 5183.585313174937, 3272.8527216275206, 3846.8461261549573, 3969.7816620085882, 3982.1637456134245, 4038.2327357801923, 3448.069021364243, 3939.9803000984957, 4001.359782434811, 4014.7992600369867, 4028.919421611566, 3461.3250416168858, 3478.9478157827652, 3807.505024346831, 3850.614938506155, 4019.537753158395, 3289.851956661956, 3411.6630108375844, 3890.533136023667, 3966.801659917007, 3974.582668819776, 3446.2418267981, 3452.2405070884365, 3464.9133771655656, 3471.89584312471, 3485.4074807282823, 5064.050040968051, 5075.949240507584, 5086.719066202316, 5170.1727723564045, 5183.326167598226, 3837.1366442550484, 4328.372386004012, 4612.492625811192, 4620.983383655624, 4632.0, 5470.781168753245, 5489.176623506466, 5497.367802702701, 5530.225768392428, 5536.114221724545, 3725.310817498744, 3827.425886117077, 3830.3296923038633, 3853.614638536152, 3871.8190951759984, 4749.4775574686755, 5384.5692344612335, 5454.645448045904, 5524.806631767909, 5822.767089316422, 3074.738647215012, 3372.9494057589154, 3969.583193764613, 4038.959610403917, 4052.594740525924, 4065.390191471303, 4104.527979282361, 4105.568915263914, 4138.530821558364, 4139.296319625671, 3623.8006909620226, 4458.0, 4671.182543054952, 4671.929921051187, 4728.621710263171, 4588.036512332381, 5519.558435325244, 5539.086050801653, 5565.220869078333, 5592.972035139798, 1204.7590481903653, 1343.818584491081, 1345.2399394342165, 1386.6325423762712, 1392.8119703840055, 749.9227140819899, 810.2707563193173, 840.7771940435789, 847.8601030829844, 856.7986523167051, 3614.813038111957, 3654.7076233901225, 3892.785896775648, 4264.296391095497, 4276.914461710749, 4140.544540100586, 4253.3194688849635, 4597.6437200843575, 4636.00651719757, 4720.223820943232, 3682.9079273018388, 3827.4498827974717, 4060.7563546186734, 4256.021115143534, 4366.310467654826, 2002.0490267123, 2211.966820497694, 2408.867512286806, 2463.938401539976, 2467.79078251659, 4212.736179146244, 4511.796969136397, 4740.620750339965, 4817.759112044454, 4829.106615276185, 4336.436263285753, 4752.0279084180365, 4782.521747825259, 4846.903061938741, 4909.337239472697, 4759.595434388116, 4833.709977401297, 5268.894622107537, 5290.418054013979, 5931.377205393372, 5511.751971161227, 5756.56825738063, 5806.012977793701, 5814.680192589448, 5818.359980402068, 5433.891322173614, 5667.518260947865, 5694.943050569441, 5696.319585722139, 5792.623479473821, 4860.392450943632, 5438.75525601341, 5700.3444603871085, 5837.708114594338, 6021.638701677914, 3218.4850423932057, 3366.259422926952, 3384.441567141394, 3820.3696390095324, 3891.6886649068574, 4884.877878053077, 5109.540141387293, 5328.280682107866, 5733.827985160452, 5899.734511947058, 4510.9323360148965, 5449.0, 5479.178123281539, 5514.172874068761, 5645.181448689999, 5524.0, 5643.548516118783, 5644.491995720405, 5647.407022262603, 5659.03796354629, 4881.926771098508, 4964.180910149929, 5262.368515778131, 5467.4532546745, 5539.396483652677, 5360.249565060816, 5481.561475081904, 5503.697296648563, 5517.806876759294, 5663.971680141738, 5395.919061214164, 5419.268398766116, 5465.781368745205, 5500.972495137658, 5523.254360661259], "value": 3885.5469651246517, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8552289542092, 767.5509826751351, 805.5609692717472, 823.2549542663887, 832.883396324515, 13809.654758631026, 17500.737488937677, 17515.82484175158, 17518.737218941726, 17549.561260968483, 16485.83514164858, 16595.83404165958, 16728.916355418205, 16750.83249167508, 16752.916235418805, 698.259844564763, 715.6815217228335, 871.3073106880014, 880.3177537408511, 908.3142227618139, 897.349421669291, 904.6788390121511, 906.7415786500849, 907.7322189953946, 907.850204716221, 950.8858936927578, 950.9524523773819, 952.4761381240324, 954.2032402943515, 954.4368822394786, 737.1854101218157, 911.3757076402619, 940.6566603189855, 944.4474982135459, 947.4031360243038, 695.9756408525728, 696.3245651717825, 696.7352406085706, 696.864111498258, 696.9963252915785, 15045.699086018218, 15085.39658413662, 15093.094414335064, 15093.169875656835, 15098.24508774568, 13384.397702103428, 13533.932330338384, 13560.45758169672, 13582.728345433035, 13708.588742337746, 11551.375424682894, 11999.100067494974, 12801.487940482462, 12846.486140554367, 13004.869951300461, 4549.47681016684, 4553.658475614309, 4614.30785382192, 4776.044791041805, 4789.30555069513, 108138.45930770374, 108568.45715771371, 108918.0, 109747.45126274317, 110181.44909275482, 10623.20325975555, 10631.415272159951, 10765.784684306427, 10854.240203185702, 10891.727706807393, 20212.494687632927, 20262.0, 20282.884441355865, 20329.593408131754, 20336.898315508624, 7698.42261830365, 7729.845403092019, 7781.41639377049, 7902.841943161105, 8001.839963200703, 3784.0918179637238, 4313.41768861206, 4373.978130109393, 4407.6914615976575, 4556.931646025312, 3195.1053704962646, 3312.1719570107475, 3386.762926595164, 3427.211741299515, 3434.7767395119236, 544.7439703339503, 603.3935894426073, 632.7121159872247, 641.201703878674, 642.195430839343, 556.3768579191251, 566.5807302596049, 617.4751461257985, 662.0769303524979, 692.1693967239333, 9332.860007099898, 9416.340856140141, 9592.808143837085, 9594.232461403071, 9649.807003860024, 617.7714245729109, 621.176940553759, 621.4222455310498, 627.9748810047638, 693.769945885937, 4275.40144379787, 4340.414044104069, 4594.839180628662, 4622.583967442946, 4656.650751193674, 150000.0, 151958.48041519665, 155103.0, 155327.0, 157488.21255893877, 120748.0, 130452.47737613082, 131569.0, 132602.0, 133997.29017613825, 89744.0, 115161.42419288018, 117757.0, 118550.4072479632, 119763.0, 7319.890201647086, 8950.552472376225, 8961.820763584823, 8993.730188094367, 8995.325350598601, 50169.24746128884, 58854.70572647281, 60135.0, 61990.0, 62586.374136259874, 88109.0, 89753.65369519593, 90159.54920225356, 92632.0, 95853.49758029082, 11657.591984280509, 11832.645020649394, 11839.230450020721, 11960.820587691365, 12405.193662411913, 12717.87282127204, 12981.221126732426, 13017.934910325388, 13380.264085475003, 13515.391807368494, 12316.322602256962, 12337.198082124632, 12340.3212823292, 12459.93770031144, 12581.496740130293, 12183.147179697336, 12205.572804951784, 12322.691932701755, 12327.69180770488, 12472.812907806208, 11873.762524749629, 12081.335526546125, 12108.878911210775, 12416.875831241934, 12614.243145411305, 10322.587096516356, 10551.472426378803, 10556.313839600401, 10661.466926653791, 10851.0, 10155.593776248867, 10604.522796474022, 10609.416482093558, 10612.946935265274, 10640.733981650521], "value": 7760.282081193564, "unit": "score"}], "name": "dromaeo_css", "value": 7210.541124051169, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 124.0, 164.0, 148.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 105.0, 161.0, 109.0, 134.0, 152.0, 105.0, 160.0, 107.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 257.0, 226.0, 184.0, 185.0, 183.0, 183.0, 182.0, 183.0, 182.0], "value": 195.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 70.0, 95.0, 48.0, 78.0, 85.0, 90.0, 92.0, 58.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 95.0, 92.0, 72.0, 70.0, 68.0, 95.0, 69.0, 67.0, 100.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 86.0, 91.0, 89.0, 89.0, 85.0, 90.0, 86.0, 91.0, 87.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 101.0, 94.0, 91.0, 136.0, 131.0, 96.0, 95.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 84.0, 84.0, 105.0, 144.0, 143.0, 85.0, 87.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 55.0, 57.0, 54.0, 55.0, 54.0, 55.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 83.0, 78.0, 72.0, 70.0, 70.0, 69.0, 70.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 85.0, 83.0, 78.0, 81.0, 83.0, 86.0, 86.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 137.0, 157.0, 148.0, 132.0, 137.0, 137.0, 183.0, 138.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 170.0, 161.0, 163.0, 163.0, 162.0, 161.0, 167.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1476.9, "alertThreshold": 2.0}]} 11:11:23 INFO - Return code: 0 11:11:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:23 INFO - # TBPL SUCCESS # 11:11:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:11:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:11:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:11:23 INFO - 2016-07-12 11:11:23.116 screenresolution[1669:9994] starting screenresolution argv=screenresolution get 11:11:23 INFO - 2016-07-12 11:11:23.119 screenresolution[1669:9994] Display 0: 1600x1200x32@60 11:11:23 INFO - 2016-07-12 11:11:23.125 screenresolution[1670:9997] starting screenresolution argv=screenresolution list 11:11:23 INFO - Available Modes on Display 0 11:11:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:11:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:11:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:11:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:11:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:11:23 INFO - Intel Iris: 11:11:23 INFO - Chipset Model: Intel Iris 11:11:23 INFO - Type: GPU 11:11:23 INFO - Bus: Built-In 11:11:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:11:23 INFO - Vendor: Intel (0x8086) 11:11:23 INFO - Device ID: 0x0a2e 11:11:23 INFO - Revision ID: 0x0009 11:11:23 INFO - Displays: 11:11:23 INFO - Display: 11:11:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:11:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:11:23 INFO - Display Serial Number: 1600x1200 60 11:11:23 INFO - Main Display: Yes 11:11:23 INFO - Mirror: Off 11:11:23 INFO - Online: Yes 11:11:23 INFO - Rotation: Supported 11:11:23 INFO - Return code: 0 11:11:23 INFO - Running post-action listener: _resource_record_post_action 11:11:23 INFO - ##### 11:11:23 INFO - ##### Finished run-tests step (success) 11:11:23 INFO - ##### 11:11:23 INFO - Running post-run listener: _resource_record_post_run 11:11:23 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32882176; Write bytes: 705838080; Read time: 324; Write time: 2237 11:11:23 INFO - TinderboxPrint: CPU usage
53.5% 11:11:23 INFO - TinderboxPrint: I/O read bytes / time
32,882,176 / 324 11:11:23 INFO - TinderboxPrint: I/O write bytes / time
705,838,080 / 2,237 11:11:23 INFO - TinderboxPrint: CPU idle
2,252.6 (46.5%) 11:11:23 INFO - TinderboxPrint: CPU system
970.0 (20.0%) 11:11:23 INFO - TinderboxPrint: CPU user
1,623.1 (33.5%) 11:11:23 INFO - TinderboxPrint: Swap in / out
434,896,896 / 0 11:11:23 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 385538560; Write bytes: 381450240; Read time: 30559; Write time: 743 11:11:23 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 31960576; Write bytes: 295019520; Read time: 311; Write time: 1439 11:11:23 INFO - Running post-run listener: _upload_blobber_files 11:11:23 INFO - Blob upload gear active. 11:11:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:25 INFO - (blobuploader) - INFO - Done attempting. 11:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:26 INFO - (blobuploader) - INFO - Done attempting. 11:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:28 INFO - (blobuploader) - INFO - Done attempting. 11:11:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:28 INFO - Return code: 0 11:11:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/da616e8230b34eacc83523c9da6247a4959af2247a92aec98e600fe22c857bcc999908861685074f0d26475b0315fa3537686f334a456de60f317ea0664a4588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/050db1fc2dbba181edb921a17ff3e8fe3493ee37ea718d77f30c4fbc7280ee35d95291061465b8cd1f2a4802164d7c36322b7733f1134d0c44920c1716df4939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ebbcb8fc9c810e9646fd75127e73c5902b0ee81f8ce8f9481e0bfd26ebd73e61217fc0ba9d96a4aa39d4227afbe3fc54ad9d535a6941b695d6c393b0842f6ff4"} 11:11:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:28 INFO - Contents: 11:11:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/da616e8230b34eacc83523c9da6247a4959af2247a92aec98e600fe22c857bcc999908861685074f0d26475b0315fa3537686f334a456de60f317ea0664a4588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/050db1fc2dbba181edb921a17ff3e8fe3493ee37ea718d77f30c4fbc7280ee35d95291061465b8cd1f2a4802164d7c36322b7733f1134d0c44920c1716df4939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ebbcb8fc9c810e9646fd75127e73c5902b0ee81f8ce8f9481e0bfd26ebd73e61217fc0ba9d96a4aa39d4227afbe3fc54ad9d535a6941b695d6c393b0842f6ff4"} 11:11:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:28 INFO - Copying logs to upload dir... 11:11:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.159928 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-07-12 11:11:28.831986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 11:11:28.835562) ========= 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.LViiSDLBuO/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.f0p04kNVfg/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/da616e8230b34eacc83523c9da6247a4959af2247a92aec98e600fe22c857bcc999908861685074f0d26475b0315fa3537686f334a456de60f317ea0664a4588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/050db1fc2dbba181edb921a17ff3e8fe3493ee37ea718d77f30c4fbc7280ee35d95291061465b8cd1f2a4802164d7c36322b7733f1134d0c44920c1716df4939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ebbcb8fc9c810e9646fd75127e73c5902b0ee81f8ce8f9481e0bfd26ebd73e61217fc0ba9d96a4aa39d4227afbe3fc54ad9d535a6941b695d6c393b0842f6ff4"} build_url:https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010967 build_url: 'https://queue.taskcluster.net/v1/task/IiRfxWEERQa0e97p-S2JHg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/da616e8230b34eacc83523c9da6247a4959af2247a92aec98e600fe22c857bcc999908861685074f0d26475b0315fa3537686f334a456de60f317ea0664a4588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/050db1fc2dbba181edb921a17ff3e8fe3493ee37ea718d77f30c4fbc7280ee35d95291061465b8cd1f2a4802164d7c36322b7733f1134d0c44920c1716df4939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ebbcb8fc9c810e9646fd75127e73c5902b0ee81f8ce8f9481e0bfd26ebd73e61217fc0ba9d96a4aa39d4227afbe3fc54ad9d535a6941b695d6c393b0842f6ff4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 11:11:28.868939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:11:28.869399) ========= 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.LViiSDLBuO/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.f0p04kNVfg/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005329 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:11:28.917923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 11:11:28.918285) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 11:11:28.918623) ========= ========= Total master_lag: 0.17 =========