builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1467242286.33 results: success (0) buildid: 20160629151429 builduid: 3b78676fb59f41488c974e45b9218b96 revision: 50a6f462a97c39f473455a8fa496134e8a606f8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.330236) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.330804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.331156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.384558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.385004) ========= 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.5nLypWhZWf/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.iJRBAxdIJG/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-06-29 16:18:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.9M=0.001s 2016-06-29 16:18:06 (14.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116482 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.536025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.536401) ========= 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.5nLypWhZWf/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.iJRBAxdIJG/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.028740 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:06.585791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-29 16:18:06.586238) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 50a6f462a97c39f473455a8fa496134e8a606f8a --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 50a6f462a97c39f473455a8fa496134e8a606f8a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5nLypWhZWf/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.iJRBAxdIJG/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-06-29 16:18:06,839 truncating revision to first 12 chars 2016-06-29 16:18:06,839 Setting DEBUG logging. 2016-06-29 16:18:06,839 attempt 1/10 2016-06-29 16:18:06,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/50a6f462a97c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 16:18:08,486 unpacking tar archive at: autoland-50a6f462a97c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.917196 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-29 16:18:08.703416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:08.703968) ========= script_repo_revision: 50a6f462a97c39f473455a8fa496134e8a606f8a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:08.704567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:08.705132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:08.724317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 38 secs) (at 2016-06-29 16:18:08.724984) ========= /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.5nLypWhZWf/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.iJRBAxdIJG/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:18:08 INFO - MultiFileLogger online at 20160629 16:18:08 in /builds/slave/test 16:18:08 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 16:18:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:08 INFO - {'append_to_log': False, 16:18:08 INFO - 'base_work_dir': '/builds/slave/test', 16:18:08 INFO - 'blob_upload_branch': 'Autoland', 16:18:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:08 INFO - 'branch': 'Autoland', 16:18:08 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:08 INFO - 'config_files': ('talos/mac_config.py',), 16:18:08 INFO - 'default_actions': ('clobber', 16:18:08 INFO - 'read-buildbot-config', 16:18:08 INFO - 'download-and-extract', 16:18:08 INFO - 'populate-webroot', 16:18:08 INFO - 'create-virtualenv', 16:18:08 INFO - 'install', 16:18:08 INFO - 'run-tests'), 16:18:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:08 INFO - 'download_minidump_stackwalk': True, 16:18:08 INFO - 'download_symbols': 'ondemand', 16:18:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:08 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:08 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:08 INFO - 'installer_path': 'installer.exe', 16:18:08 INFO - 'log_level': 'info', 16:18:08 INFO - 'log_name': 'talos', 16:18:08 INFO - 'log_to_console': True, 16:18:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:18:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:18:08 INFO - 'opt_config_files': (), 16:18:08 INFO - 'pip_index': False, 16:18:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:08 INFO - 'cmd': ('bash', 16:18:08 INFO - '-c', 16:18:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:08 INFO - 'enabled': True, 16:18:08 INFO - 'halt_on_failure': False, 16:18:08 INFO - 'name': 'check_screen_resolution'},), 16:18:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:08 INFO - 'cmd': ('bash', 16:18:08 INFO - '-c', 16:18:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:08 INFO - 'enabled': True, 16:18:08 INFO - 'halt_on_failure': False, 16:18:08 INFO - 'name': 'check_screen_resolution'},), 16:18:08 INFO - 'run_cmd_checks_enabled': True, 16:18:08 INFO - 'sps_profile': False, 16:18:08 INFO - 'sps_profile_interval': 0, 16:18:08 INFO - 'suite': 'dromaeojs', 16:18:08 INFO - 'system_bits': '32', 16:18:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:08 INFO - 'title': 't-yosemite-r7-0028', 16:18:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:08 INFO - 'use_talos_json': True, 16:18:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:08 INFO - 'work_dir': 'build'} 16:18:08 INFO - ##### 16:18:08 INFO - ##### Running clobber step. 16:18:08 INFO - ##### 16:18:08 INFO - Running pre-action listener: _resource_record_pre_action 16:18:08 INFO - Running main action method: clobber 16:18:08 INFO - rmtree: /builds/slave/test/build 16:18:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:11 INFO - Running post-action listener: _resource_record_post_action 16:18:11 INFO - ##### 16:18:11 INFO - ##### Finished clobber step (success) 16:18:11 INFO - ##### 16:18:11 INFO - ##### 16:18:11 INFO - ##### Running read-buildbot-config step. 16:18:11 INFO - ##### 16:18:11 INFO - Running pre-action listener: _resource_record_pre_action 16:18:11 INFO - Running main action method: read_buildbot_config 16:18:11 INFO - Using buildbot properties: 16:18:11 INFO - { 16:18:11 INFO - "project": "", 16:18:11 INFO - "product": "firefox", 16:18:11 INFO - "script_repo_revision": "production", 16:18:11 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 16:18:11 INFO - "repository": "", 16:18:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 16:18:11 INFO - "buildid": "20160629151429", 16:18:11 INFO - "pgo_build": "False", 16:18:11 INFO - "basedir": "/builds/slave/test", 16:18:11 INFO - "buildnumber": 8, 16:18:11 INFO - "slavename": "t-yosemite-r7-0028", 16:18:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:18:11 INFO - "platform": "yosemite_r7", 16:18:11 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:18:11 INFO - "branch": "autoland", 16:18:11 INFO - "repo_path": "integration/autoland", 16:18:11 INFO - "revision": "50a6f462a97c39f473455a8fa496134e8a606f8a", 16:18:11 INFO - "stage_platform": "macosx64", 16:18:11 INFO - "builduid": "3b78676fb59f41488c974e45b9218b96", 16:18:11 INFO - "slavebuilddir": "test" 16:18:11 INFO - } 16:18:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 16:18:11 INFO - Running post-action listener: _resource_record_post_action 16:18:11 INFO - ##### 16:18:11 INFO - ##### Finished read-buildbot-config step (success) 16:18:11 INFO - ##### 16:18:11 INFO - ##### 16:18:11 INFO - ##### Running download-and-extract step. 16:18:11 INFO - ##### 16:18:11 INFO - Running pre-action listener: _resource_record_pre_action 16:18:11 INFO - Running main action method: download_and_extract 16:18:11 INFO - mkdir: /builds/slave/test/build/tests 16:18: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')]} 16:18:11 INFO - https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:18:12 INFO - Downloaded 1199 bytes. 16:18:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 16:18:12 INFO - Using the following test package requirements: 16:18:12 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:18:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 16:18:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 16:18:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'jsshell-mac.zip'], 16:18:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 16:18:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:18:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 16:18:12 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 16:18:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 16:18:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:18:12 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 16:18:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:18: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')]} 16:18:12 INFO - https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:18:16 INFO - Downloaded 18788455 bytes. 16:18:16 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'] 16:18:16 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 16:18:19 INFO - Return code: 0 16:18:19 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 16:18:19 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')]} 16:18:19 INFO - https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:19:12 INFO - Downloaded 18788455 bytes. 16:19:12 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'] 16:19:12 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 16:19:15 INFO - Return code: 0 16:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:19:15 INFO - https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:19:17 INFO - Downloaded 14405245 bytes. 16:19:17 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'] 16:19:17 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 16:19:17 INFO - Return code: 0 16:19:17 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')]} 16:19:17 INFO - https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:19:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:19:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:19:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 16:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/To2hmpkuSRuBaqyeErETyw/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 16:24:56 INFO - Downloaded 112460108 bytes. 16:24:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:24:56 INFO - mkdir: /builds/slave/test/properties 16:24:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:24:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:24:56 INFO - Contents: 16:24:56 INFO - build_url:https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:24:58 INFO - Running post-action listener: _resource_record_post_action 16:24:58 INFO - Running post-action listener: set_extra_try_arguments 16:24:58 INFO - ##### 16:24:58 INFO - ##### Finished download-and-extract step (success) 16:24:58 INFO - ##### 16:24:58 INFO - ##### 16:24:58 INFO - ##### Running populate-webroot step. 16:24:58 INFO - ##### 16:24:58 INFO - Running pre-action listener: _resource_record_pre_action 16:24:58 INFO - Running main action method: populate_webroot 16:24:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:24:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:24:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:24:58 INFO - '--tppagecycles', 16:24:58 INFO - '7'], 16:24:58 INFO - 'tests': ['tsvgm']}}, 16:24:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:24:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:24:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:24:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:24:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['damp', 'tps']}, 16:24:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'tests': ['damp', 'tps']}, 16:24:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['dromaeo_dom']}, 16:24:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:24:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['basic_compositor_video']}, 16:24:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:24:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['a11yr', 16:24:58 INFO - 'ts_paint', 16:24:58 INFO - 'tpaint', 16:24:58 INFO - 'sessionrestore', 16:24:58 INFO - 'sessionrestore_no_auto_restore', 16:24:58 INFO - 'tabpaint']}, 16:24:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:24:58 INFO - 'ts_paint', 16:24:58 INFO - 'tpaint', 16:24:58 INFO - 'sessionrestore', 16:24:58 INFO - 'sessionrestore_no_auto_restore', 16:24:58 INFO - 'tabpaint']}, 16:24:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:24:58 INFO - 'ts_paint', 16:24:58 INFO - 'tpaint', 16:24:58 INFO - 'sessionrestore', 16:24:58 INFO - 'sessionrestore_no_auto_restore', 16:24:58 INFO - 'tabpaint']}, 16:24:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:24:58 INFO - 'ts_paint', 16:24:58 INFO - 'tpaint', 16:24:58 INFO - 'sessionrestore', 16:24:58 INFO - 'sessionrestore_no_auto_restore', 16:24:58 INFO - 'tabpaint']}, 16:24:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['a11yr', 16:24:58 INFO - 'ts_paint', 16:24:58 INFO - 'tpaint', 16:24:58 INFO - 'sessionrestore', 16:24:58 INFO - 'sessionrestore_no_auto_restore', 16:24:58 INFO - 'tabpaint']}, 16:24:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['a11yr', 16:24:58 INFO - 'ts_paint', 16:24:58 INFO - 'tpaint', 16:24:58 INFO - 'sessionrestore', 16:24:58 INFO - 'sessionrestore_no_auto_restore', 16:24:58 INFO - 'tabpaint']}, 16:24:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['tsvgx', 16:24:58 INFO - 'tsvgr_opacity', 16:24:58 INFO - 'tart', 16:24:58 INFO - 'tscrollx', 16:24:58 INFO - 'cart']}, 16:24:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:24:58 INFO - 'tsvgr_opacity', 16:24:58 INFO - 'tart', 16:24:58 INFO - 'tscrollx', 16:24:58 INFO - 'cart']}, 16:24:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'talos_options': ['--disable-e10s'], 16:24:58 INFO - 'tests': ['tp5o']}, 16:24:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'tests': ['tp5o']}, 16:24:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'talos_options': ['--disable-e10s', 16:24:58 INFO - '--xperf_path', 16:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:58 INFO - 'tests': ['tp5n']}, 16:24:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:58 INFO - 'talos_options': ['--xperf_path', 16:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:58 INFO - 'tests': ['tp5n']}}, 16:24:58 INFO - 'talos.zip': {'path': '', 16:24:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:24:58 INFO - Running post-action listener: _resource_record_post_action 16:24:58 INFO - ##### 16:24:58 INFO - ##### Finished populate-webroot step (success) 16:24:58 INFO - ##### 16:24:58 INFO - ##### 16:24:58 INFO - ##### Running create-virtualenv step. 16:24:58 INFO - ##### 16:24:58 INFO - Running pre-action listener: _resource_record_pre_action 16:24:58 INFO - Running main action method: create_virtualenv 16:24:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:24:58 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 16:24:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:24:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:24:58 INFO - Using real prefix '/tools/python27' 16:24:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:24:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:25:02 INFO - Installing pip.................done. 16:25:02 INFO - Return code: 0 16:25:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:25:02 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')]} 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:02 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')]} 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:02 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 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:02 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 16:25:02 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 16:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:02 INFO - 'HOME': '/Users/cltbld', 16:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:02 INFO - 'LOGNAME': 'cltbld', 16:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:02 INFO - 'MOZ_NO_REMOTE': '1', 16:25:02 INFO - 'NO_EM_RESTART': '1', 16:25:02 INFO - 'PAGER': '/bin/cat', 16:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:02 INFO - 'PWD': '/builds/slave/test', 16:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:02 INFO - 'SHELL': '/bin/bash', 16:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:02 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:02 INFO - 'USER': 'cltbld', 16:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:02 INFO - 'XPC_FLAGS': '0x0', 16:25:02 INFO - 'XPC_SERVICE_NAME': '0', 16:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:02 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 16:25:02 INFO - Cleaning up... 16:25:02 INFO - Return code: 0 16:25:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:25:02 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')]} 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:02 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')]} 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:02 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 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:02 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 16:25:02 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 16:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:02 INFO - 'HOME': '/Users/cltbld', 16:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:02 INFO - 'LOGNAME': 'cltbld', 16:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:02 INFO - 'MOZ_NO_REMOTE': '1', 16:25:02 INFO - 'NO_EM_RESTART': '1', 16:25:02 INFO - 'PAGER': '/bin/cat', 16:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:02 INFO - 'PWD': '/builds/slave/test', 16:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:02 INFO - 'SHELL': '/bin/bash', 16:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:02 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:02 INFO - 'USER': 'cltbld', 16:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:02 INFO - 'XPC_FLAGS': '0x0', 16:25:02 INFO - 'XPC_SERVICE_NAME': '0', 16:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:02 INFO - Downloading/unpacking psutil>=3.1.1 16:25:02 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 16:25:02 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 16:25:02 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 16:25:02 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 16:25:02 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 16:25:02 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 16:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:06 INFO - Installing collected packages: psutil 16:25:06 INFO - Running setup.py install for psutil 16:25:06 INFO - building 'psutil._psutil_osx' extension 16:25:06 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 16:25:07 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 16:25:07 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 16:25:07 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 16:25:07 INFO - building 'psutil._psutil_posix' extension 16:25:07 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 16:25:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:25:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:25:07 INFO - ^ 16:25:07 INFO - 1 warning generated. 16:25:07 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 16:25:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:07 INFO - Successfully installed psutil 16:25:07 INFO - Cleaning up... 16:25:07 INFO - Return code: 0 16:25:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:07 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 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:07 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 16:25:07 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 16:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:07 INFO - 'HOME': '/Users/cltbld', 16:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:07 INFO - 'LOGNAME': 'cltbld', 16:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:07 INFO - 'MOZ_NO_REMOTE': '1', 16:25:07 INFO - 'NO_EM_RESTART': '1', 16:25:07 INFO - 'PAGER': '/bin/cat', 16:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:07 INFO - 'PWD': '/builds/slave/test', 16:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:07 INFO - 'SHELL': '/bin/bash', 16:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:07 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:07 INFO - 'USER': 'cltbld', 16:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:07 INFO - 'XPC_FLAGS': '0x0', 16:25:07 INFO - 'XPC_SERVICE_NAME': '0', 16:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:25:08 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 16:25:08 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 16:25:08 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 16:25:08 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 16:25:08 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 16:25:08 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 16:25:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:25:10 INFO - Installing collected packages: mozsystemmonitor 16:25:10 INFO - Running setup.py install for mozsystemmonitor 16:25:10 INFO - Successfully installed mozsystemmonitor 16:25:10 INFO - Cleaning up... 16:25:10 INFO - Return code: 0 16:25:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:10 INFO - 'HOME': '/Users/cltbld', 16:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:10 INFO - 'LOGNAME': 'cltbld', 16:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:10 INFO - 'MOZ_NO_REMOTE': '1', 16:25:10 INFO - 'NO_EM_RESTART': '1', 16:25:10 INFO - 'PAGER': '/bin/cat', 16:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:10 INFO - 'PWD': '/builds/slave/test', 16:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:10 INFO - 'SHELL': '/bin/bash', 16:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:10 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:10 INFO - 'USER': 'cltbld', 16:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:10 INFO - 'XPC_FLAGS': '0x0', 16:25:10 INFO - 'XPC_SERVICE_NAME': '0', 16:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:11 INFO - Downloading/unpacking jsonschema==2.5.1 16:25:11 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 16:25:11 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 16:25:11 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 16:25:11 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 16:25:11 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 16:25:11 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 16:25:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:25:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:25:13 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 16:25:13 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 16:25:13 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 16:25:13 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 16:25:13 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 16:25:13 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 16:25:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:25:14 INFO - warning: no files found matching '*.txt' 16:25:14 INFO - no previously-included directories found matching 'build' 16:25:14 INFO - no previously-included directories found matching 'dist' 16:25:14 INFO - no previously-included directories found matching '.git*' 16:25:14 INFO - Installing collected packages: jsonschema, functools32 16:25:14 INFO - Running setup.py install for functools32 16:25:14 INFO - warning: no files found matching '*.txt' 16:25:14 INFO - no previously-included directories found matching 'build' 16:25:14 INFO - no previously-included directories found matching 'dist' 16:25:14 INFO - no previously-included directories found matching '.git*' 16:25:14 INFO - Successfully installed jsonschema functools32 16:25:14 INFO - Cleaning up... 16:25:14 INFO - Return code: 0 16:25:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:25:14 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')]} 16:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:14 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')]} 16:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:14 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 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:14 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 16:25:14 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 16:25:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:14 INFO - 'HOME': '/Users/cltbld', 16:25:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:14 INFO - 'LOGNAME': 'cltbld', 16:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:14 INFO - 'MOZ_NO_REMOTE': '1', 16:25:14 INFO - 'NO_EM_RESTART': '1', 16:25:14 INFO - 'PAGER': '/bin/cat', 16:25:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:14 INFO - 'PWD': '/builds/slave/test', 16:25:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:14 INFO - 'SHELL': '/bin/bash', 16:25:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:14 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:14 INFO - 'USER': 'cltbld', 16:25:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:14 INFO - 'XPC_FLAGS': '0x0', 16:25:14 INFO - 'XPC_SERVICE_NAME': '0', 16:25:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:25:14 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 16:25:14 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 16:25:14 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 16:25:14 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 16:25:14 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 16:25:14 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 16:25:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:25:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:25:17 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 16:25:17 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 16:25:17 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 16:25:17 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 16:25:17 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 16:25:17 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 16:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:25:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:25:17 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 16:25:17 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 16:25:17 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 16:25:17 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 16:25:17 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 16:25:17 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 16:25:18 INFO - Downloading docopt-0.6.1.tar.gz 16:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:25:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:25:18 INFO - Running setup.py install for blobuploader 16:25:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:25:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:25:18 INFO - Running setup.py install for requests 16:25:18 INFO - Running setup.py install for docopt 16:25:19 INFO - Successfully installed blobuploader requests docopt 16:25:19 INFO - Cleaning up... 16:25:19 INFO - Return code: 0 16:25:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:19 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')]} 16:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:19 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')]} 16:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:19 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 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:19 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 16:25:19 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 16:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:19 INFO - 'HOME': '/Users/cltbld', 16:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:19 INFO - 'LOGNAME': 'cltbld', 16:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:19 INFO - 'MOZ_NO_REMOTE': '1', 16:25:19 INFO - 'NO_EM_RESTART': '1', 16:25:19 INFO - 'PAGER': '/bin/cat', 16:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:19 INFO - 'PWD': '/builds/slave/test', 16:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:19 INFO - 'SHELL': '/bin/bash', 16:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:19 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:19 INFO - 'USER': 'cltbld', 16:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:19 INFO - 'XPC_FLAGS': '0x0', 16:25:19 INFO - 'XPC_SERVICE_NAME': '0', 16:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:19 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OCkF0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:19 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-B70WVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:19 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-11p5L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:19 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-_uOSiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:19 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Oxru23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-WXx4ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-duFnG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qKWdWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Cqfjm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JCnQl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-67BWtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DAubTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Hwg_ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JnoY2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:20 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pvSRdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-krEk_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:21 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-QAlWcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:25:21 INFO - Running setup.py install for manifestparser 16:25:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:25:21 INFO - Running setup.py install for mozcrash 16:25:21 INFO - Running setup.py install for mozdebug 16:25:21 INFO - Running setup.py install for mozdevice 16:25:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:25:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:25:21 INFO - Running setup.py install for mozfile 16:25:22 INFO - Running setup.py install for mozhttpd 16:25:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Running setup.py install for mozinfo 16:25:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Running setup.py install for mozInstall 16:25:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Running setup.py install for mozleak 16:25:22 INFO - Running setup.py install for mozlog 16:25:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Running setup.py install for moznetwork 16:25:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:25:22 INFO - Running setup.py install for mozprocess 16:25:23 INFO - Running setup.py install for mozprofile 16:25:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:25:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:25:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:25:23 INFO - Running setup.py install for mozrunner 16:25:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:25:23 INFO - Running setup.py install for mozscreenshot 16:25:23 INFO - Running setup.py install for moztest 16:25:23 INFO - Running setup.py install for mozversion 16:25:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:25:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:25:23 INFO - Cleaning up... 16:25:23 INFO - Return code: 0 16:25:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:23 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 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:23 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 16:25:23 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 16:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:23 INFO - 'HOME': '/Users/cltbld', 16:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:23 INFO - 'LOGNAME': 'cltbld', 16:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:23 INFO - 'MOZ_NO_REMOTE': '1', 16:25:23 INFO - 'NO_EM_RESTART': '1', 16:25:23 INFO - 'PAGER': '/bin/cat', 16:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:23 INFO - 'PWD': '/builds/slave/test', 16:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:23 INFO - 'SHELL': '/bin/bash', 16:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:23 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:23 INFO - 'USER': 'cltbld', 16:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:23 INFO - 'XPC_FLAGS': '0x0', 16:25:23 INFO - 'XPC_SERVICE_NAME': '0', 16:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7Glh1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-SgHZS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ERiwvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OEwQcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-QCv40Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-CX1RG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-zsKWBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-YBXXWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:24 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)) 16:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:24 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-nF4Jvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:25 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-tIVoAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:25 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-BugpYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:25 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Y2ZoZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-h15Dec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:25 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-0u2zj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OKE9Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:25 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-_x4M55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:25 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)) 16:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:25 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-rTN_W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:25 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)) 16:25:25 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)) 16:25:25 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)) 16:25:25 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)) 16:25:25 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)) 16:25:25 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)) 16:25:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:25 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 16:25:25 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 16:25:25 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 16:25:25 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 16:25:25 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 16:25:25 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 16:25:28 INFO - Downloading blessings-1.6.tar.gz 16:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:25:28 INFO - Installing collected packages: blessings 16:25:28 INFO - Running setup.py install for blessings 16:25:28 INFO - Successfully installed blessings 16:25:28 INFO - Cleaning up... 16:25:28 INFO - Return code: 0 16:25:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:29 INFO - Reading from file tmpfile_stdout 16:25:29 INFO - Current package versions: 16:25:29 INFO - blessings == 1.6 16:25:29 INFO - blobuploader == 1.2.4 16:25:29 INFO - docopt == 0.6.1 16:25:29 INFO - functools32 == 3.2.3-2 16:25:29 INFO - jsonschema == 2.5.1 16:25:29 INFO - manifestparser == 1.1 16:25:29 INFO - mozInstall == 1.12 16:25:29 INFO - mozcrash == 0.17 16:25:29 INFO - mozdebug == 0.1 16:25:29 INFO - mozdevice == 0.48 16:25:29 INFO - mozfile == 1.2 16:25:29 INFO - mozhttpd == 0.7 16:25:29 INFO - mozinfo == 0.9 16:25:29 INFO - mozleak == 0.1 16:25:29 INFO - mozlog == 3.2 16:25:29 INFO - moznetwork == 0.27 16:25:29 INFO - mozprocess == 0.22 16:25:29 INFO - mozprofile == 0.28 16:25:29 INFO - mozrunner == 6.11 16:25:29 INFO - mozscreenshot == 0.1 16:25:29 INFO - mozsystemmonitor == 0.3 16:25:29 INFO - moztest == 0.7 16:25:29 INFO - mozversion == 1.4 16:25:29 INFO - psutil == 3.1.1 16:25:29 INFO - requests == 1.2.3 16:25:29 INFO - wsgiref == 0.1.2 16:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:29 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 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:29 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 16:25:29 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 16:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:29 INFO - 'HOME': '/Users/cltbld', 16:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:29 INFO - 'LOGNAME': 'cltbld', 16:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:29 INFO - 'MOZ_NO_REMOTE': '1', 16:25:29 INFO - 'NO_EM_RESTART': '1', 16:25:29 INFO - 'PAGER': '/bin/cat', 16:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:29 INFO - 'PWD': '/builds/slave/test', 16:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:29 INFO - 'SHELL': '/bin/bash', 16:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:29 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:29 INFO - 'USER': 'cltbld', 16:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:29 INFO - 'XPC_FLAGS': '0x0', 16:25:29 INFO - 'XPC_SERVICE_NAME': '0', 16:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 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)) 16:25:29 INFO - Cleaning up... 16:25:29 INFO - Return code: 0 16:25:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103005a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10309a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a1c9c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, '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.5nLypWhZWf/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.iJRBAxdIJG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 16:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:29 INFO - 'HOME': '/Users/cltbld', 16:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:29 INFO - 'LOGNAME': 'cltbld', 16:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:29 INFO - 'MOZ_NO_REMOTE': '1', 16:25:29 INFO - 'NO_EM_RESTART': '1', 16:25:29 INFO - 'PAGER': '/bin/cat', 16:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:29 INFO - 'PWD': '/builds/slave/test', 16:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:29 INFO - 'SHELL': '/bin/bash', 16:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:25:29 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:29 INFO - 'USER': 'cltbld', 16:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:29 INFO - 'XPC_FLAGS': '0x0', 16:25:29 INFO - 'XPC_SERVICE_NAME': '0', 16:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:25:29 INFO - Cleaning up... 16:25:29 INFO - Return code: 0 16:25:29 INFO - Running post-action listener: _resource_record_post_action 16:25:29 INFO - Running post-action listener: _start_resource_monitoring 16:25:29 INFO - Starting resource monitoring. 16:25:29 INFO - ##### 16:25:29 INFO - ##### Finished create-virtualenv step (success) 16:25:29 INFO - ##### 16:25:29 INFO - ##### 16:25:29 INFO - ##### Running install step. 16:25:29 INFO - ##### 16:25:29 INFO - Running pre-action listener: _resource_record_pre_action 16:25:29 INFO - Running main action method: install 16:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:29 INFO - Reading from file tmpfile_stdout 16:25:29 INFO - Detecting whether we're running mozinstall >=1.0... 16:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:25:29 INFO - Reading from file tmpfile_stdout 16:25:29 INFO - Output received: 16:25:29 INFO - Usage: mozinstall [options] installer 16:25:29 INFO - Options: 16:25:29 INFO - -h, --help show this help message and exit 16:25:29 INFO - -d DEST, --destination=DEST 16:25:29 INFO - Directory to install application into. [default: 16:25:29 INFO - "/builds/slave/test"] 16:25:29 INFO - --app=APP Application being installed. [default: firefox] 16:25:29 INFO - mkdir: /builds/slave/test/build/application 16:25:29 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'] 16:25:29 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 16:26:04 INFO - Reading from file tmpfile_stdout 16:26:04 INFO - Output received: 16:26:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:26:04 INFO - Running post-action listener: _resource_record_post_action 16:26:04 INFO - ##### 16:26:04 INFO - ##### Finished install step (success) 16:26:04 INFO - ##### 16:26:04 INFO - ##### 16:26:04 INFO - ##### Running run-tests step. 16:26:04 INFO - ##### 16:26:04 INFO - Running pre-action listener: _resource_record_pre_action 16:26:04 INFO - Running main action method: run_tests 16:26:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:26:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:26:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:26:04 INFO - 2016-06-29 16:26:04.384 screenresolution[1652:8439] starting screenresolution argv=screenresolution get 16:26:04 INFO - 2016-06-29 16:26:04.387 screenresolution[1652:8439] Display 0: 1600x1200x32@60 16:26:04 INFO - 2016-06-29 16:26:04.393 screenresolution[1653:8441] starting screenresolution argv=screenresolution list 16:26:04 INFO - Available Modes on Display 0 16:26:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:26:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:26:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:26:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:26:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:26:04 INFO - Intel Iris: 16:26:04 INFO - Chipset Model: Intel Iris 16:26:04 INFO - Type: GPU 16:26:04 INFO - Bus: Built-In 16:26:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:26:04 INFO - Vendor: Intel (0x8086) 16:26:04 INFO - Device ID: 0x0a2e 16:26:04 INFO - Revision ID: 0x0009 16:26:04 INFO - Displays: 16:26:04 INFO - Display: 16:26:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:26:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:26:04 INFO - Display Serial Number: 1600x1200 60 16:26:04 INFO - Main Display: Yes 16:26:04 INFO - Mirror: Off 16:26:04 INFO - Online: Yes 16:26:04 INFO - Rotation: Supported 16:26:04 INFO - Return code: 0 16:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:26:04 INFO - Python 2.7.3 16:26:04 INFO - Return code: 0 16:26:04 INFO - grabbing minidump binary from tooltool 16:26:04 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')]} 16:26:04 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 0x102f69d30>, '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 0x102ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f61b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:26:04 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 16:26:04 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 16:26:04 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 16:26:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:26:04 INFO - Return code: 0 16:26:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:26:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:26:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:26:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:26:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:26:04 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/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 16:26:04 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/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --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 16:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5nLypWhZWf/Render', 16:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:26:04 INFO - 'HOME': '/Users/cltbld', 16:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:26:04 INFO - 'LOGNAME': 'cltbld', 16:26:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:26:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:04 INFO - 'MOZ_NO_REMOTE': '1', 16:26:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:26:04 INFO - 'NO_EM_RESTART': '1', 16:26:04 INFO - 'PAGER': '/bin/cat', 16:26:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:04 INFO - 'PWD': '/builds/slave/test', 16:26:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:26:04 INFO - 'SHELL': '/bin/bash', 16:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iJRBAxdIJG/Listeners', 16:26:04 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 16:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:26:04 INFO - 'USER': 'cltbld', 16:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:04 INFO - 'XPC_FLAGS': '0x0', 16:26:04 INFO - 'XPC_SERVICE_NAME': '0', 16:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:26:04 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/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 16:26:04 INFO - mozversion application_buildid: 20160629151429 16:26:04 INFO - mozversion application_changeset: 50a6f462a97c39f473455a8fa496134e8a606f8a 16:26:04 INFO - mozversion application_display_name: Nightly 16:26:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:26:04 INFO - mozversion application_name: Firefox 16:26:04 INFO - mozversion application_remotingname: firefox 16:26:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:26:04 INFO - mozversion application_vendor: Mozilla 16:26:04 INFO - mozversion application_version: 50.0a1 16:26:04 INFO - mozversion platform_buildid: 20160629151429 16:26:04 INFO - mozversion platform_changeset: 50a6f462a97c39f473455a8fa496134e8a606f8a 16:26:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:26:04 INFO - mozversion platform_version: 50.0a1 16:26:04 INFO - using testdate: 1467242764 16:26:04 INFO - actual date: 1467242764 16:26:04 INFO - starting webserver on 'localhost:49271' 16:26:04 INFO - SUITE-START | Running 2 tests 16:26:04 INFO - TEST-START | dromaeo_css 16:26:04 INFO - operating with platform_type : mac_ 16:26:04 INFO - Initialising browser for dromaeo_css test... 16:26:04 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpYClIF0/profile http://localhost:49271/getInfo.html) 16:26:07 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 16:26:07 INFO - PROCESS | 1663 | colorDepth:24 16:26:07 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 16:26:07 INFO - PROCESS | 1663 | __metrics 16:26:07 INFO - PROCESS | 1663 | 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" 16:26:07 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:26:08 INFO - TEST-INFO | 1663: exit 0 16:26:08 INFO - Browser initialized. 16:26:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:26:08 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpYClIF0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:20 INFO - PROCESS | 1666 | RSS: Main: 244690944 16:26:20 INFO - PROCESS | 1666 | 16:27:11 INFO - PROCESS | 1666 | 1467242831332 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] 16:29:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:29:24 INFO - PROCESS | 1666 | RSS: Main: 383401984 16:29:24 INFO - PROCESS | 1666 | 16:32:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:32:28 INFO - PROCESS | 1666 | RSS: Main: 375554048 16:32:28 INFO - PROCESS | 1666 | 16:35:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:35:30 INFO - PROCESS | 1666 | RSS: Main: 371441664 16:35:30 INFO - PROCESS | 1666 | 16:38:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:38:33 INFO - PROCESS | 1666 | RSS: Main: 372420608 16:38:33 INFO - PROCESS | 1666 | 16:41:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:41:37 INFO - PROCESS | 1666 | RSS: Main: 341139456 16:41:37 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:44:41 INFO - PROCESS | 1666 | RSS: Main: 387178496 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | __start_tp_report 16:44:41 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 16:44:41 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 16:44:41 INFO - PROCESS | 1666 | |i|pagename|runs| 16:44:41 INFO - PROCESS | 1666 | |0;dojo.html;3328.2511434927146;3339.6994270515665;3370.1743072947133;3381.120908563773;3403.421418358879;5564;5663.9433605663935;5681.687507187114;5732.512736417404;5757.884842303151;5704.401037891013;5709.343425506068;5804.477597016278;5816.709164541777;5847.590668653196;5099.643024988252;5121.12940800063;5177.559907407875;5177.792888284483;5268.9473105269035;5272.103742363807;5303.15149576066;5311.893762124755;5312.521873031426;5335.759890804923;5141.4087379951225;5172.508611681884;5188;5198.40218374888;5236.659617124875;5199.428062913076;5199.66202196856;5199.714015729133;5202.765875535572;5227.032998895179;5106.719130447824;5167;5174;5206.453322401169;5210.869728256824;5738.6556806591325;5754.683492407916;5757.712114394305;5765.682887441189;5771.624844385102;6207.782727604557;6239.906401403982;6291.653959032297;6307.990721484586;6323.557350985433;6157.78447754331;6174.598651087665;6301.40136687014;6307.4954003679595;6392.1370614966845;5859.062549991981;5863.384344643794;5871.530277577784;5878.647281163144;5881.117832325185;6320.209973753281;6331.05034244867;6336.366363363627;6344.49244060474;6348.238211414659;6023.156758053876;6061.207773834101;6082.330943596201;6091.664958427329;6127.356627554132;6303.527235457359;6353.30113687494;6356.14192084072;6362.268339141058;6365.649889256136;6217.502599792006;6278.372162783685;6285.43431091204;6290.748370065237;6298;6098.710785140803;6177.104319873683;6255.343188965093;6310.968445157837;6314.210723659543;4910.607151427877;4944.307796908436;4947.5794557462295;4953.554180123806;4971.37857767779;4417.889552761207;4419.270820314612;4433.667474939392;4437.755923424243;4468.843590474317;5626.127950167731;5639.520640745501;5721.656700597978;5733.885322293614;5757.971210143923;6122.215193971364;6164.260288765377;6196.628202307876;6260.686965651699;6273.153124328157;5674.546036317085;5674.943250567524;5691.971540142273;5701;5728.48443640066;5352.839414817562;5391.029614669397;5399.7300134993875;5404.432534583891;5404.729763511808;6252.3122456529745;6300.810975670737;6312.368763123651;6337.809865704036;6356.269029061532;6337.873242535031;6346.301906790157;6360.332165122781;6360.395762402564;6376.266729326001;6221.5333849962335;6276.403741644536;6300.527460440394;6327.683615819283;6348.365163483615;6134.283518479682;6217.129601855653;6240.656763878031;6244.718987645658;6249.968755155349;6318.273398559225;6326.778562750282;6328.525360597881;6339.207599050119;6370.458511026614;5954.523638108854;6003.099535069599;6021.42796434338;6120.724567394389;6136.8772624548155;5505.926344362971;6056.06131049688;6088.178095957166;6097.827165393427;6135.325114237341;5476.507114359727;5770.855728606818;5889.49939255151;5890.764369425175;5941.940580594139;5829.883402332014;5893.174955506147;6078.589965612492;6100.066499260575;6101.2909632572;5977.6114552553945;5985.371535988658;6002.699865006645;6036.517078633787;6044 16:44:41 INFO - PROCESS | 1666 | |1;ext.html;457.91986402379575;479.88722650177203;530.3953493017958;531.2323692264678;548.747576114987;30964.225894352654;41636.959076023115;42606.36090458646;42722.572774272245;45252.773736131356;43798.562014379844;44184.779076104656;44286.11427771451;44329.7783511082;44338.113237735226;8573.614187361583;9607.807843843137;9807.31348805584;9807.509624518745;9810.166135878459;8746.25656819168;11846.052315814713;11971.521139154424;11976.28142311464;12212.145149839514;11931.701707457296;11978.580749673763;12004.979576735988;12005.099617528676;12012.519499220021;8703.695370661997;11836.585719499777;11919.940400297986;11961.940190298992;11985.161038727336;11861.051115910706;11941.164118511708;11946.701332466671;11953.760924781456;11955.880441195564;41583.168336633404;41965;41990.1601967962;42104.157916841796;42254;3374.7975121492545;3585.784852908808;3608.5128507651393;3744.2698673758628;4078.6125318094732;30709.38581228363;30801.229969250722;33078.353731701405;33102.834485827654;33189.3362132756;3178.3484385700876;3347.062822409729;3394.8132852693093;3403.9659603404143;3459.7405194610255;496780;502915;503635;504509;504531.4773426146;63704;64975.025374618475;64985;64999.35000650027;65026.67486662631;68065;68240;68252.31747682558;68315.65842170856;68467.65766171138;16236.918815405847;16450.75323870143;16468.752968705478;16470.42353517645;16479.588010299838;11223.438828058564;11464.140189485823;11480.425978701032;11688.357140357362;12481.500739970299;17431.453836983826;19433.51416214606;20311.796882031285;20327.695084573745;20338;7531.623418829036;7536.962315188389;7559.433042521833;7582.128055273714;7661.770146895602;848.7878030492377;957.8323793336139;986.7089208683456;1022.5858527296457;1053.8208504554243;24785.62821557678;28047.0183543575;29251.62603248068;29947.850260748557;31167.53248701226;1073.120041565924;1099.455769394155;1130.22014809781;1180.15029178991;1204.3135412814786;15970.60073498172;15970.76043859343;15999.360025599079;16130.156422689724;16321.673566528603;182169;183241.08379458284;183446.0827695853;183665;184384;59129;59290.70354648199;59393;59426;59448;1201.6815543880878;1247.1643998521013;1376.0436496634943;1402.0466083063616;1408.7112142011067;31487.685123149393;31494.52758208583;31555.36889262248;32421.67578324281;32570.83714581412;51581.74209128931;51889;52161.7391913038;52269;52321.7383913078;423470;424011.87994059833;428942;429768;430709;27308;27441.45117097607;27742;27804.74878630426;29181.7081829179;48358.516414836806;48866.267005994225;49353.75323123361;49711;49971.75014124906;32420.675793241764;40166.799166003984;40517.79741101393;40754.1849163021;41570.58429415667;39804;39967;40002;40312.79843600763;40850.808568071945;38411.231775363776;39285.8035709831;39488.2102357957;39518.60481395149;39523.80238098906;33626;34347.767395119234;35157.82421087878;35407.760728374386;35555.64444355523;24233.51532969366;24365.903534340643;25555.505656103338;25738.227853164433;26517 16:44:41 INFO - PROCESS | 1666 | |2;jquery.html;347.6975031722402;380.5319457067807;384.37538999126417;384.5500764105997;405.8741790045086;15390.384384624616;15772.684546309067;20191.596168076667;20779.376618701444;20824.958752062375;20759.792402075975;20954.26660066898;21164.94175291237;21438.24966126186;21572.89213553934;5261.8947621047555;5639.843832014448;5646.350669672999;5828.388019257981;5894.852628684296;5871.383504732005;5889.6171748836405;5950.434708702688;5950.851228719295;5955.70221488926;5614.242077319571;5806.245188125537;5818.301803783552;5819.709014549277;5910.556708246899;5728.856778580548;5779.826605201809;5783.855403614923;5795.3045634523705;5803.970980145094;4541.682082254243;5066.721330326831;5067;5069.670471419383;5070.7464626768515;26285.47429051408;26287.868560657073;26313.868430657916;26681.332966675793;26811.731882681117;2177.5536015116863;2183.4868805830615;2205.669149627569;2475.6905386826647;2707.4179051503825;15155.696886062327;15407.537773866801;15950.9631873929;16388.0167189969;16572.254248558846;1836.8714190006706;1843.64970655575;1855.2115350975782;1918;1965.3710812539994;115593.26610100856;121056.78943210543;121146.18280725884;122838;123810.38094809468;10492.534254450198;10835;10878.891211087946;11172.162087843444;11190.04884584803;13638.795418068737;13736.725265494633;13784.035117541676;13784.310784460937;13801.930990345185;7030.543014704028;8451.957740211259;8458.661653533913;8560.0583935767;8630.395872289006;7243.637818109073;8452.8732069019;8559.400841941004;8698.956505217433;8712.346574006975;5476.780928762884;6521.64130972801;6621.9337806621315;6627.10534077903;6639.302873198245;1813.1296977450897;1844.087176847469;1851.8333349998566;1854.5178253654146;1883.2749391484103;845.7124577643631;923.5243849417556;930.4556834251903;936.4708939449189;953.4755884263627;22121.66817497739;22660.093596256294;22688.546229075328;22705.205317813798;22776.772232277795;948.4688574398359;981.2052237687496;986.605357856863;1004.864343313658;1031.437866362834;11041.674999000172;11342.773144537063;11828.940855295668;11837.526498939946;11927.522899084113;478817;596043;602555;626718;627510;116446;117889;118203;118844;120421;1006.059334522224;1064.7338165458636;1085.4247248958065;1090.3185509056839;1091.2743025887696;19638.214471420983;20028.99855007273;20032.499187519847;20034.499137521678;20063.69904451405;52230.47769522256;53054.204186936455;53221.935561287784;53641.39075827732;53646.46353536415;73163;74930.6253468751;76217;77792.8331075023;79986.20013799788;7750;7909.406794490321;8351.457155284887;8400.075991641037;8578.4424012439;9278.907210927804;13154.144980576231;13335.333233338488;13345.332733363099;13373.732525349633;11287.322760634388;11501.194916355775;11585.6524304271;11697.590584329508;11717.296962182296;9628.71113866585;10638.202134839763;11149.944250278697;11243.49404276826;11285.774284514428;11692.766144677229;11759.412029398667;11884.465199066235;11899.76200476003;11957.103217258566;8247.463914845515;8313.376496762889;8351.373646976379;8363.414560980673;8365.539895305817;8372.455790373606;9362.157405833508;9685.806283874424;11444.82832757526;11655.53377864876 16:44:41 INFO - PROCESS | 1666 | |3;mootools.html;1354.2145555577765;1492.3657445585623;1529.839366866479;1701.880868339216;1869.336385583118;7754.340881025112;8215.794605134859;8220.465669731464;8221.3011893989;8236.876446853286;8331.166883311666;8558.101399353072;8593;8690.04409514953;8714;2277.055022165799;2358.7169539655265;2358.9646155307682;2359.929202123939;2360.0913648245464;2318.0380142241033;2360.1975328388344;2361.669366288721;2364.6807680963107;2367.3016460144213;2156.8382371322136;2202.6695995600626;2346.0615753698485;2361.89371478283;2365.3849999000213;2304.43541332373;2332.2303639798824;2341.063574570177;2342.7422983471806;2346.0498498108295;2329.94175145621;2330.079618550663;2335.2177020698086;2338.0414030247516;2357.728861180969;8755.518446485441;8800.823983520359;8824;8856.114388561156;8879.289656827503;5141.357330333708;5156.278121063054;5301.1783173608155;5306.973465132688;5324.361076670785;3491.5286436331025;3559.4660800879815;3606.296772129436;3614.6023937366867;3636.1273294409416;1044.8693913260843;1062.0706881478707;1080.2330345454736;1085.0072183951754;1085.5440714899762;11517.827232591519;11615.477303521362;11626.883731162749;11640.650780476599;11670.708232294175;4357.281048626941;4363.301871700576;4560.977195114003;4579.816807327669;4602.079584083197;9069.954650226839;9072.228860546795;9078.273738101068;9082.45505269686;9083.591238394289;5195.350581177353;5205.375354957354;5208.0104780092415;5214.765335559909;5216.973915130476;4213.705040647125;4354.521002689701;4370.235208838504;4514.70654407469;4862.3922009748785;3681.079730067483;3727.7576957497677;3748.044248716614;3795.772253664789;3796.2976849282973;1149.655103468956;1158.8551431071116;1160.280626011878;1162.5698491558178;1167.0780083733755;890.3633901760272;896.4173287363266;899.4603238057244;941.3081385181886;946.3422921069928;5800.245968024215;5960.374160713062;6040.909386359208;6135.7852475164045;6186.938130618726;406.86980166346484;424.19826527862364;431.83158568158444;434.09058023440843;450.0548847420391;4019.7789121598594;4029.2948733972025;4052;4090.427340172378;4102.979485102555;10067.496625168713;10807.08139808125;10842.891571084347;10844.837327440095;10883.782324353628;9402.952985235166;10650.360978341325;10756.892431075588;10785.298955567863;10800.405977671146;8063.798405039804;8137.5931203439595;8154.714584989615;8165.673373065129;8198.877016844752;5861.384554621874;5861.996957131323;5883.764649414146;6002.0996850472775;6125.877482450237;9720.854187187339;10035.34770239932;10042.49787510607;10057.396556206651;10085.193184545073;9364.719058428258;10339.844902326622;10376;10389.220808439246;10395.740106497398;6621.470282377302;6782.253952065367;6793.72825086991;6796.898046529207;6799.422049125682;6439.613623182624;7983.281504664608;7984.121746607752;7995.720149794729;8094.069182044141;7494.475386722877;7527.962360188164;7558.281963213486;7652.693892244471;7677.923220767944;7390.445716571387;7414.073240844895;7471.551706897603;7526.172121066569;7576.469647124648;6767.830804229934;7042.154941407064;7105.82235444118;7111.43108551325;7173.175084865307;4994.900101997867;5052.141136006814;5071.619628527801;5084.440711521804;5187.24784906179;4791.1854984652;5058.190689489664;5058.620603454682;5274.657147285414;5281.366236051698 16:44:41 INFO - PROCESS | 1666 | |4;prototype.html;301.8249415339103;306.3108006984284;309.07740394921166;314.04217137729916;317.18958062151194;4368.694191406603;4451.330750968387;5037.546620804127;5334.173203153513;5349.726366294324;5106.69359838409;5344.893102137955;5392.460753924605;5410.972945135269;5415.296011518507;3190.5214217867388;3693.445983102543;3861;4017.1721866550647;4099.364598487239;3495.580530336363;3646.2342907989355;4054.6553542948736;4056.492938382702;4078.5717499662555;4041.4139949707424;4047.907065092423;4052.844939192331;4062.2484840304637;4080.87757367278;3803.2773772983046;3830.7701537907674;3965.385365268388;4029.2545879012478;4051.5543290238347;3090.644575873781;3411.942297887663;3459.0141809584397;3465.549478567795;3505.8948231553095;3757.444937442538;4271.893202669959;4644.558766917137;5172.27588137661;5202.525827788099;4234.36976763945;4259.275923093051;4607.285870690049;4624.213883639789;4662.230731929228;4872.244802055687;5453.454654534555;5640.351359593658;5658.745356458928;5667.971660141714;3591.8024508652015;3832.7891965941863;3848.2688289224957;3854.421836724514;3864.787436690981;5377.139657654757;5537.640053396516;5909.852253693606;5916.461719952843;5937.109433584997;3069.051152518167;3876.5348158221195;3880.4373365861793;3880.631340022693;3889.105505733697;3313.867445302209;3772;3945.368741001426;3963;3978.1645854370904;3823.483829682957;4500.964071768193;4594.471635761864;4623.676342655982;4649.209634362167;5310.221075939527;5408.621396502207;5673.262475878109;5695.857603559862;5701.631608413951;1252.9373531323397;1315.6118944911275;1343.3812256231217;1345.5828693105168;1349.7098123903409;653.2618141500169;734.3014421999131;817.595290331278;822.2271065198694;827.7831587566268;4350.412694286231;5039.823606173766;5298.986385173609;5300.469953004746;5312.211089178212;4788;5799.60809405748;5818.912716309259;5876.412358764175;5877.764889404461;4989.451160372356;5192.350956130484;5235.293235413246;5240.580753539708;5316.893662126736;2606.27024433159;2833.844138572398;2952.5680045178074;2977.1392879450345;3028.318628308613;4588.632909367309;5069.543741063322;5953;5975.551833612496;6066.757329706762;5262.973720124539;5547.44525547442;5611.37270191648;5852;5899.351071382144;5308.548773354231;5328.440513746078;5758.395368486333;5885.941140588539;5920.733566989496;4825.95174048255;5646;5737.684427356368;5759.625624334405;5795.884082318245;5404.594655400782;5788.652680839163;5803.718616059366;5817.9127313091185;5819.912701309399;4886.755662216804;5953.315368732651;6034.788782392595;6052.636841789506;6080.422359875804;3676.5036720042453;3861.9034524137123;3878.786666733357;3885.7862817545306;3953.3872249801325;4947.985662939161;5508.394076651485;5849.970750146222;5867.471927526543;5872.29532456108;5350.6254562180275;5370.597205209703;5633.126865335879;5718.628289161191;5731.054376027909;5130.768615532171;5150.871228219325;5477.178423236546;5654.180143879033;5730.885382292414;5241.371035475768;5459.344878614592;5497.312835895513;5506.614536982373;5514.420985796433;4529.822246215942;5354.892902142014;5535.308086489189;5699.601027928005;5718.342390625131;5341.332333458317;5552.861178470571;5619.269494965628;5626.2967129108865;5633.492985631313 16:44:41 INFO - PROCESS | 1666 | |5;yui.html;720.700909122714;780.3718007004363;788.4008153803107;831.0816547714774;840.8024114333127;15061.548153555397;15619.219039048045;16142.273597688103;16175.919120404382;16204.83795162048;14355.928220358883;14594.41622335108;14596.343164557595;14624.415023399051;14681.412743490275;681.9556728812636;712.8396110875037;843.2200214801314;864.7146441674248;890.5235698901089;877.2630989968425;885.8582626779717;887.3832686283035;888.2449917570046;892.0366004714924;898.6944438890775;921.5576523268802;934.0612684252317;941.4022095969075;947.313197931501;709.4324540367737;870.0907551608584;936.5457752989795;937.6624415210553;940.8306504829128;697.438561957624;699.1470406104544;699.192432740186;700.3066963705945;700.4711442860659;14611.853881461155;14630.341634626468;14648.414063437449;14666.779998300033;14699.853001469955;13896.93051534746;14017.509387171502;14027.1583704977;14122.22327771972;14134.92932535341;11775.646730598095;11803.645890623295;11828.88171118295;11835.644930652094;11944.35187441873;4603.539646035403;4628.606568441686;4642.837500687459;4800.831970881038;4805.471398146201;107021;107388;107715.46142269317;107788;109710;10578.735531611772;11109.333439993627;11254.549818007352;11430.942845285721;11575.569130482525;20387.490312742004;22156.22453214162;22179.66730499044;22192.556148877255;22206.222782202545;7873.763787086396;7887.408444366695;8053.1946805319;8100.716474923467;8113.229243221885;4389.385486031958;4401.2517871961845;4443.2224360736745;4448.199324121689;4617.284320930261;3359.8152101634646;3483.1466290758926;3483.982580087134;3487.7035451986867;3487.843047062888;660.5046215338496;661.4576047640888;698.1099098649162;710.1265443504415;715.3347386930205;577.1948132355425;619.2290598205174;678.6913795248165;700.8212905709114;705.6859697434695;8999.460032398078;9214.76963075915;9414.340996130206;9742.220622350194;10399.84400233997;569.6610516742531;626.9090981807612;671.7313074770132;687.7867860963117;713.4871935011075;4449.7997590108525;4550.749708765983;4596.793144308447;4625.699329543636;4729.810807567727;94825;124208;130868;153853;157042;83789.58105209435;83791.16208837833;104669.47665261626;127672;132501;98605.88165352237;110015.44992274987;110729;113325.20536445906;113570.72858542617;8980.86528702057;9080.364374493985;9109.726708198765;9133.954330228305;9227.123423274777;57861;61465;61479;63917.36082639114;64001.91981761725;54175.45824541704;77433.83849242154;91012.08987910036;92527.53736231275;94317;13113.803292950804;13286.867131328563;13383.330833458484;13572.321383930566;13601.944981679073;14998.2500874958;15358.38566457374;15372.538823835303;15759;15870.60323491922;13836.723265534432;13840.446382145004;14093.577192684235;14525.4916077941;14684.779728304298;14098.013139080576;14274.857251427768;14296.285185740464;14299.428022878968;14751.704965900837;13669.316534173451;13866;13994.930025349808;14167.504137355143;14535.636609084857;9664.323497355117;10176.847347289648;10783.191260655325;10822;10902.727431814268;10461.424621645578;10864.782704345711;11151.442427878736;11199;11205.495752690986 16:44:41 INFO - PROCESS | 1666 | __end_tp_report 16:44:41 INFO - PROCESS | 1666 | __start_cc_report 16:44:41 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1713 16:44:41 INFO - PROCESS | 1666 | __end_cc_report 16:44:41 INFO - PROCESS | 1666 | __startTimestamp1467243881341__endTimestamp 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | ------- Summary: start ------- 16:44:41 INFO - PROCESS | 1666 | Number of tests: 6 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5757.85 Median:5941.94 stddev:646.89 (10.9%) stddev-sans-first:620.16 16:44:41 INFO - PROCESS | 1666 | Values: 3328.3 3339.7 3370.2 3381.1 3403.4 5564.0 5663.9 5681.7 5732.5 5757.9 5704.4 5709.3 5804.5 5816.7 5847.6 5099.6 5121.1 5177.6 5177.8 5268.9 5272.1 5303.2 5311.9 5312.5 5335.8 5141.4 5172.5 5188.0 5198.4 5236.7 5199.4 5199.7 5199.7 5202.8 5227.0 5106.7 5167.0 5174.0 5206.5 5210.9 5738.7 5754.7 5757.7 5765.7 5771.6 6207.8 6239.9 6291.7 6308.0 6323.6 6157.8 6174.6 6301.4 6307.5 6392.1 5859.1 5863.4 5871.5 5878.6 5881.1 6320.2 6331.1 6336.4 6344.5 6348.2 6023.2 6061.2 6082.3 6091.7 6127.4 6303.5 6353.3 6356.1 6362.3 6365.6 6217.5 6278.4 6285.4 6290.7 6298.0 6098.7 6177.1 6255.3 6311.0 6314.2 4910.6 4944.3 4947.6 4953.6 4971.4 4417.9 4419.3 4433.7 4437.8 4468.8 5626.1 5639.5 5721.7 5733.9 5758.0 6122.2 6164.3 6196.6 6260.7 6273.2 5674.5 5674.9 5692.0 5701.0 5728.5 5352.8 5391.0 5399.7 5404.4 5404.7 6252.3 6300.8 6312.4 6337.8 6356.3 6337.9 6346.3 6360.3 6360.4 6376.3 6221.5 6276.4 6300.5 6327.7 6348.4 6134.3 6217.1 6240.7 6244.7 6250.0 6318.3 6326.8 6328.5 6339.2 6370.5 5954.5 6003.1 6021.4 6120.7 6136.9 5505.9 6056.1 6088.2 6097.8 6135.3 5476.5 5770.9 5889.5 5890.8 5941.9 5829.9 5893.2 6078.6 6100.1 6101.3 5977.6 5985.4 6002.7 6036.5 6044.0 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:54757.83 Median:35282.79 stddev:105135.43 (298.0%) stddev-sans-first:105351.32 16:44:41 INFO - PROCESS | 1666 | Values: 457.9 479.9 530.4 531.2 548.7 30964.2 41637.0 42606.4 42722.6 45252.8 43798.6 44184.8 44286.1 44329.8 44338.1 8573.6 9607.8 9807.3 9807.5 9810.2 8746.3 11846.1 11971.5 11976.3 12212.1 11931.7 11978.6 12005.0 12005.1 12012.5 8703.7 11836.6 11919.9 11961.9 11985.2 11861.1 11941.2 11946.7 11953.8 11955.9 41583.2 41965.0 41990.2 42104.2 42254.0 3374.8 3585.8 3608.5 3744.3 4078.6 30709.4 30801.2 33078.4 33102.8 33189.3 3178.3 3347.1 3394.8 3404.0 3459.7 496780.0 502915.0 503635.0 504509.0 504531.5 63704.0 64975.0 64985.0 64999.4 65026.7 68065.0 68240.0 68252.3 68315.7 68467.7 16236.9 16450.8 16468.8 16470.4 16479.6 11223.4 11464.1 11480.4 11688.4 12481.5 17431.5 19433.5 20311.8 20327.7 20338.0 7531.6 7537.0 7559.4 7582.1 7661.8 848.8 957.8 986.7 1022.6 1053.8 24785.6 28047.0 29251.6 29947.9 31167.5 1073.1 1099.5 1130.2 1180.2 1204.3 15970.6 15970.8 15999.4 16130.2 16321.7 182169.0 183241.1 183446.1 183665.0 184384.0 59129.0 59290.7 59393.0 59426.0 59448.0 1201.7 1247.2 1376.0 1402.0 1408.7 31487.7 31494.5 31555.4 32421.7 32570.8 51581.7 51889.0 52161.7 52269.0 52321.7 423470.0 424011.9 428942.0 429768.0 430709.0 27308.0 27441.5 27742.0 27804.7 29181.7 48358.5 48866.3 49353.8 49711.0 49971.8 32420.7 40166.8 40517.8 40754.2 41570.6 39804.0 39967.0 40002.0 40312.8 40850.8 38411.2 39285.8 39488.2 39518.6 39523.8 33626.0 34347.8 35157.8 35407.8 35555.6 24233.5 24365.9 25555.5 25738.2 26517.0 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34719.66 Median:14380.58 stddev:98165.68 (682.6%) stddev-sans-first:98407.13 16:44:41 INFO - PROCESS | 1666 | Values: 347.7 380.5 384.4 384.6 405.9 15390.4 15772.7 20191.6 20779.4 20825.0 20759.8 20954.3 21164.9 21438.2 21572.9 5261.9 5639.8 5646.4 5828.4 5894.9 5871.4 5889.6 5950.4 5950.9 5955.7 5614.2 5806.2 5818.3 5819.7 5910.6 5728.9 5779.8 5783.9 5795.3 5804.0 4541.7 5066.7 5067.0 5069.7 5070.7 26285.5 26287.9 26313.9 26681.3 26811.7 2177.6 2183.5 2205.7 2475.7 2707.4 15155.7 15407.5 15951.0 16388.0 16572.3 1836.9 1843.6 1855.2 1918.0 1965.4 115593.3 121056.8 121146.2 122838.0 123810.4 10492.5 10835.0 10878.9 11172.2 11190.0 13638.8 13736.7 13784.0 13784.3 13801.9 7030.5 8452.0 8458.7 8560.1 8630.4 7243.6 8452.9 8559.4 8699.0 8712.3 5476.8 6521.6 6621.9 6627.1 6639.3 1813.1 1844.1 1851.8 1854.5 1883.3 845.7 923.5 930.5 936.5 953.5 22121.7 22660.1 22688.5 22705.2 22776.8 948.5 981.2 986.6 1004.9 1031.4 11041.7 11342.8 11828.9 11837.5 11927.5 478817.0 596043.0 602555.0 626718.0 627510.0 116446.0 117889.0 118203.0 118844.0 120421.0 1006.1 1064.7 1085.4 1090.3 1091.3 19638.2 20029.0 20032.5 20034.5 20063.7 52230.5 53054.2 53221.9 53641.4 53646.5 73163.0 74930.6 76217.0 77792.8 79986.2 7750.0 7909.4 8351.5 8400.1 8578.4 9278.9 13154.1 13335.3 13345.3 13373.7 11287.3 11501.2 11585.7 11697.6 11717.3 9628.7 10638.2 11149.9 11243.5 11285.8 11692.8 11759.4 11884.5 11899.8 11957.1 8247.5 8313.4 8351.4 8363.4 8365.5 8372.5 9362.2 9685.8 11444.8 11655.5 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5611.53 Median:4696.63 stddev:3165.39 (67.4%) stddev-sans-first:3158.09 16:44:41 INFO - PROCESS | 1666 | Values: 1354.2 1492.4 1529.8 1701.9 1869.3 7754.3 8215.8 8220.5 8221.3 8236.9 8331.2 8558.1 8593.0 8690.0 8714.0 2277.1 2358.7 2359.0 2359.9 2360.1 2318.0 2360.2 2361.7 2364.7 2367.3 2156.8 2202.7 2346.1 2361.9 2365.4 2304.4 2332.2 2341.1 2342.7 2346.0 2329.9 2330.1 2335.2 2338.0 2357.7 8755.5 8800.8 8824.0 8856.1 8879.3 5141.4 5156.3 5301.2 5307.0 5324.4 3491.5 3559.5 3606.3 3614.6 3636.1 1044.9 1062.1 1080.2 1085.0 1085.5 11517.8 11615.5 11626.9 11640.7 11670.7 4357.3 4363.3 4561.0 4579.8 4602.1 9070.0 9072.2 9078.3 9082.5 9083.6 5195.4 5205.4 5208.0 5214.8 5217.0 4213.7 4354.5 4370.2 4514.7 4862.4 3681.1 3727.8 3748.0 3795.8 3796.3 1149.7 1158.9 1160.3 1162.6 1167.1 890.4 896.4 899.5 941.3 946.3 5800.2 5960.4 6040.9 6135.8 6186.9 406.9 424.2 431.8 434.1 450.1 4019.8 4029.3 4052.0 4090.4 4103.0 10067.5 10807.1 10842.9 10844.8 10883.8 9403.0 10650.4 10756.9 10785.3 10800.4 8063.8 8137.6 8154.7 8165.7 8198.9 5861.4 5862.0 5883.8 6002.1 6125.9 9720.9 10035.3 10042.5 10057.4 10085.2 9364.7 10339.8 10376.0 10389.2 10395.7 6621.5 6782.3 6793.7 6796.9 6799.4 6439.6 7983.3 7984.1 7995.7 8094.1 7494.5 7528.0 7558.3 7652.7 7677.9 7390.4 7414.1 7471.6 7526.2 7576.5 6767.8 7042.2 7105.8 7111.4 7173.2 4994.9 5052.1 5071.6 5084.4 5187.2 4791.2 5058.2 5058.6 5274.7 5281.4 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4520.09 Median:5182.31 stddev:1419.78 (27.4%) stddev-sans-first:1388.01 16:44:41 INFO - PROCESS | 1666 | Values: 301.8 306.3 309.1 314.0 317.2 4368.7 4451.3 5037.5 5334.2 5349.7 5106.7 5344.9 5392.5 5411.0 5415.3 3190.5 3693.4 3861.0 4017.2 4099.4 3495.6 3646.2 4054.7 4056.5 4078.6 4041.4 4047.9 4052.8 4062.2 4080.9 3803.3 3830.8 3965.4 4029.3 4051.6 3090.6 3411.9 3459.0 3465.5 3505.9 3757.4 4271.9 4644.6 5172.3 5202.5 4234.4 4259.3 4607.3 4624.2 4662.2 4872.2 5453.5 5640.4 5658.7 5668.0 3591.8 3832.8 3848.3 3854.4 3864.8 5377.1 5537.6 5909.9 5916.5 5937.1 3069.1 3876.5 3880.4 3880.6 3889.1 3313.9 3772.0 3945.4 3963.0 3978.2 3823.5 4501.0 4594.5 4623.7 4649.2 5310.2 5408.6 5673.3 5695.9 5701.6 1252.9 1315.6 1343.4 1345.6 1349.7 653.3 734.3 817.6 822.2 827.8 4350.4 5039.8 5299.0 5300.5 5312.2 4788.0 5799.6 5818.9 5876.4 5877.8 4989.5 5192.4 5235.3 5240.6 5316.9 2606.3 2833.8 2952.6 2977.1 3028.3 4588.6 5069.5 5953.0 5975.6 6066.8 5263.0 5547.4 5611.4 5852.0 5899.4 5308.5 5328.4 5758.4 5885.9 5920.7 4826.0 5646.0 5737.7 5759.6 5795.9 5404.6 5788.7 5803.7 5817.9 5819.9 4886.8 5953.3 6034.8 6052.6 6080.4 3676.5 3861.9 3878.8 3885.8 3953.4 4948.0 5508.4 5850.0 5867.5 5872.3 5350.6 5370.6 5633.1 5718.6 5731.1 5130.8 5150.9 5477.2 5654.2 5730.9 5241.4 5459.3 5497.3 5506.6 5514.4 4529.8 5354.9 5535.3 5699.6 5718.3 5341.3 5552.9 5619.3 5626.3 5633.5 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:23532.31 Median:3938.61 stddev:36374.63 (923.5%) stddev-sans-first:36436.35 16:44:41 INFO - PROCESS | 1666 | Values: 720.7 780.4 788.4 831.1 840.8 15061.5 15619.2 16142.3 16175.9 16204.8 14355.9 14594.4 14596.3 14624.4 14681.4 682.0 712.8 843.2 864.7 890.5 877.3 885.9 887.4 888.2 892.0 898.7 921.6 934.1 941.4 947.3 709.4 870.1 936.5 937.7 940.8 697.4 699.1 699.2 700.3 700.5 14611.9 14630.3 14648.4 14666.8 14699.9 13896.9 14017.5 14027.2 14122.2 14134.9 11775.6 11803.6 11828.9 11835.6 11944.4 4603.5 4628.6 4642.8 4800.8 4805.5 107021.0 107388.0 107715.5 107788.0 109710.0 10578.7 11109.3 11254.5 11430.9 11575.6 20387.5 22156.2 22179.7 22192.6 22206.2 7873.8 7887.4 8053.2 8100.7 8113.2 4389.4 4401.3 4443.2 4448.2 4617.3 3359.8 3483.1 3484.0 3487.7 3487.8 660.5 661.5 698.1 710.1 715.3 577.2 619.2 678.7 700.8 705.7 8999.5 9214.8 9414.3 9742.2 10399.8 569.7 626.9 671.7 687.8 713.5 4449.8 4550.7 4596.8 4625.7 4729.8 94825.0 124208.0 130868.0 153853.0 157042.0 83789.6 83791.2 104669.5 127672.0 132501.0 98605.9 110015.4 110729.0 113325.2 113570.7 8980.9 9080.4 9109.7 9134.0 9227.1 57861.0 61465.0 61479.0 63917.4 64001.9 54175.5 77433.8 91012.1 92527.5 94317.0 13113.8 13286.9 13383.3 13572.3 13601.9 14998.3 15358.4 15372.5 15759.0 15870.6 13836.7 13840.4 14093.6 14525.5 14684.8 14098.0 14274.9 14296.3 14299.4 14751.7 13669.3 13866.0 13994.9 14167.5 14535.6 9664.3 10176.8 10783.2 10822.0 10902.7 10461.4 10864.8 11151.4 11199.0 11205.5 16:44:41 INFO - PROCESS | 1666 | -------- Summary: end -------- 16:44:41 INFO - PROCESS | 1666 | 16:44:41 INFO - TEST-INFO | 1666: exit 0 16:44:41 INFO - TEST-OK | dromaeo_css | took 1116994ms 16:44:41 INFO - TEST-START | kraken 16:44:41 INFO - operating with platform_type : mac_ 16:44:41 INFO - Initialising browser for kraken test... 16:44:41 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpARLRSa/profile http://localhost:49271/getInfo.html) 16:44:44 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 16:44:44 INFO - PROCESS | 1672 | colorDepth:24 16:44:44 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 16:44:44 INFO - PROCESS | 1672 | __metrics 16:44:44 INFO - PROCESS | 1672 | 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" 16:44:44 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:44:44 INFO - TEST-INFO | 1672: exit 0 16:44:44 INFO - Browser initialized. 16:44:44 INFO - Running cycle 1/1 for kraken test... 16:44:44 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpARLRSa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:56 INFO - PROCESS | 1673 | RSS: Main: 243838976 16:44:56 INFO - PROCESS | 1673 | 16:44:59 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:45:00 INFO - PROCESS | 1673 | RSS: Main: 294146048 16:45:00 INFO - PROCESS | 1673 | 16:45:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:45:03 INFO - PROCESS | 1673 | RSS: Main: 304373760 16:45:03 INFO - PROCESS | 1673 | 16:45:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:45:07 INFO - PROCESS | 1673 | RSS: Main: 390291456 16:45:07 INFO - PROCESS | 1673 | 16:45:09 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:45:10 INFO - PROCESS | 1673 | RSS: Main: 292847616 16:45:10 INFO - PROCESS | 1673 | 16:45:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:45:13 INFO - PROCESS | 1673 | RSS: Main: 296587264 16:45:13 INFO - PROCESS | 1673 | 16:45:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:45:16 INFO - PROCESS | 1673 | RSS: Main: 331030528 16:45:16 INFO - PROCESS | 1673 | 16:45:19 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:45:19 INFO - PROCESS | 1673 | RSS: Main: 333975552 16:45:19 INFO - PROCESS | 1673 | 16:45:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:45:23 INFO - PROCESS | 1673 | RSS: Main: 335224832 16:45:23 INFO - PROCESS | 1673 | 16:45:24 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:45:25 INFO - PROCESS | 1673 | RSS: Main: 313237504 16:45:25 INFO - PROCESS | 1673 | 16:45:27 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:45:27 INFO - PROCESS | 1673 | RSS: Main: 319455232 16:45:27 INFO - PROCESS | 1673 | 16:45:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:45:30 INFO - PROCESS | 1673 | RSS: Main: 318029824 16:45:30 INFO - PROCESS | 1673 | 16:45:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:45:34 INFO - PROCESS | 1673 | RSS: Main: 326316032 16:45:34 INFO - PROCESS | 1673 | 16:45:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:45:37 INFO - PROCESS | 1673 | RSS: Main: 328781824 16:45:37 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:45:39 INFO - PROCESS | 1673 | RSS: Main: 372178944 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | __start_tp_report 16:45:39 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 16:45:39 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 16:45:39 INFO - PROCESS | 1673 | |i|pagename|runs| 16:45:39 INFO - PROCESS | 1673 | |0;ai-astar;100;112;115;112;113;112;112;113;112;113 16:45:39 INFO - PROCESS | 1673 | |1;audio-beat-detection;139;108;107;153;106;105;124;104;137;105 16:45:39 INFO - PROCESS | 1673 | |2;audio-dft;183;185;184;183;183;183;184;181;183;183 16:45:39 INFO - PROCESS | 1673 | |3;audio-fft;78;74;63;95;61;79;82;71;95;60 16:45:39 INFO - PROCESS | 1673 | |4;audio-oscillator;84;94;93;69;71;86;124;99;80;101 16:45:39 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;87;84;87;84;87;84;88;84;87;84 16:45:39 INFO - PROCESS | 1673 | |6;imaging-darkroom;93;96;94;96;93;93;94;93;93;93 16:45:39 INFO - PROCESS | 1673 | |7;imaging-desaturate;84;84;85;84;84;85;81;86;83;84 16:45:39 INFO - PROCESS | 1673 | |8;json-parse-financial;54;54;54;54;55;53;54;52;56;56 16:45:39 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;65;66;77;76;72;71;69;70;70;73 16:45:39 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;82;82;81;80;84;83;83;82;82;85 16:45:39 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;137;135;134;135;133;134;133;152;225;149 16:45:39 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;161;163;167;164;166;216;216;161;163;161 16:45:39 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;77;83;80;83;80;81;78;66;64 16:45:39 INFO - PROCESS | 1673 | __end_tp_report 16:45:39 INFO - PROCESS | 1673 | __start_cc_report 16:45:39 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1964 16:45:39 INFO - PROCESS | 1673 | __end_cc_report 16:45:39 INFO - PROCESS | 1673 | __startTimestamp1467243939808__endTimestamp 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | ------- Summary: start ------- 16:45:39 INFO - PROCESS | 1673 | Number of tests: 14 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:4.12 (3.7%) stddev-sans-first:1.00 16:45:39 INFO - PROCESS | 1673 | Values: 100.0 112.0 115.0 112.0 113.0 112.0 112.0 113.0 112.0 113.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:116.00 stddev:18.12 (15.6%) stddev-sans-first:17.69 16:45:39 INFO - PROCESS | 1673 | Values: 139.0 108.0 107.0 153.0 106.0 105.0 124.0 104.0 137.0 105.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 16:45:39 INFO - PROCESS | 1673 | Values: 183.0 185.0 184.0 183.0 183.0 183.0 184.0 181.0 183.0 183.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:75.80 Median:78.50 stddev:12.69 (16.2%) stddev-sans-first:13.44 16:45:39 INFO - PROCESS | 1673 | Values: 78.0 74.0 63.0 95.0 61.0 79.0 82.0 71.0 95.0 60.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:85.00 stddev:16.11 (19.0%) stddev-sans-first:16.94 16:45:39 INFO - PROCESS | 1673 | Values: 84.0 94.0 93.0 69.0 71.0 86.0 124.0 99.0 80.0 101.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:87.00 stddev:1.71 (2.0%) stddev-sans-first:1.74 16:45:39 INFO - PROCESS | 1673 | Values: 87.0 84.0 87.0 84.0 87.0 84.0 88.0 84.0 87.0 84.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:93.50 stddev:1.23 (1.3%) stddev-sans-first:1.27 16:45:39 INFO - PROCESS | 1673 | Values: 93.0 96.0 94.0 96.0 93.0 93.0 94.0 93.0 93.0 93.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.33 (1.6%) stddev-sans-first:1.41 16:45:39 INFO - PROCESS | 1673 | Values: 84.0 84.0 85.0 84.0 84.0 85.0 81.0 86.0 83.0 84.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.30 16:45:39 INFO - PROCESS | 1673 | Values: 54.0 54.0 54.0 54.0 55.0 53.0 54.0 52.0 56.0 56.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:3.84 (5.4%) stddev-sans-first:3.43 16:45:39 INFO - PROCESS | 1673 | Values: 65.0 66.0 77.0 76.0 72.0 71.0 69.0 70.0 70.0 73.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.43 (1.7%) stddev-sans-first:1.51 16:45:39 INFO - PROCESS | 1673 | Values: 82.0 82.0 81.0 80.0 84.0 83.0 83.0 82.0 82.0 85.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:136.00 stddev:28.34 (20.8%) stddev-sans-first:29.84 16:45:39 INFO - PROCESS | 1673 | Values: 137.0 135.0 134.0 135.0 133.0 134.0 133.0 152.0 225.0 149.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:165.00 stddev:22.33 (13.5%) stddev-sans-first:23.20 16:45:39 INFO - PROCESS | 1673 | Values: 161.0 163.0 167.0 164.0 166.0 216.0 216.0 161.0 163.0 161.0 16:45:39 INFO - PROCESS | 1673 | 16:45:39 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:80.00 stddev:7.48 (9.4%) stddev-sans-first:7.04 16:45:39 INFO - PROCESS | 1673 | Values: 66.0 77.0 83.0 80.0 83.0 80.0 81.0 78.0 66.0 64.0 16:45:39 INFO - PROCESS | 1673 | -------- Summary: end -------- 16:45:39 INFO - PROCESS | 1673 | 16:45:40 INFO - TEST-INFO | 1673: exit 0 16:45:40 INFO - TEST-OK | kraken | took 58661ms 16:45:40 INFO - SUITE-END | took 1175s 16:45:40 INFO - Completed test suite (00:19:35) 16:45:40 INFO - javascript benchmark 16:45:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.2511434927146, 3339.6994270515665, 3370.1743072947133, 3381.120908563773, 3403.421418358879, 5564.0, 5663.9433605663935, 5681.687507187114, 5732.512736417404, 5757.884842303151, 5704.401037891013, 5709.343425506068, 5804.477597016278, 5816.709164541777, 5847.590668653196, 5099.643024988252, 5121.12940800063, 5177.559907407875, 5177.792888284483, 5268.9473105269035, 5272.103742363807, 5303.15149576066, 5311.893762124755, 5312.521873031426, 5335.759890804923, 5141.4087379951225, 5172.508611681884, 5188.0, 5198.40218374888, 5236.659617124875, 5199.428062913076, 5199.66202196856, 5199.714015729133, 5202.765875535572, 5227.032998895179, 5106.719130447824, 5167.0, 5174.0, 5206.453322401169, 5210.869728256824, 5738.6556806591325, 5754.683492407916, 5757.712114394305, 5765.682887441189, 5771.624844385102, 6207.782727604557, 6239.906401403982, 6291.653959032297, 6307.990721484586, 6323.557350985433, 6157.78447754331, 6174.598651087665, 6301.40136687014, 6307.4954003679595, 6392.1370614966845, 5859.062549991981, 5863.384344643794, 5871.530277577784, 5878.647281163144, 5881.117832325185, 6320.209973753281, 6331.05034244867, 6336.366363363627, 6344.49244060474, 6348.238211414659, 6023.156758053876, 6061.207773834101, 6082.330943596201, 6091.664958427329, 6127.356627554132, 6303.527235457359, 6353.30113687494, 6356.14192084072, 6362.268339141058, 6365.649889256136, 6217.502599792006, 6278.372162783685, 6285.43431091204, 6290.748370065237, 6298.0, 6098.710785140803, 6177.104319873683, 6255.343188965093, 6310.968445157837, 6314.210723659543, 4910.607151427877, 4944.307796908436, 4947.5794557462295, 4953.554180123806, 4971.37857767779, 4417.889552761207, 4419.270820314612, 4433.667474939392, 4437.755923424243, 4468.843590474317, 5626.127950167731, 5639.520640745501, 5721.656700597978, 5733.885322293614, 5757.971210143923, 6122.215193971364, 6164.260288765377, 6196.628202307876, 6260.686965651699, 6273.153124328157, 5674.546036317085, 5674.943250567524, 5691.971540142273, 5701.0, 5728.48443640066, 5352.839414817562, 5391.029614669397, 5399.7300134993875, 5404.432534583891, 5404.729763511808, 6252.3122456529745, 6300.810975670737, 6312.368763123651, 6337.809865704036, 6356.269029061532, 6337.873242535031, 6346.301906790157, 6360.332165122781, 6360.395762402564, 6376.266729326001, 6221.5333849962335, 6276.403741644536, 6300.527460440394, 6327.683615819283, 6348.365163483615, 6134.283518479682, 6217.129601855653, 6240.656763878031, 6244.718987645658, 6249.968755155349, 6318.273398559225, 6326.778562750282, 6328.525360597881, 6339.207599050119, 6370.458511026614, 5954.523638108854, 6003.099535069599, 6021.42796434338, 6120.724567394389, 6136.8772624548155, 5505.926344362971, 6056.06131049688, 6088.178095957166, 6097.827165393427, 6135.325114237341, 5476.507114359727, 5770.855728606818, 5889.49939255151, 5890.764369425175, 5941.940580594139, 5829.883402332014, 5893.174955506147, 6078.589965612492, 6100.066499260575, 6101.2909632572, 5977.6114552553945, 5985.371535988658, 6002.699865006645, 6036.517078633787, 6044.0], "value": 5715.364357468328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.91986402379575, 479.88722650177203, 530.3953493017958, 531.2323692264678, 548.747576114987, 30964.225894352654, 41636.959076023115, 42606.36090458646, 42722.572774272245, 45252.773736131356, 43798.562014379844, 44184.779076104656, 44286.11427771451, 44329.7783511082, 44338.113237735226, 8573.614187361583, 9607.807843843137, 9807.31348805584, 9807.509624518745, 9810.166135878459, 8746.25656819168, 11846.052315814713, 11971.521139154424, 11976.28142311464, 12212.145149839514, 11931.701707457296, 11978.580749673763, 12004.979576735988, 12005.099617528676, 12012.519499220021, 8703.695370661997, 11836.585719499777, 11919.940400297986, 11961.940190298992, 11985.161038727336, 11861.051115910706, 11941.164118511708, 11946.701332466671, 11953.760924781456, 11955.880441195564, 41583.168336633404, 41965.0, 41990.1601967962, 42104.157916841796, 42254.0, 3374.7975121492545, 3585.784852908808, 3608.5128507651393, 3744.2698673758628, 4078.6125318094732, 30709.38581228363, 30801.229969250722, 33078.353731701405, 33102.834485827654, 33189.3362132756, 3178.3484385700876, 3347.062822409729, 3394.8132852693093, 3403.9659603404143, 3459.7405194610255, 496780.0, 502915.0, 503635.0, 504509.0, 504531.4773426146, 63704.0, 64975.025374618475, 64985.0, 64999.35000650027, 65026.67486662631, 68065.0, 68240.0, 68252.31747682558, 68315.65842170856, 68467.65766171138, 16236.918815405847, 16450.75323870143, 16468.752968705478, 16470.42353517645, 16479.588010299838, 11223.438828058564, 11464.140189485823, 11480.425978701032, 11688.357140357362, 12481.500739970299, 17431.453836983826, 19433.51416214606, 20311.796882031285, 20327.695084573745, 20338.0, 7531.623418829036, 7536.962315188389, 7559.433042521833, 7582.128055273714, 7661.770146895602, 848.7878030492377, 957.8323793336139, 986.7089208683456, 1022.5858527296457, 1053.8208504554243, 24785.62821557678, 28047.0183543575, 29251.62603248068, 29947.850260748557, 31167.53248701226, 1073.120041565924, 1099.455769394155, 1130.22014809781, 1180.15029178991, 1204.3135412814786, 15970.60073498172, 15970.76043859343, 15999.360025599079, 16130.156422689724, 16321.673566528603, 182169.0, 183241.08379458284, 183446.0827695853, 183665.0, 184384.0, 59129.0, 59290.70354648199, 59393.0, 59426.0, 59448.0, 1201.6815543880878, 1247.1643998521013, 1376.0436496634943, 1402.0466083063616, 1408.7112142011067, 31487.685123149393, 31494.52758208583, 31555.36889262248, 32421.67578324281, 32570.83714581412, 51581.74209128931, 51889.0, 52161.7391913038, 52269.0, 52321.7383913078, 423470.0, 424011.87994059833, 428942.0, 429768.0, 430709.0, 27308.0, 27441.45117097607, 27742.0, 27804.74878630426, 29181.7081829179, 48358.516414836806, 48866.267005994225, 49353.75323123361, 49711.0, 49971.75014124906, 32420.675793241764, 40166.799166003984, 40517.79741101393, 40754.1849163021, 41570.58429415667, 39804.0, 39967.0, 40002.0, 40312.79843600763, 40850.808568071945, 38411.231775363776, 39285.8035709831, 39488.2102357957, 39518.60481395149, 39523.80238098906, 33626.0, 34347.767395119234, 35157.82421087878, 35407.760728374386, 35555.64444355523, 24233.51532969366, 24365.903534340643, 25555.505656103338, 25738.227853164433, 26517.0], "value": 19975.286703563488, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.6975031722402, 380.5319457067807, 384.37538999126417, 384.5500764105997, 405.8741790045086, 15390.384384624616, 15772.684546309067, 20191.596168076667, 20779.376618701444, 20824.958752062375, 20759.792402075975, 20954.26660066898, 21164.94175291237, 21438.24966126186, 21572.89213553934, 5261.8947621047555, 5639.843832014448, 5646.350669672999, 5828.388019257981, 5894.852628684296, 5871.383504732005, 5889.6171748836405, 5950.434708702688, 5950.851228719295, 5955.70221488926, 5614.242077319571, 5806.245188125537, 5818.301803783552, 5819.709014549277, 5910.556708246899, 5728.856778580548, 5779.826605201809, 5783.855403614923, 5795.3045634523705, 5803.970980145094, 4541.682082254243, 5066.721330326831, 5067.0, 5069.670471419383, 5070.7464626768515, 26285.47429051408, 26287.868560657073, 26313.868430657916, 26681.332966675793, 26811.731882681117, 2177.5536015116863, 2183.4868805830615, 2205.669149627569, 2475.6905386826647, 2707.4179051503825, 15155.696886062327, 15407.537773866801, 15950.9631873929, 16388.0167189969, 16572.254248558846, 1836.8714190006706, 1843.64970655575, 1855.2115350975782, 1918.0, 1965.3710812539994, 115593.26610100856, 121056.78943210543, 121146.18280725884, 122838.0, 123810.38094809468, 10492.534254450198, 10835.0, 10878.891211087946, 11172.162087843444, 11190.04884584803, 13638.795418068737, 13736.725265494633, 13784.035117541676, 13784.310784460937, 13801.930990345185, 7030.543014704028, 8451.957740211259, 8458.661653533913, 8560.0583935767, 8630.395872289006, 7243.637818109073, 8452.8732069019, 8559.400841941004, 8698.956505217433, 8712.346574006975, 5476.780928762884, 6521.64130972801, 6621.9337806621315, 6627.10534077903, 6639.302873198245, 1813.1296977450897, 1844.087176847469, 1851.8333349998566, 1854.5178253654146, 1883.2749391484103, 845.7124577643631, 923.5243849417556, 930.4556834251903, 936.4708939449189, 953.4755884263627, 22121.66817497739, 22660.093596256294, 22688.546229075328, 22705.205317813798, 22776.772232277795, 948.4688574398359, 981.2052237687496, 986.605357856863, 1004.864343313658, 1031.437866362834, 11041.674999000172, 11342.773144537063, 11828.940855295668, 11837.526498939946, 11927.522899084113, 478817.0, 596043.0, 602555.0, 626718.0, 627510.0, 116446.0, 117889.0, 118203.0, 118844.0, 120421.0, 1006.059334522224, 1064.7338165458636, 1085.4247248958065, 1090.3185509056839, 1091.2743025887696, 19638.214471420983, 20028.99855007273, 20032.499187519847, 20034.499137521678, 20063.69904451405, 52230.47769522256, 53054.204186936455, 53221.935561287784, 53641.39075827732, 53646.46353536415, 73163.0, 74930.6253468751, 76217.0, 77792.8331075023, 79986.20013799788, 7750.0, 7909.406794490321, 8351.457155284887, 8400.075991641037, 8578.4424012439, 9278.907210927804, 13154.144980576231, 13335.333233338488, 13345.332733363099, 13373.732525349633, 11287.322760634388, 11501.194916355775, 11585.6524304271, 11697.590584329508, 11717.296962182296, 9628.71113866585, 10638.202134839763, 11149.944250278697, 11243.49404276826, 11285.774284514428, 11692.766144677229, 11759.412029398667, 11884.465199066235, 11899.76200476003, 11957.103217258566, 8247.463914845515, 8313.376496762889, 8351.373646976379, 8363.414560980673, 8365.539895305817, 8372.455790373606, 9362.157405833508, 9685.806283874424, 11444.82832757526, 11655.53377864876], "value": 9760.278258818153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.2145555577765, 1492.3657445585623, 1529.839366866479, 1701.880868339216, 1869.336385583118, 7754.340881025112, 8215.794605134859, 8220.465669731464, 8221.3011893989, 8236.876446853286, 8331.166883311666, 8558.101399353072, 8593.0, 8690.04409514953, 8714.0, 2277.055022165799, 2358.7169539655265, 2358.9646155307682, 2359.929202123939, 2360.0913648245464, 2318.0380142241033, 2360.1975328388344, 2361.669366288721, 2364.6807680963107, 2367.3016460144213, 2156.8382371322136, 2202.6695995600626, 2346.0615753698485, 2361.89371478283, 2365.3849999000213, 2304.43541332373, 2332.2303639798824, 2341.063574570177, 2342.7422983471806, 2346.0498498108295, 2329.94175145621, 2330.079618550663, 2335.2177020698086, 2338.0414030247516, 2357.728861180969, 8755.518446485441, 8800.823983520359, 8824.0, 8856.114388561156, 8879.289656827503, 5141.357330333708, 5156.278121063054, 5301.1783173608155, 5306.973465132688, 5324.361076670785, 3491.5286436331025, 3559.4660800879815, 3606.296772129436, 3614.6023937366867, 3636.1273294409416, 1044.8693913260843, 1062.0706881478707, 1080.2330345454736, 1085.0072183951754, 1085.5440714899762, 11517.827232591519, 11615.477303521362, 11626.883731162749, 11640.650780476599, 11670.708232294175, 4357.281048626941, 4363.301871700576, 4560.977195114003, 4579.816807327669, 4602.079584083197, 9069.954650226839, 9072.228860546795, 9078.273738101068, 9082.45505269686, 9083.591238394289, 5195.350581177353, 5205.375354957354, 5208.0104780092415, 5214.765335559909, 5216.973915130476, 4213.705040647125, 4354.521002689701, 4370.235208838504, 4514.70654407469, 4862.3922009748785, 3681.079730067483, 3727.7576957497677, 3748.044248716614, 3795.772253664789, 3796.2976849282973, 1149.655103468956, 1158.8551431071116, 1160.280626011878, 1162.5698491558178, 1167.0780083733755, 890.3633901760272, 896.4173287363266, 899.4603238057244, 941.3081385181886, 946.3422921069928, 5800.245968024215, 5960.374160713062, 6040.909386359208, 6135.7852475164045, 6186.938130618726, 406.86980166346484, 424.19826527862364, 431.83158568158444, 434.09058023440843, 450.0548847420391, 4019.7789121598594, 4029.2948733972025, 4052.0, 4090.427340172378, 4102.979485102555, 10067.496625168713, 10807.08139808125, 10842.891571084347, 10844.837327440095, 10883.782324353628, 9402.952985235166, 10650.360978341325, 10756.892431075588, 10785.298955567863, 10800.405977671146, 8063.798405039804, 8137.5931203439595, 8154.714584989615, 8165.673373065129, 8198.877016844752, 5861.384554621874, 5861.996957131323, 5883.764649414146, 6002.0996850472775, 6125.877482450237, 9720.854187187339, 10035.34770239932, 10042.49787510607, 10057.396556206651, 10085.193184545073, 9364.719058428258, 10339.844902326622, 10376.0, 10389.220808439246, 10395.740106497398, 6621.470282377302, 6782.253952065367, 6793.72825086991, 6796.898046529207, 6799.422049125682, 6439.613623182624, 7983.281504664608, 7984.121746607752, 7995.720149794729, 8094.069182044141, 7494.475386722877, 7527.962360188164, 7558.281963213486, 7652.693892244471, 7677.923220767944, 7390.445716571387, 7414.073240844895, 7471.551706897603, 7526.172121066569, 7576.469647124648, 6767.830804229934, 7042.154941407064, 7105.82235444118, 7111.43108551325, 7173.175084865307, 4994.900101997867, 5052.141136006814, 5071.619628527801, 5084.440711521804, 5187.24784906179, 4791.1854984652, 5058.190689489664, 5058.620603454682, 5274.657147285414, 5281.366236051698], "value": 4429.1864611822675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.8249415339103, 306.3108006984284, 309.07740394921166, 314.04217137729916, 317.18958062151194, 4368.694191406603, 4451.330750968387, 5037.546620804127, 5334.173203153513, 5349.726366294324, 5106.69359838409, 5344.893102137955, 5392.460753924605, 5410.972945135269, 5415.296011518507, 3190.5214217867388, 3693.445983102543, 3861.0, 4017.1721866550647, 4099.364598487239, 3495.580530336363, 3646.2342907989355, 4054.6553542948736, 4056.492938382702, 4078.5717499662555, 4041.4139949707424, 4047.907065092423, 4052.844939192331, 4062.2484840304637, 4080.87757367278, 3803.2773772983046, 3830.7701537907674, 3965.385365268388, 4029.2545879012478, 4051.5543290238347, 3090.644575873781, 3411.942297887663, 3459.0141809584397, 3465.549478567795, 3505.8948231553095, 3757.444937442538, 4271.893202669959, 4644.558766917137, 5172.27588137661, 5202.525827788099, 4234.36976763945, 4259.275923093051, 4607.285870690049, 4624.213883639789, 4662.230731929228, 4872.244802055687, 5453.454654534555, 5640.351359593658, 5658.745356458928, 5667.971660141714, 3591.8024508652015, 3832.7891965941863, 3848.2688289224957, 3854.421836724514, 3864.787436690981, 5377.139657654757, 5537.640053396516, 5909.852253693606, 5916.461719952843, 5937.109433584997, 3069.051152518167, 3876.5348158221195, 3880.4373365861793, 3880.631340022693, 3889.105505733697, 3313.867445302209, 3772.0, 3945.368741001426, 3963.0, 3978.1645854370904, 3823.483829682957, 4500.964071768193, 4594.471635761864, 4623.676342655982, 4649.209634362167, 5310.221075939527, 5408.621396502207, 5673.262475878109, 5695.857603559862, 5701.631608413951, 1252.9373531323397, 1315.6118944911275, 1343.3812256231217, 1345.5828693105168, 1349.7098123903409, 653.2618141500169, 734.3014421999131, 817.595290331278, 822.2271065198694, 827.7831587566268, 4350.412694286231, 5039.823606173766, 5298.986385173609, 5300.469953004746, 5312.211089178212, 4788.0, 5799.60809405748, 5818.912716309259, 5876.412358764175, 5877.764889404461, 4989.451160372356, 5192.350956130484, 5235.293235413246, 5240.580753539708, 5316.893662126736, 2606.27024433159, 2833.844138572398, 2952.5680045178074, 2977.1392879450345, 3028.318628308613, 4588.632909367309, 5069.543741063322, 5953.0, 5975.551833612496, 6066.757329706762, 5262.973720124539, 5547.44525547442, 5611.37270191648, 5852.0, 5899.351071382144, 5308.548773354231, 5328.440513746078, 5758.395368486333, 5885.941140588539, 5920.733566989496, 4825.95174048255, 5646.0, 5737.684427356368, 5759.625624334405, 5795.884082318245, 5404.594655400782, 5788.652680839163, 5803.718616059366, 5817.9127313091185, 5819.912701309399, 4886.755662216804, 5953.315368732651, 6034.788782392595, 6052.636841789506, 6080.422359875804, 3676.5036720042453, 3861.9034524137123, 3878.786666733357, 3885.7862817545306, 3953.3872249801325, 4947.985662939161, 5508.394076651485, 5849.970750146222, 5867.471927526543, 5872.29532456108, 5350.6254562180275, 5370.597205209703, 5633.126865335879, 5718.628289161191, 5731.054376027909, 5130.768615532171, 5150.871228219325, 5477.178423236546, 5654.180143879033, 5730.885382292414, 5241.371035475768, 5459.344878614592, 5497.312835895513, 5506.614536982373, 5514.420985796433, 4529.822246215942, 5354.892902142014, 5535.308086489189, 5699.601027928005, 5718.342390625131, 5341.332333458317, 5552.861178470571, 5619.269494965628, 5626.2967129108865, 5633.492985631313], "value": 4061.4687588470933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.700909122714, 780.3718007004363, 788.4008153803107, 831.0816547714774, 840.8024114333127, 15061.548153555397, 15619.219039048045, 16142.273597688103, 16175.919120404382, 16204.83795162048, 14355.928220358883, 14594.41622335108, 14596.343164557595, 14624.415023399051, 14681.412743490275, 681.9556728812636, 712.8396110875037, 843.2200214801314, 864.7146441674248, 890.5235698901089, 877.2630989968425, 885.8582626779717, 887.3832686283035, 888.2449917570046, 892.0366004714924, 898.6944438890775, 921.5576523268802, 934.0612684252317, 941.4022095969075, 947.313197931501, 709.4324540367737, 870.0907551608584, 936.5457752989795, 937.6624415210553, 940.8306504829128, 697.438561957624, 699.1470406104544, 699.192432740186, 700.3066963705945, 700.4711442860659, 14611.853881461155, 14630.341634626468, 14648.414063437449, 14666.779998300033, 14699.853001469955, 13896.93051534746, 14017.509387171502, 14027.1583704977, 14122.22327771972, 14134.92932535341, 11775.646730598095, 11803.645890623295, 11828.88171118295, 11835.644930652094, 11944.35187441873, 4603.539646035403, 4628.606568441686, 4642.837500687459, 4800.831970881038, 4805.471398146201, 107021.0, 107388.0, 107715.46142269317, 107788.0, 109710.0, 10578.735531611772, 11109.333439993627, 11254.549818007352, 11430.942845285721, 11575.569130482525, 20387.490312742004, 22156.22453214162, 22179.66730499044, 22192.556148877255, 22206.222782202545, 7873.763787086396, 7887.408444366695, 8053.1946805319, 8100.716474923467, 8113.229243221885, 4389.385486031958, 4401.2517871961845, 4443.2224360736745, 4448.199324121689, 4617.284320930261, 3359.8152101634646, 3483.1466290758926, 3483.982580087134, 3487.7035451986867, 3487.843047062888, 660.5046215338496, 661.4576047640888, 698.1099098649162, 710.1265443504415, 715.3347386930205, 577.1948132355425, 619.2290598205174, 678.6913795248165, 700.8212905709114, 705.6859697434695, 8999.460032398078, 9214.76963075915, 9414.340996130206, 9742.220622350194, 10399.84400233997, 569.6610516742531, 626.9090981807612, 671.7313074770132, 687.7867860963117, 713.4871935011075, 4449.7997590108525, 4550.749708765983, 4596.793144308447, 4625.699329543636, 4729.810807567727, 94825.0, 124208.0, 130868.0, 153853.0, 157042.0, 83789.58105209435, 83791.16208837833, 104669.47665261626, 127672.0, 132501.0, 98605.88165352237, 110015.44992274987, 110729.0, 113325.20536445906, 113570.72858542617, 8980.86528702057, 9080.364374493985, 9109.726708198765, 9133.954330228305, 9227.123423274777, 57861.0, 61465.0, 61479.0, 63917.36082639114, 64001.91981761725, 54175.45824541704, 77433.83849242154, 91012.08987910036, 92527.53736231275, 94317.0, 13113.803292950804, 13286.867131328563, 13383.330833458484, 13572.321383930566, 13601.944981679073, 14998.2500874958, 15358.38566457374, 15372.538823835303, 15759.0, 15870.60323491922, 13836.723265534432, 13840.446382145004, 14093.577192684235, 14525.4916077941, 14684.779728304298, 14098.013139080576, 14274.857251427768, 14296.285185740464, 14299.428022878968, 14751.704965900837, 13669.316534173451, 13866.0, 13994.930025349808, 14167.504137355143, 14535.636609084857, 9664.323497355117, 10176.847347289648, 10783.191260655325, 10822.0, 10902.727431814268, 10461.424621645578, 10864.782704345711, 11151.442427878736, 11199.0, 11205.495752690986], "value": 7862.294876155675, "unit": "score"}], "name": "dromaeo_css", "value": 7349.659855849505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 115.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 107.0, 153.0, 106.0, 105.0, 124.0, 104.0, 137.0, 105.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 184.0, 183.0, 183.0, 183.0, 184.0, 181.0, 183.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 63.0, 95.0, 61.0, 79.0, 82.0, 71.0, 95.0, 60.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 94.0, 93.0, 69.0, 71.0, 86.0, 124.0, 99.0, 80.0, 101.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 84.0, 88.0, 84.0, 87.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 96.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 81.0, 86.0, 83.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 54.0, 52.0, 56.0, 56.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 77.0, 76.0, 72.0, 71.0, 69.0, 70.0, 70.0, 73.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 80.0, 84.0, 83.0, 83.0, 82.0, 82.0, 85.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 134.0, 135.0, 133.0, 134.0, 133.0, 152.0, 225.0, 149.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 167.0, 164.0, 166.0, 216.0, 216.0, 161.0, 163.0, 161.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 83.0, 80.0, 83.0, 80.0, 81.0, 78.0, 66.0, 64.0], "value": 75.8, "unit": "score"}], "name": "kraken", "value": 1446.5, "alertThreshold": 2.0}]} 16:45:41 INFO - Return code: 0 16:45:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:45:41 INFO - # TBPL SUCCESS # 16:45:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:45:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:45:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:45:41 INFO - 2016-06-29 16:45:41.140 screenresolution[1677:10481] starting screenresolution argv=screenresolution get 16:45:41 INFO - 2016-06-29 16:45:41.142 screenresolution[1677:10481] Display 0: 1600x1200x32@60 16:45:41 INFO - 2016-06-29 16:45:41.148 screenresolution[1678:10484] starting screenresolution argv=screenresolution list 16:45:41 INFO - Available Modes on Display 0 16:45:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:45:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:45:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:45:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:45:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:45:41 INFO - Intel Iris: 16:45:41 INFO - Chipset Model: Intel Iris 16:45:41 INFO - Type: GPU 16:45:41 INFO - Bus: Built-In 16:45:41 INFO - VRAM (Dynamic, Max): 1536 MB 16:45:41 INFO - Vendor: Intel (0x8086) 16:45:41 INFO - Device ID: 0x0a2e 16:45:41 INFO - Revision ID: 0x0009 16:45:41 INFO - Displays: 16:45:41 INFO - Display: 16:45:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:45:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:45:41 INFO - Display Serial Number: 1600x1200 60 16:45:41 INFO - Main Display: Yes 16:45:41 INFO - Mirror: Off 16:45:41 INFO - Online: Yes 16:45:41 INFO - Rotation: Supported 16:45:41 INFO - Return code: 0 16:45:41 INFO - Running post-action listener: _resource_record_post_action 16:45:41 INFO - ##### 16:45:41 INFO - ##### Finished run-tests step (success) 16:45:41 INFO - ##### 16:45:41 INFO - Running post-run listener: _resource_record_post_run 16:45:41 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32714240; Write bytes: 705088512; Read time: 379; Write time: 2105 16:45:41 INFO - TinderboxPrint: CPU usage
53.6% 16:45:41 INFO - TinderboxPrint: I/O read bytes / time
32,714,240 / 379 16:45:41 INFO - TinderboxPrint: I/O write bytes / time
705,088,512 / 2,105 16:45:41 INFO - TinderboxPrint: CPU idle
2,249.5 (46.4%) 16:45:41 INFO - TinderboxPrint: CPU system
969.7 (20.0%) 16:45:41 INFO - TinderboxPrint: CPU user
1,626.5 (33.6%) 16:45:41 INFO - TinderboxPrint: Swap in / out
435,494,912 / 0 16:45:41 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392227328; Write bytes: 386484224; Read time: 29343; Write time: 803 16:45:41 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31792640; Write bytes: 294839296; Read time: 365; Write time: 1253 16:45:41 INFO - Running post-run listener: _upload_blobber_files 16:45:41 INFO - Blob upload gear active. 16:45:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:45:41 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 16:45:41 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'] 16:45:41 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 16:45:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:45:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:45:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:45:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:43 INFO - (blobuploader) - INFO - Done attempting. 16:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:45:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:44 INFO - (blobuploader) - INFO - Done attempting. 16:45:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:45:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:45:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:46 INFO - (blobuploader) - INFO - Done attempting. 16:45:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:45:46 INFO - Return code: 0 16:45:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:45:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:45:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5d21f1834b1aad7dd28a3a79cd7b624726a7f489c032a111fc0f5641f6f5dbf417f6a890ae1945592b58562b42fc466d67b8aee67171945b27d7e47564943179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e893d6fa6e4a2df6f3d48f72f45eb6378decf59685ce9e4ea7d8f429ae0f67d79b7f94d86a5ffa59e1a54ccd0a57e2c350bba88574e8d433eb524249d8b745ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4af9a57115b4fc5e68a86665b14608c32dfe61446a1cfc21ab34a206ccdd620c4d889317323bdb55c60e919ffc40b7837448678c1f6a7a57db7046eaa6a6e0db"} 16:45:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:45:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:45:46 INFO - Contents: 16:45:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5d21f1834b1aad7dd28a3a79cd7b624726a7f489c032a111fc0f5641f6f5dbf417f6a890ae1945592b58562b42fc466d67b8aee67171945b27d7e47564943179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e893d6fa6e4a2df6f3d48f72f45eb6378decf59685ce9e4ea7d8f429ae0f67d79b7f94d86a5ffa59e1a54ccd0a57e2c350bba88574e8d433eb524249d8b745ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4af9a57115b4fc5e68a86665b14608c32dfe61446a1cfc21ab34a206ccdd620c4d889317323bdb55c60e919ffc40b7837448678c1f6a7a57db7046eaa6a6e0db"} 16:45:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:45:46 INFO - Copying logs to upload dir... 16:45:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:45:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1658.100510 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 38 secs) (at 2016-06-29 16:45:46.862264) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:45:46.866148) ========= 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.5nLypWhZWf/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.iJRBAxdIJG/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/5d21f1834b1aad7dd28a3a79cd7b624726a7f489c032a111fc0f5641f6f5dbf417f6a890ae1945592b58562b42fc466d67b8aee67171945b27d7e47564943179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e893d6fa6e4a2df6f3d48f72f45eb6378decf59685ce9e4ea7d8f429ae0f67d79b7f94d86a5ffa59e1a54ccd0a57e2c350bba88574e8d433eb524249d8b745ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4af9a57115b4fc5e68a86665b14608c32dfe61446a1cfc21ab34a206ccdd620c4d889317323bdb55c60e919ffc40b7837448678c1f6a7a57db7046eaa6a6e0db"} build_url:https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/To2hmpkuSRuBaqyeErETyw/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/5d21f1834b1aad7dd28a3a79cd7b624726a7f489c032a111fc0f5641f6f5dbf417f6a890ae1945592b58562b42fc466d67b8aee67171945b27d7e47564943179", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e893d6fa6e4a2df6f3d48f72f45eb6378decf59685ce9e4ea7d8f429ae0f67d79b7f94d86a5ffa59e1a54ccd0a57e2c350bba88574e8d433eb524249d8b745ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4af9a57115b4fc5e68a86665b14608c32dfe61446a1cfc21ab34a206ccdd620c4d889317323bdb55c60e919ffc40b7837448678c1f6a7a57db7046eaa6a6e0db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:45:46.898007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:45:46.898323) ========= 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.5nLypWhZWf/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.iJRBAxdIJG/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.004481 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:45:46.947789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:45:46.948087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:45:46.948394) ========= ========= Total master_lag: 0.36 =========