builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1468354094.57 results: success (0) buildid: 20160712111626 builduid: c363b6bdd4724fbfb93586b8f19ba448 revision: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:14.575054) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:14.575487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:14.575778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:14.686803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 13:08:14.687419) ========= 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.jneSx0JIOE/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.R62zdz0ak6/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-12 13:08:14-- 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% 18.0M=0.001s 2016-07-12 13:08:15 (18.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.571612 ========= master_lag: 0.50 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 13:08:15.757329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:15.757636) ========= 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.jneSx0JIOE/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.R62zdz0ak6/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.025105 ========= master_lag: 0.60 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:16.387135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-12 13:08:16.387448) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jneSx0JIOE/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.R62zdz0ak6/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-12 13:08:16,719 truncating revision to first 12 chars 2016-07-12 13:08:16,720 Setting DEBUG logging. 2016-07-12 13:08:16,720 attempt 1/10 2016-07-12 13:08:16,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55922a4a546c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 13:08:17,952 unpacking tar archive at: fx-team-55922a4a546c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.508776 ========= master_lag: 1.87 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-12 13:08:19.762769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:19.763051) ========= script_repo_revision: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:19.763417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:19.763694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 13:08:19.807453) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-07-12 13:08:19.807712) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jneSx0JIOE/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.R62zdz0ak6/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:08:19 INFO - MultiFileLogger online at 20160712 13:08:19 in /builds/slave/test 13:08:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:08:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:08:19 INFO - {'append_to_log': False, 13:08:19 INFO - 'base_work_dir': '/builds/slave/test', 13:08:19 INFO - 'blob_upload_branch': 'Fx-Team', 13:08:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:08:19 INFO - 'branch': 'Fx-Team', 13:08:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:19 INFO - 'config_files': ('talos/mac_config.py',), 13:08:19 INFO - 'default_actions': ('clobber', 13:08:19 INFO - 'read-buildbot-config', 13:08:19 INFO - 'download-and-extract', 13:08:19 INFO - 'populate-webroot', 13:08:19 INFO - 'create-virtualenv', 13:08:19 INFO - 'install', 13:08:19 INFO - 'run-tests'), 13:08:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:08:19 INFO - 'download_minidump_stackwalk': True, 13:08:19 INFO - 'download_symbols': 'ondemand', 13:08:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:08:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:08:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:08:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:08:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:08:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:08:19 INFO - 'installer_path': 'installer.exe', 13:08:19 INFO - 'log_level': 'info', 13:08:19 INFO - 'log_name': 'talos', 13:08:19 INFO - 'log_to_console': True, 13:08:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:08:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:08:19 INFO - 'opt_config_files': (), 13:08:19 INFO - 'pip_index': False, 13:08:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:08:19 INFO - 'cmd': ('bash', 13:08:19 INFO - '-c', 13:08:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:08:19 INFO - 'enabled': True, 13:08:19 INFO - 'halt_on_failure': False, 13:08:19 INFO - 'name': 'check_screen_resolution'},), 13:08:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:08:19 INFO - 'cmd': ('bash', 13:08:19 INFO - '-c', 13:08:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:08:19 INFO - 'enabled': True, 13:08:19 INFO - 'halt_on_failure': False, 13:08:19 INFO - 'name': 'check_screen_resolution'},), 13:08:19 INFO - 'run_cmd_checks_enabled': True, 13:08:19 INFO - 'sps_profile': False, 13:08:19 INFO - 'sps_profile_interval': 0, 13:08:19 INFO - 'suite': 'dromaeojs', 13:08:19 INFO - 'system_bits': '32', 13:08:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:19 INFO - 'title': 't-yosemite-r7-0321', 13:08:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:08:19 INFO - 'use_talos_json': True, 13:08:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:08:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:19 INFO - 'work_dir': 'build'} 13:08:19 INFO - ##### 13:08:19 INFO - ##### Running clobber step. 13:08:19 INFO - ##### 13:08:19 INFO - Running pre-action listener: _resource_record_pre_action 13:08:19 INFO - Running main action method: clobber 13:08:19 INFO - rmtree: /builds/slave/test/build 13:08:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:08:21 INFO - Running post-action listener: _resource_record_post_action 13:08:21 INFO - ##### 13:08:21 INFO - ##### Finished clobber step (success) 13:08:21 INFO - ##### 13:08:21 INFO - ##### 13:08:21 INFO - ##### Running read-buildbot-config step. 13:08:21 INFO - ##### 13:08:21 INFO - Running pre-action listener: _resource_record_pre_action 13:08:21 INFO - Running main action method: read_buildbot_config 13:08:21 INFO - Using buildbot properties: 13:08:21 INFO - { 13:08:21 INFO - "project": "", 13:08:21 INFO - "product": "firefox", 13:08:21 INFO - "script_repo_revision": "production", 13:08:21 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:08:21 INFO - "repository": "", 13:08:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:08:21 INFO - "buildid": "20160712111626", 13:08:21 INFO - "pgo_build": "False", 13:08:21 INFO - "basedir": "/builds/slave/test", 13:08:21 INFO - "buildnumber": 886, 13:08:21 INFO - "slavename": "t-yosemite-r7-0321", 13:08:21 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:08:21 INFO - "platform": "yosemite_r7", 13:08:21 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:08:21 INFO - "branch": "fx-team", 13:08:21 INFO - "repo_path": "integration/fx-team", 13:08:21 INFO - "revision": "55922a4a546c9a6b5c6842aeb00b65c10b29bfc2", 13:08:21 INFO - "stage_platform": "macosx64", 13:08:21 INFO - "builduid": "c363b6bdd4724fbfb93586b8f19ba448", 13:08:21 INFO - "slavebuilddir": "test" 13:08:21 INFO - } 13:08:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 13:08:21 INFO - Running post-action listener: _resource_record_post_action 13:08:21 INFO - ##### 13:08:21 INFO - ##### Finished read-buildbot-config step (success) 13:08:21 INFO - ##### 13:08:21 INFO - ##### 13:08:21 INFO - ##### Running download-and-extract step. 13:08:21 INFO - ##### 13:08:21 INFO - Running pre-action listener: _resource_record_pre_action 13:08:21 INFO - Running main action method: download_and_extract 13:08:21 INFO - mkdir: /builds/slave/test/build/tests 13:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:08:21 INFO - https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:26 INFO - Downloaded 1199 bytes. 13:08:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:08:26 INFO - Using the following test package requirements: 13:08:26 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:08:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 13:08:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 13:08:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'jsshell-mac.zip'], 13:08:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 13:08:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:08:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 13:08:26 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 13:08:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 13:08:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:08:26 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 13:08:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:08:26 INFO - https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:36 INFO - Downloaded 18822324 bytes. 13:08:36 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'] 13:08:36 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 13:08:39 INFO - Return code: 0 13:08:39 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 13:08:39 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')]} 13:08:39 INFO - https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:44 INFO - Downloaded 18822324 bytes. 13:08:44 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'] 13:08:44 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 13:08:47 INFO - Return code: 0 13:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:47 INFO - https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:48 INFO - Downloaded 14403317 bytes. 13:08:48 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'] 13:08:48 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 13:08:49 INFO - Return code: 0 13:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:08:49 INFO - https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 13:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CRU5delrTC2rH9R7VKno4Q/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 13:08:56 INFO - Downloaded 112412478 bytes. 13:08:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:08:56 INFO - mkdir: /builds/slave/test/properties 13:08:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:56 INFO - Contents: 13:08:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:08:57 INFO - Running post-action listener: _resource_record_post_action 13:08:57 INFO - Running post-action listener: set_extra_try_arguments 13:08:57 INFO - ##### 13:08:57 INFO - ##### Finished download-and-extract step (success) 13:08:57 INFO - ##### 13:08:57 INFO - ##### 13:08:57 INFO - ##### Running populate-webroot step. 13:08:57 INFO - ##### 13:08:57 INFO - Running pre-action listener: _resource_record_pre_action 13:08:57 INFO - Running main action method: populate_webroot 13:08:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:57 INFO - '--tppagecycles', 13:08:57 INFO - '7'], 13:08:57 INFO - 'tests': ['tsvgm']}}, 13:08:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['damp', 'tps']}, 13:08:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'tests': ['damp', 'tps']}, 13:08:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['dromaeo_dom']}, 13:08:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['basic_compositor_video']}, 13:08:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:08:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['a11yr', 13:08:57 INFO - 'ts_paint', 13:08:57 INFO - 'tpaint', 13:08:57 INFO - 'sessionrestore', 13:08:57 INFO - 'sessionrestore_no_auto_restore', 13:08:57 INFO - 'tabpaint']}, 13:08:57 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:57 INFO - 'ts_paint', 13:08:57 INFO - 'tpaint', 13:08:57 INFO - 'sessionrestore', 13:08:57 INFO - 'sessionrestore_no_auto_restore', 13:08:57 INFO - 'tabpaint']}, 13:08:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:57 INFO - 'ts_paint', 13:08:57 INFO - 'tpaint', 13:08:57 INFO - 'sessionrestore', 13:08:57 INFO - 'sessionrestore_no_auto_restore', 13:08:57 INFO - 'tabpaint']}, 13:08:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:57 INFO - 'ts_paint', 13:08:57 INFO - 'tpaint', 13:08:57 INFO - 'sessionrestore', 13:08:57 INFO - 'sessionrestore_no_auto_restore', 13:08:57 INFO - 'tabpaint']}, 13:08:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['a11yr', 13:08:57 INFO - 'ts_paint', 13:08:57 INFO - 'tpaint', 13:08:57 INFO - 'sessionrestore', 13:08:57 INFO - 'sessionrestore_no_auto_restore', 13:08:57 INFO - 'tabpaint']}, 13:08:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['a11yr', 13:08:57 INFO - 'ts_paint', 13:08:57 INFO - 'tpaint', 13:08:57 INFO - 'sessionrestore', 13:08:57 INFO - 'sessionrestore_no_auto_restore', 13:08:57 INFO - 'tabpaint']}, 13:08:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['tsvgx', 13:08:57 INFO - 'tsvgr_opacity', 13:08:57 INFO - 'tart', 13:08:57 INFO - 'tscrollx', 13:08:57 INFO - 'cart']}, 13:08:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:57 INFO - 'tsvgr_opacity', 13:08:57 INFO - 'tart', 13:08:57 INFO - 'tscrollx', 13:08:57 INFO - 'cart']}, 13:08:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'talos_options': ['--disable-e10s'], 13:08:57 INFO - 'tests': ['tp5o']}, 13:08:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'tests': ['tp5o']}, 13:08:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'talos_options': ['--disable-e10s', 13:08:57 INFO - '--xperf_path', 13:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:57 INFO - 'tests': ['tp5n']}, 13:08:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:57 INFO - 'talos_options': ['--xperf_path', 13:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:57 INFO - 'tests': ['tp5n']}}, 13:08:57 INFO - 'talos.zip': {'path': '', 13:08:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:57 INFO - Running post-action listener: _resource_record_post_action 13:08:57 INFO - ##### 13:08:57 INFO - ##### Finished populate-webroot step (success) 13:08:57 INFO - ##### 13:08:57 INFO - ##### 13:08:57 INFO - ##### Running create-virtualenv step. 13:08:57 INFO - ##### 13:08:57 INFO - Running pre-action listener: _resource_record_pre_action 13:08:57 INFO - Running main action method: create_virtualenv 13:08:57 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:57 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 13:08:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:57 INFO - Using real prefix '/tools/python27' 13:08:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:01 INFO - Installing pip.................done. 13:09:01 INFO - Return code: 0 13:09:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:01 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:01 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 13:09:01 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 13:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:01 INFO - 'HOME': '/Users/cltbld', 13:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:01 INFO - 'LOGNAME': 'cltbld', 13:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:01 INFO - 'MOZ_NO_REMOTE': '1', 13:09:01 INFO - 'NO_EM_RESTART': '1', 13:09:01 INFO - 'PAGER': '/bin/cat', 13:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:01 INFO - 'PWD': '/builds/slave/test', 13:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:01 INFO - 'SHELL': '/bin/bash', 13:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:01 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:01 INFO - 'USER': 'cltbld', 13:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:01 INFO - 'XPC_FLAGS': '0x0', 13:09:01 INFO - 'XPC_SERVICE_NAME': '0', 13:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:01 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 13:09:01 INFO - Cleaning up... 13:09:01 INFO - Return code: 0 13:09:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:01 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:01 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 13:09:01 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 13:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:01 INFO - 'HOME': '/Users/cltbld', 13:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:01 INFO - 'LOGNAME': 'cltbld', 13:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:01 INFO - 'MOZ_NO_REMOTE': '1', 13:09:01 INFO - 'NO_EM_RESTART': '1', 13:09:01 INFO - 'PAGER': '/bin/cat', 13:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:01 INFO - 'PWD': '/builds/slave/test', 13:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:01 INFO - 'SHELL': '/bin/bash', 13:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:01 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:01 INFO - 'USER': 'cltbld', 13:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:01 INFO - 'XPC_FLAGS': '0x0', 13:09:01 INFO - 'XPC_SERVICE_NAME': '0', 13:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:01 INFO - Downloading/unpacking psutil>=3.1.1 13:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:04 INFO - Installing collected packages: psutil 13:09:04 INFO - Running setup.py install for psutil 13:09:05 INFO - building 'psutil._psutil_osx' extension 13:09:05 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 13:09:05 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 13:09:05 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 13:09:05 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 13:09:05 INFO - building 'psutil._psutil_posix' extension 13:09:05 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 13:09:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:09:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:09:05 INFO - ^ 13:09:05 INFO - 1 warning generated. 13:09:05 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 13:09:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:06 INFO - Successfully installed psutil 13:09:06 INFO - Cleaning up... 13:09:06 INFO - Return code: 0 13:09:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09:06 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')]} 13:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:06 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')]} 13:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:06 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:06 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 13:09:06 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 13:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:06 INFO - 'HOME': '/Users/cltbld', 13:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:06 INFO - 'LOGNAME': 'cltbld', 13:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:06 INFO - 'MOZ_NO_REMOTE': '1', 13:09:06 INFO - 'NO_EM_RESTART': '1', 13:09:06 INFO - 'PAGER': '/bin/cat', 13:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:06 INFO - 'PWD': '/builds/slave/test', 13:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:06 INFO - 'SHELL': '/bin/bash', 13:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:06 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:06 INFO - 'USER': 'cltbld', 13:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:06 INFO - 'XPC_FLAGS': '0x0', 13:09:06 INFO - 'XPC_SERVICE_NAME': '0', 13:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:06 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 13:09:06 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 13:09:06 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 13:09:06 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 13:09:06 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 13:09:06 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 13:09:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:08 INFO - Installing collected packages: mozsystemmonitor 13:09:08 INFO - Running setup.py install for mozsystemmonitor 13:09:09 INFO - Successfully installed mozsystemmonitor 13:09:09 INFO - Cleaning up... 13:09:09 INFO - Return code: 0 13:09:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:09 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:09 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 13:09:09 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 13:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:09 INFO - 'HOME': '/Users/cltbld', 13:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:09 INFO - 'LOGNAME': 'cltbld', 13:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:09 INFO - 'MOZ_NO_REMOTE': '1', 13:09:09 INFO - 'NO_EM_RESTART': '1', 13:09:09 INFO - 'PAGER': '/bin/cat', 13:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:09 INFO - 'PWD': '/builds/slave/test', 13:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:09 INFO - 'SHELL': '/bin/bash', 13:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:09 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:09 INFO - 'USER': 'cltbld', 13:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:09 INFO - 'XPC_FLAGS': '0x0', 13:09:09 INFO - 'XPC_SERVICE_NAME': '0', 13:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:09 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:09 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 13:09:09 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 13:09:09 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 13:09:09 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 13:09:09 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 13:09:09 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 13:09:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09:12 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:12 INFO - warning: no files found matching '*.txt' 13:09:12 INFO - no previously-included directories found matching 'build' 13:09:12 INFO - no previously-included directories found matching 'dist' 13:09:12 INFO - no previously-included directories found matching '.git*' 13:09:12 INFO - Installing collected packages: jsonschema, functools32 13:09:12 INFO - Running setup.py install for functools32 13:09:12 INFO - warning: no files found matching '*.txt' 13:09:12 INFO - no previously-included directories found matching 'build' 13:09:12 INFO - no previously-included directories found matching 'dist' 13:09:12 INFO - no previously-included directories found matching '.git*' 13:09:12 INFO - Successfully installed jsonschema functools32 13:09:12 INFO - Cleaning up... 13:09:12 INFO - Return code: 0 13:09:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:12 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:12 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 13:09:12 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 13:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:12 INFO - 'HOME': '/Users/cltbld', 13:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:12 INFO - 'LOGNAME': 'cltbld', 13:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:12 INFO - 'MOZ_NO_REMOTE': '1', 13:09:12 INFO - 'NO_EM_RESTART': '1', 13:09:12 INFO - 'PAGER': '/bin/cat', 13:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:12 INFO - 'PWD': '/builds/slave/test', 13:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:12 INFO - 'SHELL': '/bin/bash', 13:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:12 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:12 INFO - 'USER': 'cltbld', 13:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:12 INFO - 'XPC_FLAGS': '0x0', 13:09:12 INFO - 'XPC_SERVICE_NAME': '0', 13:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:12 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:15 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:15 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 13:09:15 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 13:09:15 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 13:09:15 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 13:09:15 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 13:09:15 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 13:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:16 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 13:09:16 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 13:09:16 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 13:09:16 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 13:09:16 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 13:09:16 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 13:09:16 INFO - Downloading docopt-0.6.1.tar.gz 13:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:16 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:16 INFO - Running setup.py install for blobuploader 13:09:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:16 INFO - Running setup.py install for requests 13:09:17 INFO - Running setup.py install for docopt 13:09:17 INFO - Successfully installed blobuploader requests docopt 13:09:17 INFO - Cleaning up... 13:09:17 INFO - Return code: 0 13:09:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:17 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:17 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 13:09:17 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 13:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:17 INFO - 'HOME': '/Users/cltbld', 13:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:17 INFO - 'LOGNAME': 'cltbld', 13:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:17 INFO - 'MOZ_NO_REMOTE': '1', 13:09:17 INFO - 'NO_EM_RESTART': '1', 13:09:17 INFO - 'PAGER': '/bin/cat', 13:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:17 INFO - 'PWD': '/builds/slave/test', 13:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:17 INFO - 'SHELL': '/bin/bash', 13:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:17 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:17 INFO - 'USER': 'cltbld', 13:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:17 INFO - 'XPC_FLAGS': '0x0', 13:09:17 INFO - 'XPC_SERVICE_NAME': '0', 13:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:17 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-KHmtun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:17 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-HpLRBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:17 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-gkSf86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:17 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-uYJznf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_2fxC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-FLvaJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-RSz6kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-7A0KTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-DgwA4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-TFae6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-SNA_Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-J5f2ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:18 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-0PaZWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:19 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-WGAvOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:19 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-89aKaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:19 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-kBmPpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:19 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-0_07JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:19 INFO - Running setup.py install for manifestparser 13:09:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:19 INFO - Running setup.py install for mozcrash 13:09:19 INFO - Running setup.py install for mozdebug 13:09:19 INFO - Running setup.py install for mozdevice 13:09:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Running setup.py install for mozfile 13:09:20 INFO - Running setup.py install for mozhttpd 13:09:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Running setup.py install for mozinfo 13:09:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Running setup.py install for mozInstall 13:09:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Running setup.py install for mozleak 13:09:20 INFO - Running setup.py install for mozlog 13:09:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:20 INFO - Running setup.py install for moznetwork 13:09:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:21 INFO - Running setup.py install for mozprocess 13:09:21 INFO - Running setup.py install for mozprofile 13:09:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:21 INFO - Running setup.py install for mozrunner 13:09:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:21 INFO - Running setup.py install for mozscreenshot 13:09:21 INFO - Running setup.py install for moztest 13:09:21 INFO - Running setup.py install for mozversion 13:09:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:21 INFO - Cleaning up... 13:09:21 INFO - Return code: 0 13:09:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:22 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')]} 13:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:22 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:22 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 13:09:22 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 13:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:22 INFO - 'HOME': '/Users/cltbld', 13:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:22 INFO - 'LOGNAME': 'cltbld', 13:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:22 INFO - 'MOZ_NO_REMOTE': '1', 13:09:22 INFO - 'NO_EM_RESTART': '1', 13:09:22 INFO - 'PAGER': '/bin/cat', 13:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:22 INFO - 'PWD': '/builds/slave/test', 13:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:22 INFO - 'SHELL': '/bin/bash', 13:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:22 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:22 INFO - 'USER': 'cltbld', 13:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:22 INFO - 'XPC_FLAGS': '0x0', 13:09:22 INFO - 'XPC_SERVICE_NAME': '0', 13:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:22 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ymRZls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:22 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)) 13:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:22 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-qiOYQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:22 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)) 13:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:22 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Po7jl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-I3aKV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-oyySD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-D9BAoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-q7_ggN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-NOtZNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-AF_nn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-NtLIhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-gNSNdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:23 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)) 13:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:23 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-HKhZTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:24 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-r9IYVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:24 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)) 13:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:24 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-YQe9dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:24 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-eFrs2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:24 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)) 13:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:24 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-3wuxq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:24 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)) 13:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:24 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6U1YiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:24 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)) 13:09:24 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)) 13:09:24 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)) 13:09:24 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)) 13:09:24 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)) 13:09:24 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)) 13:09:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:24 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 13:09:24 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 13:09:24 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 13:09:24 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 13:09:24 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 13:09:24 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 13:09:27 INFO - Downloading blessings-1.6.tar.gz 13:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:27 INFO - Installing collected packages: blessings 13:09:27 INFO - Running setup.py install for blessings 13:09:27 INFO - Successfully installed blessings 13:09:27 INFO - Cleaning up... 13:09:27 INFO - Return code: 0 13:09:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:27 INFO - Reading from file tmpfile_stdout 13:09:27 INFO - Current package versions: 13:09:27 INFO - blessings == 1.6 13:09:27 INFO - blobuploader == 1.2.4 13:09:27 INFO - docopt == 0.6.1 13:09:27 INFO - functools32 == 3.2.3-2 13:09:27 INFO - jsonschema == 2.5.1 13:09:27 INFO - manifestparser == 1.1 13:09:27 INFO - mozInstall == 1.12 13:09:27 INFO - mozcrash == 0.17 13:09:27 INFO - mozdebug == 0.1 13:09:27 INFO - mozdevice == 0.48 13:09:27 INFO - mozfile == 1.2 13:09:27 INFO - mozhttpd == 0.7 13:09:27 INFO - mozinfo == 0.9 13:09:27 INFO - mozleak == 0.1 13:09:27 INFO - mozlog == 3.2 13:09:27 INFO - moznetwork == 0.27 13:09:27 INFO - mozprocess == 0.23 13:09:27 INFO - mozprofile == 0.28 13:09:27 INFO - mozrunner == 6.12 13:09:27 INFO - mozscreenshot == 0.1 13:09:27 INFO - mozsystemmonitor == 0.3 13:09:27 INFO - moztest == 0.7 13:09:27 INFO - mozversion == 1.4 13:09:27 INFO - psutil == 3.1.1 13:09:27 INFO - requests == 1.2.3 13:09:27 INFO - wsgiref == 0.1.2 13:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:27 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')]} 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:27 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')]} 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:27 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:27 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 13:09:27 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 13:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:27 INFO - 'HOME': '/Users/cltbld', 13:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:27 INFO - 'LOGNAME': 'cltbld', 13:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:27 INFO - 'MOZ_NO_REMOTE': '1', 13:09:27 INFO - 'NO_EM_RESTART': '1', 13:09:27 INFO - 'PAGER': '/bin/cat', 13:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:27 INFO - 'PWD': '/builds/slave/test', 13:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:27 INFO - 'SHELL': '/bin/bash', 13:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:27 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:27 INFO - 'USER': 'cltbld', 13:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:27 INFO - 'XPC_FLAGS': '0x0', 13:09:27 INFO - 'XPC_SERVICE_NAME': '0', 13:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 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)) 13:09:27 INFO - Cleaning up... 13:09:27 INFO - Return code: 0 13:09:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09:27 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')]} 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:27 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')]} 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:27 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 0x102105a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10219a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5484c1590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, '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.jneSx0JIOE/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.R62zdz0ak6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 13:09:27 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 13:09:27 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 13:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:27 INFO - 'HOME': '/Users/cltbld', 13:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:27 INFO - 'LOGNAME': 'cltbld', 13:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:27 INFO - 'MOZ_NO_REMOTE': '1', 13:09:27 INFO - 'NO_EM_RESTART': '1', 13:09:27 INFO - 'PAGER': '/bin/cat', 13:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:27 INFO - 'PWD': '/builds/slave/test', 13:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:27 INFO - 'SHELL': '/bin/bash', 13:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:09:27 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:27 INFO - 'USER': 'cltbld', 13:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:27 INFO - 'XPC_FLAGS': '0x0', 13:09:27 INFO - 'XPC_SERVICE_NAME': '0', 13:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:09:28 INFO - Cleaning up... 13:09:28 INFO - Return code: 0 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - Running post-action listener: _start_resource_monitoring 13:09:28 INFO - Starting resource monitoring. 13:09:28 INFO - ##### 13:09:28 INFO - ##### Finished create-virtualenv step (success) 13:09:28 INFO - ##### 13:09:28 INFO - ##### 13:09:28 INFO - ##### Running install step. 13:09:28 INFO - ##### 13:09:28 INFO - Running pre-action listener: _resource_record_pre_action 13:09:28 INFO - Running main action method: install 13:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:28 INFO - Reading from file tmpfile_stdout 13:09:28 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:28 INFO - Reading from file tmpfile_stdout 13:09:28 INFO - Output received: 13:09:28 INFO - Usage: mozinstall [options] installer 13:09:28 INFO - Options: 13:09:28 INFO - -h, --help show this help message and exit 13:09:28 INFO - -d DEST, --destination=DEST 13:09:28 INFO - Directory to install application into. [default: 13:09:28 INFO - "/builds/slave/test"] 13:09:28 INFO - --app=APP Application being installed. [default: firefox] 13:09:28 INFO - mkdir: /builds/slave/test/build/application 13:09:28 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'] 13:09:28 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 13:10:02 INFO - Reading from file tmpfile_stdout 13:10:02 INFO - Output received: 13:10:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:10:02 INFO - Running post-action listener: _resource_record_post_action 13:10:02 INFO - ##### 13:10:02 INFO - ##### Finished install step (success) 13:10:02 INFO - ##### 13:10:02 INFO - ##### 13:10:02 INFO - ##### Running run-tests step. 13:10:02 INFO - ##### 13:10:02 INFO - Running pre-action listener: _resource_record_pre_action 13:10:02 INFO - Running main action method: run_tests 13:10:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:10:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:10:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:10:02 INFO - 2016-07-12 13:10:02.484 screenresolution[1639:7928] starting screenresolution argv=screenresolution get 13:10:02 INFO - 2016-07-12 13:10:02.486 screenresolution[1639:7928] Display 0: 1600x1200x32@60 13:10:02 INFO - 2016-07-12 13:10:02.493 screenresolution[1640:7930] starting screenresolution argv=screenresolution list 13:10:02 INFO - Available Modes on Display 0 13:10:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:10:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:10:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:10:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:10:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:10:02 INFO - Intel Iris: 13:10:02 INFO - Chipset Model: Intel Iris 13:10:02 INFO - Type: GPU 13:10:02 INFO - Bus: Built-In 13:10:02 INFO - VRAM (Dynamic, Max): 1536 MB 13:10:02 INFO - Vendor: Intel (0x8086) 13:10:02 INFO - Device ID: 0x0a2e 13:10:02 INFO - Revision ID: 0x0009 13:10:02 INFO - Displays: 13:10:02 INFO - Display: 13:10:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:10:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:10:02 INFO - Display Serial Number: 1600x1200 60 13:10:02 INFO - Main Display: Yes 13:10:02 INFO - Mirror: Off 13:10:02 INFO - Online: Yes 13:10:02 INFO - Rotation: Supported 13:10:02 INFO - Return code: 0 13:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:02 INFO - Python 2.7.3 13:10:02 INFO - Return code: 0 13:10:02 INFO - grabbing minidump binary from tooltool 13:10: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')]} 13:10:02 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 0x102069d30>, '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 0x101dcedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102061b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:02 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 13:10:02 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 13:10:02 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 13:10:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:02 INFO - Return code: 0 13:10:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:10:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:10:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 13:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 13:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jneSx0JIOE/Render', 13:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:02 INFO - 'HOME': '/Users/cltbld', 13:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:02 INFO - 'LOGNAME': 'cltbld', 13:10:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:02 INFO - 'MOZ_NO_REMOTE': '1', 13:10:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:02 INFO - 'NO_EM_RESTART': '1', 13:10:02 INFO - 'PAGER': '/bin/cat', 13:10:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:02 INFO - 'PWD': '/builds/slave/test', 13:10:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:02 INFO - 'SHELL': '/bin/bash', 13:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R62zdz0ak6/Listeners', 13:10:02 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 13:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:02 INFO - 'USER': 'cltbld', 13:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:02 INFO - 'XPC_FLAGS': '0x0', 13:10:02 INFO - 'XPC_SERVICE_NAME': '0', 13:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 13:10:03 INFO - mozversion application_buildid: 20160712111626 13:10:03 INFO - mozversion application_changeset: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 13:10:03 INFO - mozversion application_display_name: Nightly 13:10:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:03 INFO - mozversion application_name: Firefox 13:10:03 INFO - mozversion application_remotingname: firefox 13:10:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:10:03 INFO - mozversion application_vendor: Mozilla 13:10:03 INFO - mozversion application_version: 50.0a1 13:10:03 INFO - mozversion platform_buildid: 20160712111626 13:10:03 INFO - mozversion platform_changeset: 55922a4a546c9a6b5c6842aeb00b65c10b29bfc2 13:10:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:10:03 INFO - mozversion platform_version: 50.0a1 13:10:03 INFO - using testdate: 1468354203 13:10:03 INFO - actual date: 1468354203 13:10:03 INFO - starting webserver on 'localhost:49268' 13:10:03 INFO - SUITE-START | Running 2 tests 13:10:03 INFO - TEST-START | dromaeo_css 13:10:03 INFO - operating with platform_type : mac_ 13:10:03 INFO - Initialising browser for dromaeo_css test... 13:10:03 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpGW5bnD/profile http://localhost:49268/getInfo.html) 13:10:05 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 13:10:05 INFO - PROCESS | 1650 | colorDepth:24 13:10:05 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 13:10:05 INFO - PROCESS | 1650 | __metrics 13:10:05 INFO - PROCESS | 1650 | 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" 13:10:05 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:10:06 INFO - TEST-INFO | 1650: exit 0 13:10:06 INFO - Browser initialized. 13:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:06 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpGW5bnD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:18 INFO - PROCESS | 1653 | RSS: Main: 243625984 13:10:18 INFO - PROCESS | 1653 | 13:11:09 INFO - PROCESS | 1653 | 1468354269784 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] 13:13:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 13:13:21 INFO - PROCESS | 1653 | RSS: Main: 341098496 13:13:21 INFO - PROCESS | 1653 | 13:16:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 13:16:25 INFO - PROCESS | 1653 | RSS: Main: 384397312 13:16:25 INFO - PROCESS | 1653 | 13:19:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 13:19:28 INFO - PROCESS | 1653 | RSS: Main: 371867648 13:19:28 INFO - PROCESS | 1653 | 13:22:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 13:22:31 INFO - PROCESS | 1653 | RSS: Main: 372211712 13:22:31 INFO - PROCESS | 1653 | 13:25:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 13:25:35 INFO - PROCESS | 1653 | RSS: Main: 335400960 13:25:35 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 13:28:38 INFO - PROCESS | 1653 | RSS: Main: 382394368 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | __start_tp_report 13:28:38 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 13:28:38 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 13:28:38 INFO - PROCESS | 1653 | |i|pagename|runs| 13:28:38 INFO - PROCESS | 1653 | |0;dojo.html;2757.931051723707;3368.0906155338043;3379.9831000844993;3392.9821053683895;3407.369636617226;5585;5680.318361796591;5696.8860622787515;5775.682337471442;5786.623869448483;5743.712814359286;5801.07182850744;5801.274840644919;5807.709614519278;5809.186713860063;5213.244079608455;5246.606504512158;5300.257963885059;5306.044911915854;5359;5310.92033619496;5347.786088556453;5349.4753995111405;5353.304070470834;5359.981603495343;5229.450907654679;5252.264682944391;5279.5512381447625;5296;5359.1425371940495;5327.893442131136;5349.037173308803;5356.946430535722;5366.758495867695;5369.865753356158;5160.664556803796;5166.276721259027;5176.171812509981;5282.867928301785;5289.206619007141;4878.585320247783;5651.9152212716845;5704.657720536781;5729.598928075036;5777.0467872801355;6267.122602835607;6301.40136687014;6306.463950564207;6310.1481300024825;6331.05034244867;6236.844078898019;6272.435480806749;6347.936520634781;6395.744170233185;6421.582597131218;5854.941450585439;5872.0898260769645;5894.528437725015;5923.466887980059;5939.851503712355;6356.364363563606;6365.4589359904;6370.426661600478;6374.426301632875;6385.904211436832;5942.970285148633;6010.759569617254;6127.036821038966;6184.938150618526;6186.443220110212;6350.650714210763;6357.745690172434;6375.394337537927;6377.904331435032;6390.0734393512685;6261.906071408933;6315.305316415191;6315.305316415191;6325.272593651697;6330.145430366933;6134.877302453926;6154.415330543591;6157.907631385533;6230.096635987757;6335.176427064452;4911.63162762787;4936.851894443173;4937.7777999990085;4948.604111671058;4949.727764972961;4493.752843593568;4499.955000450019;4507.391502147234;4513.503514613456;4551.817927282872;4927.679700819435;5868.647881127146;5876.41235876409;5882.941170588325;5933.881322373529;6185.938140618537;6274.403931626488;6297.874042519124;6348;6415.133956915756;5801.216835727123;5820.388859169726;5820.417958204231;5824.621399609012;5825.621334613236;5423.403425623178;5467.4532546745;5484.149956756709;5502.257195278667;5529.529989950899;6366.299707032223;6424.453921416545;6426;6430.742770289323;6440.420362167428;6389.9361006389345;6397.808065758035;6408.711607977745;6410.326915673973;6420.486361091195;6274.341194174728;6283.8114856554375;6334.9366506334345;6349.68251587428;6404.71178796946;6255;6270.9372906270355;6277.811665650038;6282.560220784501;6298.338674439118;6305.747770089145;6365.2361716594305;6370.044493326038;6388.968055159695;6391.424771770563;5930.199423077829;6004.309504407049;6113.877722445615;6133.579501509479;6135.600157732601;6207.565470417208;6210.596311239755;6215.316315205233;6218.129461875251;6218.22272215973;6033.54748393881;6058.818235452944;6059.37393080821;6059.969700151471;6082.939170608237;5512.255845460972;6032.276126864805;6092.839971250802;6109.541784366102;6112.602680825732;5983.970080149571;6006.918754624035;6017.699115044318;6020.187274717857;6041.852048110845 13:28:38 INFO - PROCESS | 1653 | |1;ext.html;508.60328943424145;517.131219551154;522.5271129627687;534.2493796216315;539.6923753460527;29687.554686679716;30222.848885755568;40617.59382406179;41220;41242.55651052214;42964.355534667004;43006.35490467645;43235.3514697279;43242.351364729475;43358.783206084;8601.182887625697;9527.142557169871;9699.951500242489;9702.126808587225;9713.46575938323;8736.344774141933;11567.595134170306;11776.646700598996;11777.116716246315;12139.817902731465;11757.294562326246;11831.290122592629;11836.289822610628;11839.7632047359;11858.169928105037;8567.057623661392;11536.59621913229;11727.648170554854;11752;11798.23311484755;11657.475413606408;11737.530498780125;11752.588659396966;11754.29474231549;11756;33790;40575.59424405748;40975;41057;41158.58841411577;3505.0711561435983;3507.0530956641564;3513.94729079064;3565.2691198304287;3696.632246068945;31213;31771.887983920682;31879.840600796848;32131.03606891797;32169.356612867847;3251.7723759336855;3312.420326442887;3333.666633336671;3366.7979921204806;3414.573178352706;539747;542788;543416;543847;544669.2766536182;33482.49776253358;62042.68978655078;63237;63292.68353658202;63365.68317158385;34429.48355774665;35940.64059359425;35952.64047359545;35969.820150899075;36067.639323606956;12549.435275412447;14753.483628072965;14978.850211497745;14984.850151498564;14992.925035374754;11461.197716159788;11682.824757628643;12535.059870509565;12721.236725796482;12772.361381931052;7799.415043871732;7816.765497035098;7848.803779905434;7887.44787864844;7901.683932642745;3272.574565306495;3290.341931613687;3300.9834950825093;3323.9169020774675;3335.0995231287416;923.8475651517559;934.3366209990846;1005.0903931941605;1042.0621440703276;1059.1950117910444;30255.243618909702;30256.243593909887;30803.845980770402;31036.53445198324;31080.533791993137;1010.8534262532039;1063.404493483636;1135.5855112883737;1151.78691941991;1172.5954545681727;15836.92081539585;15861;15887.364505419653;16314.592135196715;16494.34022639081;729497;735228;736449;737500;739326;59549.404505954386;60170;60190.09714854281;60290;60316;1269.536619134028;1382.3710211853584;1406.4444544405108;1429.4139402844783;1436.3321055708936;26542.734572654026;31131;31583.36833263368;32352.676473235908;33596.83201583976;49541.50458495369;49691;50337.49662503474;50448;50469.242961354874;576912;577971;578143;578564;578795.1060244672;22319.665205022262;24096;24746;26100.34749131287;26829.865850670623;47511;48853.5114648849;48931.26603101027;49040.5095949036;49302.26046609376;38797.61202388053;39636;40160.59839401569;41030.79484602558;41143.17713645651;39606.80196598999;40146.59853401545;40811;41790.95522611959;42991.1401771969;32504.512432313062;38941;39036.41445378265;39698.40452393274;39809.80095099506;28747;34044.65955340415;35502;35566.822165889;35583.64416355907;22634.773652263924;25541.9783208677;25593;26086;27397 13:28:38 INFO - PROCESS | 1653 | |2;jquery.html;360.72584835525026;383.8541354285372;387.7867173054821;390.23708649590054;413.0582272418884;14956.177410242432;15669.52991410258;21041.737495750265;21575.676364854502;21709;21331;22340.441488962784;22448;22798.54402911945;22899.771002290014;5956.225690660208;6006.309274433442;6164.7534098636;6193.256809182882;6201.906971395432;4232.788360581974;6096.4513193812545;6143.262808462969;6583.275839657634;6922.757703480379;6917.861642767141;6919.550229235084;6920.861582768342;6932.514723969299;6934.583924964493;7048.506604537684;7832;7848.136704962478;7901.723439679584;7907.169747176521;7460.552366858006;7530.1340345859835;7648.808779780495;7650.42621803367;7670.578118203496;27948.860255698793;29180.416391672046;29445.411091778045;29471;29929.551056734166;2416.516696660675;2417.5648383291;2470.110760126353;2832.6459192600923;2991.7157870002316;16201.669595782154;16638.83361166385;17215.22531486086;17479.737803932952;18107.45677629673;1790.8030116687155;1977.1399441243104;2068.75174979002;2154.8491605587615;2188.376312750874;132646.6735332644;133593.99609005873;135041;136597;137356;20914.16343346249;20949.162033518794;20982.950852457318;21010.949452527617;21154.682679759815;35200.64799352025;35278.29443411117;35298.76454324086;35368.46947295793;35387.82306088504;10958.232923695265;11128.888711112948;11145.721356965978;11156.274842135235;11321.264117832314;8894.777630559158;8960.507172105597;9226.53867306632;9279.860802087975;9394.342396032349;9418.681384606161;9728.854067188999;9742.561584728704;9848.359856609297;9892.653757118467;3151.4158390119883;3299.736021118305;3794.79128647927;3801.695864330902;3814.7329686922203;891.4250308550949;944.900785417535;956.086936975187;1006.8842083160383;1047.6887607495103;19739.506512337306;20803.791962080184;21081.683774743393;21236.36290911275;21249.36251912445;930.7486978515763;955.5604421965974;965.9758506037265;982.1455333859587;1046.2048842879467;10732.463376831127;10943.781124377469;10968.067714244378;11019;11057.22599418033;557684;563224;567802;569927;573155;75312;77601;110553;118763.40618296854;120655;963.4893506441597;988.1847475832467;998.730342807438;1002.1331548210891;1002.4336250018716;18685.90657046706;19061.237550497826;19084.85490870552;19144.712829307293;19157.904210478857;37013;48428.7578562119;49742;52227;53113.7344313276;63965.04052439124;76068.61965690136;77818.44363112593;79838.00404989922;80268.59865700868;7332.826747720339;7682.6158692064055;7920.960395198218;8143.918560814316;8397.748067557983;9280.489573073546;12447;12619.74760504803;13083.803742944054;13233.602991910258;11460.369679667698;11588.594399195988;11793.705157371134;11878.287302761863;11981.76036479248;9603.135717785433;11469.942650286695;11600.955913967784;11641.53433862636;11831.349275789915;11653.41732913368;11839.940800296288;11957.94021029924;11992.100592455776;12002.519899203933;8200.917990820015;8389.95805020971;8568.957155214184;8572.27135693473;8652.351073669373;10224.13094886943;10904.34573925567;11129.443527823738;11314.208005439541;11808.586699465477 13:28:38 INFO - PROCESS | 1653 | |3;mootools.html;1343.7178192579559;1467.9266036698161;1504.9473268435606;1532.532577563843;1852.5461261990815;7898.289153976141;8205.302549283311;8206.343492520606;8511.659533618647;8779.2098711116;8581.141885811416;8692.261157801595;8769.736907892757;8800.823983520326;8813.4711917285;2346.354752443079;2375.596148654733;2375.893084811179;2376.702912135983;2382.4996750682376;2307.238611258281;2346.6128088865316;2350.717913850332;2350.870702111392;2352.6118190498632;2308.3305841306087;2323.6049871521795;2333.3583264602203;2362.2676970139228;2373;2286.942826429336;2319.1446842525997;2326.93019209424;2329.615613423783;2334.8832558372014;2305.5849947009533;2306.2965795432387;2308.1113771198043;2311.7688231176917;2319.026009076192;8723;8787.736367908909;8808.823823523493;8810.339224558184;8834.337424693174;5136.460671629462;5320.441353657849;5322.33470816148;5364.839054828361;5394.460553944614;3438.8108654024018;3544.2379888323876;3594.4248920172645;3610.656987586175;3622.9094272643133;1067.7010437077631;1079.22835172851;1085.2240647936762;1086.283053184902;1101.0255923507752;11464.885351146466;11558.768824623461;11578.073754099652;11595.01442377399;11620;4310.4611923509565;4345.543717909637;4532.501424843264;4533.274676051816;4565.680402371869;9060.95469522648;9099.226565741987;9102.317326200562;9102.362834601514;9104.089591040974;4401.867943961686;5197.66215196011;5200.947990520122;5205.687658740488;5212.921806172911;4330.069035157457;4383.211022016004;4478.104379124123;4663.417072865892;4871.537203965618;3254.7558933080113;3647.814460300413;3702.9814850925573;3793;3837.9232415351535;1150.872145297613;1159.310210424796;1162.3258510064143;1167.5947548051042;1172.8123500239922;937.2829785214317;947.7204224753714;949.2026697574071;950.4392408478892;994.2193107601819;5820.272465941757;5847.590668653239;5899.056151015817;6045.848853778691;6261.906071408933;429.4524481286322;438.62935819232695;441.83210380055374;448.8339314453673;455.8860284928768;3678.6689197971778;3684.9263014739554;3796.1405244928255;4044.9797751011647;4089.3865920111625;9925.702228933143;10261.692149235534;10290.3825770454;10397.376157430579;10675.57297708083;10045.598176073021;10223.591056357662;10372.896271037343;10374.17006639467;10377.688669339932;7682.846343073107;8103.068147163034;8172.305354044854;8173.754787356389;8186.467879587927;5946.910796338145;6122.908156377569;6156.476699480594;6157.84605384869;6159.784407545714;9412.576434060347;9893.159081478156;9902.356346837432;9904.851427228741;9911.950440247752;9593.568289426852;10105.191584673355;10116.544755485873;10129.240306977154;10163.475478677961;7539.434542409232;7763.146053934176;7767.495112817649;8230.917690823015;8399.874001889855;7281.963590182015;7881.802954926173;8377.748667539983;8519.74440766778;8527.616257268313;7163.856722865409;7418.146913105062;7521.135069467081;7577.431692622965;7588.354989825927;7391.113066432063;7429.14564825052;7444.888326674996;7515.436342274461;7522.097348318237;5663.943360566342;6965.199002114821;7034.613096279753;7137.892931606134;7139.21468638439;4288.378185163197;4449.9777501112285;4890.779914903909;5004.84985450437;5160.561352284948;4148.191102734938;5075.8477245681215;5107.310513080686;5118.820841270538;5151.25306830515 13:28:38 INFO - PROCESS | 1653 | |4;prototype.html;301.3160126512816;307.93687294104706;317.09469464678335;320.30014418495574;320.98074115553067;3989.780562069089;4672.229082201441;5123.820666276681;5154.149565321717;5311;5155.948440515594;5317.5480084192795;5327.786888524454;5342.492463215998;5361.544268737162;3601.7298702597277;4095.9180816383655;4130.938035929464;4150.149219410029;4161.791910404483;3897.395903634927;4090.9363565472895;4170.77060761658;4186.853460128896;4259.446271984638;3450.396180668373;3965.2267807777494;4027.3153563894207;4047.7166598338126;4061.451704019949;3505.6494350564994;4059.5737447567876;4072.3891416287497;4074.8981275468054;4090.97954510227;3074.9391459946282;3367.9158021049425;3394.4738565522384;3550.236699109678;3555.928881422357;4195.202911446815;4264.893377665552;4288.485381754178;4780.040183524773;4935.481774413706;3902.317094508478;3966.3455529837543;4621.260598304255;4656.674032817704;4660.650451216173;4943.357363542752;5051;5442.455754424565;5532.723363831792;5636.351819540764;3376.763626546143;3453.3783918894587;3647.215848592539;3814.828332725034;3856.4986551748093;5040.487853643929;5761.942380576183;5791.652500849962;5797.724285778521;5816.709164541799;3549.432090865449;3655.814554655776;3845.1925095729653;3862.4013277941963;3864.8840534784003;3882.941755873664;3899.9610003900166;3913.295606790748;3915.667168290727;3918.529776426847;4493.73037617744;4520.932186017212;4528.43394575678;4529.207388706963;4541.386912766734;4579.496255411902;5366.731663416814;5527.972360138174;5533.4782934693285;5555.333359996826;1074.4573990134932;1273.2296960339047;1294.9287789171685;1342.7448784731066;1350.6960933790015;886.2334081019872;888.5512816027865;904.895936967244;908.9863652045225;914.5244472874068;4609.654275929319;4698.506656800987;5228.4510126436935;5240.4497527759795;5255.84371438283;5726.3700992890745;5729;5737.254156959569;5740.47419135579;5879.824464947997;4864.416270047546;4969.602431805447;5203.609729270244;5208.85405210853;5214.530692237641;2118.9682154767693;2159.492519257973;2165.8917054147228;2537.67010288665;2545.7454254574395;4675.335059016328;4966.379202599675;5001;5004.649674522749;5006.322881834553;3752.699784017272;4409.2724700424715;4835.8065677373215;4928.605711543068;4952.678075925053;4094.3653733670735;4424.070945101565;4981.551660350586;5008.5993120550265;5044.511868998654;4015.277250094894;4613.569793364068;4723.748206725152;4840.491748366371;4847.2729090636685;3695.7043436524477;4311.2455320318195;4760.214564596803;4782.928256076231;4815.3499277597075;4131.648809851196;4392.407025051577;5008.749562521933;5013.573846222966;5056.8988620226655;3100.891468798581;3235.951460728044;3606.3688854450893;3779.4519794629073;3795.7532760370486;5752.453516915886;5761.971190144022;5768.884622307446;5781.988152073286;5790.870780197821;5159.716215608028;5603.35561410443;5605.383407825218;5632.746526406239;5636.731735359512;4915.311856340187;5310.627751377826;5563.276774019351;5593.846369147826;5597.285316621516;5428.430014848384;5467.644603100785;5469.835904922858;5471.2887324647545;5487.670739755627;5245.265662807134;5311.893762124813;5576.525995290283;5583.134614134816;5626.5780066496;5453.291072160594;5453.536449401687;5468.316460442445;5477.4796394342475;5499.807506737245 13:28:38 INFO - PROCESS | 1653 | |5;yui.html;734.100726609903;792.1800936031207;793.8134538383479;835.098094058417;852.3053711225355;17364;17937.730934036;17938.82061179388;17966;17986.910065449672;16777.832221677778;16942.3223071077;16944.576385590368;16965.236564354604;17028.914855425737;589.9498542623882;742.3652776875774;746.2500187311745;925.3568769705058;928.7538802217417;874.1564390363299;905.2350763604743;910.0126362896233;911.9726408207731;913.0139449394638;949.392388871123;962.5668449197854;962.9807403851919;963.330485312708;966.3911735606558;748.6294284329292;922.4741897118645;955.5556666150273;957.5260246178117;958.6644674363987;714.9356557909813;716.1227496317022;719.5358993449248;719.6473727873357;721.1778572427437;15329.156896370696;15365.308561114776;15384.692306153926;15386.9230653846;15443.768343474856;13222.338883055905;13535.864641353559;13812.792808107886;13857.792133118011;13860.960427967942;12875.935620321932;12894.677633059155;13058.2817945013;13125.015623828156;13521.52674656392;4046.6358027777346;4617.683960071397;4644;4739.312799644067;4791.281307803857;110774;112227;112396;112594;112728.4363578185;10351.896481035245;10515.631952881766;10631.043206111332;10676.466176691134;10794.568217271379;21055.473613159487;21063.78936210649;21100.261490847748;21116.78883211179;21118.683219751714;7886.487378320391;8022.879656805153;8074.152214017444;8261.504309741435;8348.998120225611;4522.389477420572;4594.839180628729;4617.538246175355;4675.509071547506;4744.691595046311;3483.7909725416557;3625.492431059654;3628.6915612172734;3633.3459977204357;3633.5276414066;694.7672529702505;716.6560051175464;727.7925791149603;734.075065417567;747.2788758847738;648.3775575447623;652.6638781027774;688.8587839492892;689.9655017249117;690.3545185251805;8611.78470538229;8781.956090219635;9616.95191524038;9725.708228753148;9815.36200146988;636.8439732265624;671.5597420735173;674.3458844920517;693.3032302535919;694.5277211496131;4056.3307054336296;4535.866033491627;4644.442666879929;4812.8796780080775;4828.497740199633;170267.28934817022;171518.99683511019;172580;173432;174130.12934935244;142289;144651.5534844638;145873;147173;150590;113691.86308136812;121227;122380;122422.38788806;123022;9517.238620910171;9646.90353096488;9653.227741780782;9665.323427360017;9768.462734549385;41777.43562569727;45071.77464112658;58184.254472365894;62205.37794622177;63739.6813015932;81744.59127704323;85987;97427;97844;98724;13312.600621981355;13440.991925605815;13500.257485838372;13644.249566273951;13732;15181.772273416129;15182;15197.77203341973;15226.619334516725;15417.229138542803;13946;13956.421562785346;13973.510927117502;14095.436182552583;14205.360758765673;13610.931945340606;13820.378082986088;14051.768629163556;14116.78824817608;14596.85403145955;11680.415979200836;13732.588022359345;13844.86155138476;13877;14406.711865762416;11416;11428.742838287615;11618.88381116178;11681.259554867314;12097.2136811107;11401.543938242708;11539.36533490666;11680.06559475223;11688.357140357022;11710.765784684088 13:28:38 INFO - PROCESS | 1653 | __end_tp_report 13:28:38 INFO - PROCESS | 1653 | __start_cc_report 13:28:38 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1376 13:28:38 INFO - PROCESS | 1653 | __end_cc_report 13:28:38 INFO - PROCESS | 1653 | __startTimestamp1468355318614__endTimestamp 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | ------- Summary: start ------- 13:28:38 INFO - PROCESS | 1653 | Number of tests: 6 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5804.11 Median:6017.70 stddev:668.63 (11.1%) stddev-sans-first:626.53 13:28:38 INFO - PROCESS | 1653 | Values: 2757.9 3368.1 3380.0 3393.0 3407.4 5585.0 5680.3 5696.9 5775.7 5786.6 5743.7 5801.1 5801.3 5807.7 5809.2 5213.2 5246.6 5300.3 5306.0 5359.0 5310.9 5347.8 5349.5 5353.3 5360.0 5229.5 5252.3 5279.6 5296.0 5359.1 5327.9 5349.0 5356.9 5366.8 5369.9 5160.7 5166.3 5176.2 5282.9 5289.2 4878.6 5651.9 5704.7 5729.6 5777.0 6267.1 6301.4 6306.5 6310.1 6331.1 6236.8 6272.4 6347.9 6395.7 6421.6 5854.9 5872.1 5894.5 5923.5 5939.9 6356.4 6365.5 6370.4 6374.4 6385.9 5943.0 6010.8 6127.0 6184.9 6186.4 6350.7 6357.7 6375.4 6377.9 6390.1 6261.9 6315.3 6315.3 6325.3 6330.1 6134.9 6154.4 6157.9 6230.1 6335.2 4911.6 4936.9 4937.8 4948.6 4949.7 4493.8 4500.0 4507.4 4513.5 4551.8 4927.7 5868.6 5876.4 5882.9 5933.9 6185.9 6274.4 6297.9 6348.0 6415.1 5801.2 5820.4 5820.4 5824.6 5825.6 5423.4 5467.5 5484.1 5502.3 5529.5 6366.3 6424.5 6426.0 6430.7 6440.4 6389.9 6397.8 6408.7 6410.3 6420.5 6274.3 6283.8 6334.9 6349.7 6404.7 6255.0 6270.9 6277.8 6282.6 6298.3 6305.7 6365.2 6370.0 6389.0 6391.4 5930.2 6004.3 6113.9 6133.6 6135.6 6207.6 6210.6 6215.3 6218.1 6218.2 6033.5 6058.8 6059.4 6060.0 6082.9 5512.3 6032.3 6092.8 6109.5 6112.6 5984.0 6006.9 6017.7 6020.2 6041.9 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:73460.25 Median:3510.50 stddev:167562.66 (4773.2%) stddev-sans-first:167943.19 13:28:38 INFO - PROCESS | 1653 | Values: 508.6 517.1 522.5 534.2 539.7 29687.6 30222.8 40617.6 41220.0 41242.6 42964.4 43006.4 43235.4 43242.4 43358.8 8601.2 9527.1 9700.0 9702.1 9713.5 8736.3 11567.6 11776.6 11777.1 12139.8 11757.3 11831.3 11836.3 11839.8 11858.2 8567.1 11536.6 11727.6 11752.0 11798.2 11657.5 11737.5 11752.6 11754.3 11756.0 33790.0 40575.6 40975.0 41057.0 41158.6 3505.1 3507.1 3513.9 3565.3 3696.6 31213.0 31771.9 31879.8 32131.0 32169.4 3251.8 3312.4 3333.7 3366.8 3414.6 539747.0 542788.0 543416.0 543847.0 544669.3 33482.5 62042.7 63237.0 63292.7 63365.7 34429.5 35940.6 35952.6 35969.8 36067.6 12549.4 14753.5 14978.9 14984.9 14992.9 11461.2 11682.8 12535.1 12721.2 12772.4 7799.4 7816.8 7848.8 7887.4 7901.7 3272.6 3290.3 3301.0 3323.9 3335.1 923.8 934.3 1005.1 1042.1 1059.2 30255.2 30256.2 30803.8 31036.5 31080.5 1010.9 1063.4 1135.6 1151.8 1172.6 15836.9 15861.0 15887.4 16314.6 16494.3 729497.0 735228.0 736449.0 737500.0 739326.0 59549.4 60170.0 60190.1 60290.0 60316.0 1269.5 1382.4 1406.4 1429.4 1436.3 26542.7 31131.0 31583.4 32352.7 33596.8 49541.5 49691.0 50337.5 50448.0 50469.2 576912.0 577971.0 578143.0 578564.0 578795.1 22319.7 24096.0 24746.0 26100.3 26829.9 47511.0 48853.5 48931.3 49040.5 49302.3 38797.6 39636.0 40160.6 41030.8 41143.2 39606.8 40146.6 40811.0 41791.0 42991.1 32504.5 38941.0 39036.4 39698.4 39809.8 28747.0 34044.7 35502.0 35566.8 35583.6 22634.8 25542.0 25593.0 26086.0 27397.0 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35300.05 Median:16540.48 stddev:94364.62 (570.5%) stddev-sans-first:94592.87 13:28:38 INFO - PROCESS | 1653 | Values: 360.7 383.9 387.8 390.2 413.1 14956.2 15669.5 21041.7 21575.7 21709.0 21331.0 22340.4 22448.0 22798.5 22899.8 5956.2 6006.3 6164.8 6193.3 6201.9 4232.8 6096.5 6143.3 6583.3 6922.8 6917.9 6919.6 6920.9 6932.5 6934.6 7048.5 7832.0 7848.1 7901.7 7907.2 7460.6 7530.1 7648.8 7650.4 7670.6 27948.9 29180.4 29445.4 29471.0 29929.6 2416.5 2417.6 2470.1 2832.6 2991.7 16201.7 16638.8 17215.2 17479.7 18107.5 1790.8 1977.1 2068.8 2154.8 2188.4 132646.7 133594.0 135041.0 136597.0 137356.0 20914.2 20949.2 20983.0 21010.9 21154.7 35200.6 35278.3 35298.8 35368.5 35387.8 10958.2 11128.9 11145.7 11156.3 11321.3 8894.8 8960.5 9226.5 9279.9 9394.3 9418.7 9728.9 9742.6 9848.4 9892.7 3151.4 3299.7 3794.8 3801.7 3814.7 891.4 944.9 956.1 1006.9 1047.7 19739.5 20803.8 21081.7 21236.4 21249.4 930.7 955.6 966.0 982.1 1046.2 10732.5 10943.8 10968.1 11019.0 11057.2 557684.0 563224.0 567802.0 569927.0 573155.0 75312.0 77601.0 110553.0 118763.4 120655.0 963.5 988.2 998.7 1002.1 1002.4 18685.9 19061.2 19084.9 19144.7 19157.9 37013.0 48428.8 49742.0 52227.0 53113.7 63965.0 76068.6 77818.4 79838.0 80268.6 7332.8 7682.6 7921.0 8143.9 8397.7 9280.5 12447.0 12619.7 13083.8 13233.6 11460.4 11588.6 11793.7 11878.3 11981.8 9603.1 11469.9 11601.0 11641.5 11831.3 11653.4 11839.9 11957.9 11992.1 12002.5 8200.9 8390.0 8569.0 8572.3 8652.4 10224.1 10904.3 11129.4 11314.2 11808.6 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5605.42 Median:4767.48 stddev:3160.42 (66.3%) stddev-sans-first:3153.06 13:28:38 INFO - PROCESS | 1653 | Values: 1343.7 1467.9 1504.9 1532.5 1852.5 7898.3 8205.3 8206.3 8511.7 8779.2 8581.1 8692.3 8769.7 8800.8 8813.5 2346.4 2375.6 2375.9 2376.7 2382.5 2307.2 2346.6 2350.7 2350.9 2352.6 2308.3 2323.6 2333.4 2362.3 2373.0 2286.9 2319.1 2326.9 2329.6 2334.9 2305.6 2306.3 2308.1 2311.8 2319.0 8723.0 8787.7 8808.8 8810.3 8834.3 5136.5 5320.4 5322.3 5364.8 5394.5 3438.8 3544.2 3594.4 3610.7 3622.9 1067.7 1079.2 1085.2 1086.3 1101.0 11464.9 11558.8 11578.1 11595.0 11620.0 4310.5 4345.5 4532.5 4533.3 4565.7 9061.0 9099.2 9102.3 9102.4 9104.1 4401.9 5197.7 5200.9 5205.7 5212.9 4330.1 4383.2 4478.1 4663.4 4871.5 3254.8 3647.8 3703.0 3793.0 3837.9 1150.9 1159.3 1162.3 1167.6 1172.8 937.3 947.7 949.2 950.4 994.2 5820.3 5847.6 5899.1 6045.8 6261.9 429.5 438.6 441.8 448.8 455.9 3678.7 3684.9 3796.1 4045.0 4089.4 9925.7 10261.7 10290.4 10397.4 10675.6 10045.6 10223.6 10372.9 10374.2 10377.7 7682.8 8103.1 8172.3 8173.8 8186.5 5946.9 6122.9 6156.5 6157.8 6159.8 9412.6 9893.2 9902.4 9904.9 9912.0 9593.6 10105.2 10116.5 10129.2 10163.5 7539.4 7763.1 7767.5 8230.9 8399.9 7282.0 7881.8 8377.7 8519.7 8527.6 7163.9 7418.1 7521.1 7577.4 7588.4 7391.1 7429.1 7444.9 7515.4 7522.1 5663.9 6965.2 7034.6 7137.9 7139.2 4288.4 4450.0 4890.8 5004.8 5160.6 4148.2 5075.8 5107.3 5118.8 5151.3 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4327.06 Median:4770.13 stddev:1336.50 (28.0%) stddev-sans-first:1305.64 13:28:38 INFO - PROCESS | 1653 | Values: 301.3 307.9 317.1 320.3 321.0 3989.8 4672.2 5123.8 5154.1 5311.0 5155.9 5317.5 5327.8 5342.5 5361.5 3601.7 4095.9 4130.9 4150.1 4161.8 3897.4 4090.9 4170.8 4186.9 4259.4 3450.4 3965.2 4027.3 4047.7 4061.5 3505.6 4059.6 4072.4 4074.9 4091.0 3074.9 3367.9 3394.5 3550.2 3555.9 4195.2 4264.9 4288.5 4780.0 4935.5 3902.3 3966.3 4621.3 4656.7 4660.7 4943.4 5051.0 5442.5 5532.7 5636.4 3376.8 3453.4 3647.2 3814.8 3856.5 5040.5 5761.9 5791.7 5797.7 5816.7 3549.4 3655.8 3845.2 3862.4 3864.9 3882.9 3900.0 3913.3 3915.7 3918.5 4493.7 4520.9 4528.4 4529.2 4541.4 4579.5 5366.7 5528.0 5533.5 5555.3 1074.5 1273.2 1294.9 1342.7 1350.7 886.2 888.6 904.9 909.0 914.5 4609.7 4698.5 5228.5 5240.4 5255.8 5726.4 5729.0 5737.3 5740.5 5879.8 4864.4 4969.6 5203.6 5208.9 5214.5 2119.0 2159.5 2165.9 2537.7 2545.7 4675.3 4966.4 5001.0 5004.6 5006.3 3752.7 4409.3 4835.8 4928.6 4952.7 4094.4 4424.1 4981.6 5008.6 5044.5 4015.3 4613.6 4723.7 4840.5 4847.3 3695.7 4311.2 4760.2 4782.9 4815.3 4131.6 4392.4 5008.7 5013.6 5056.9 3100.9 3236.0 3606.4 3779.5 3795.8 5752.5 5762.0 5768.9 5782.0 5790.9 5159.7 5603.4 5605.4 5632.7 5636.7 4915.3 5310.6 5563.3 5593.8 5597.3 5428.4 5467.6 5469.8 5471.3 5487.7 5245.3 5311.9 5576.5 5583.1 5626.6 5453.3 5453.5 5468.3 5477.5 5499.8 13:28:38 INFO - PROCESS | 1653 | 13:28:38 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:26431.48 Median:3554.64 stddev:43579.73 (1226.0%) stddev-sans-first:43659.27 13:28:38 INFO - PROCESS | 1653 | Values: 734.1 792.2 793.8 835.1 852.3 17364.0 17937.7 17938.8 17966.0 17986.9 16777.8 16942.3 16944.6 16965.2 17028.9 589.9 742.4 746.3 925.4 928.8 874.2 905.2 910.0 912.0 913.0 949.4 962.6 963.0 963.3 966.4 748.6 922.5 955.6 957.5 958.7 714.9 716.1 719.5 719.6 721.2 15329.2 15365.3 15384.7 15386.9 15443.8 13222.3 13535.9 13812.8 13857.8 13861.0 12875.9 12894.7 13058.3 13125.0 13521.5 4046.6 4617.7 4644.0 4739.3 4791.3 110774.0 112227.0 112396.0 112594.0 112728.4 10351.9 10515.6 10631.0 10676.5 10794.6 21055.5 21063.8 21100.3 21116.8 21118.7 7886.5 8022.9 8074.2 8261.5 8349.0 4522.4 4594.8 4617.5 4675.5 4744.7 3483.8 3625.5 3628.7 3633.3 3633.5 694.8 716.7 727.8 734.1 747.3 648.4 652.7 688.9 690.0 690.4 8611.8 8782.0 9617.0 9725.7 9815.4 636.8 671.6 674.3 693.3 694.5 4056.3 4535.9 4644.4 4812.9 4828.5 170267.3 171519.0 172580.0 173432.0 174130.1 142289.0 144651.6 145873.0 147173.0 150590.0 113691.9 121227.0 122380.0 122422.4 123022.0 9517.2 9646.9 9653.2 9665.3 9768.5 41777.4 45071.8 58184.3 62205.4 63739.7 81744.6 85987.0 97427.0 97844.0 98724.0 13312.6 13441.0 13500.3 13644.2 13732.0 15181.8 15182.0 15197.8 15226.6 15417.2 13946.0 13956.4 13973.5 14095.4 14205.4 13610.9 13820.4 14051.8 14116.8 14596.9 11680.4 13732.6 13844.9 13877.0 14406.7 11416.0 11428.7 11618.9 11681.3 12097.2 11401.5 11539.4 11680.1 11688.4 11710.8 13:28:38 INFO - PROCESS | 1653 | -------- Summary: end -------- 13:28:38 INFO - PROCESS | 1653 | 13:28:39 INFO - TEST-INFO | 1653: exit 0 13:28:39 INFO - TEST-OK | dromaeo_css | took 1116147ms 13:28:39 INFO - TEST-START | kraken 13:28:39 INFO - operating with platform_type : mac_ 13:28:39 INFO - Initialising browser for kraken test... 13:28:39 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmp80HV9v/profile http://localhost:49268/getInfo.html) 13:28:41 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 13:28:41 INFO - PROCESS | 1658 | colorDepth:24 13:28:41 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 13:28:41 INFO - PROCESS | 1658 | __metrics 13:28:41 INFO - PROCESS | 1658 | 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" 13:28:41 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:42 INFO - TEST-INFO | 1658: exit 0 13:28:42 INFO - Browser initialized. 13:28:42 INFO - Running cycle 1/1 for kraken test... 13:28:42 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmp80HV9v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:54 INFO - PROCESS | 1659 | RSS: Main: 243621888 13:28:54 INFO - PROCESS | 1659 | 13:28:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:57 INFO - PROCESS | 1659 | RSS: Main: 293371904 13:28:57 INFO - PROCESS | 1659 | 13:29:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 13:29:00 INFO - PROCESS | 1659 | RSS: Main: 304111616 13:29:00 INFO - PROCESS | 1659 | 13:29:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 13:29:04 INFO - PROCESS | 1659 | RSS: Main: 385429504 13:29:04 INFO - PROCESS | 1659 | 13:29:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 13:29:07 INFO - PROCESS | 1659 | RSS: Main: 287580160 13:29:07 INFO - PROCESS | 1659 | 13:29:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:10 INFO - PROCESS | 1659 | RSS: Main: 290955264 13:29:10 INFO - PROCESS | 1659 | 13:29:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:13 INFO - PROCESS | 1659 | RSS: Main: 329138176 13:29:13 INFO - PROCESS | 1659 | 13:29:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:17 INFO - PROCESS | 1659 | RSS: Main: 332029952 13:29:17 INFO - PROCESS | 1659 | 13:29:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 13:29:20 INFO - PROCESS | 1659 | RSS: Main: 330833920 13:29:20 INFO - PROCESS | 1659 | 13:29:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:23 INFO - PROCESS | 1659 | RSS: Main: 312995840 13:29:23 INFO - PROCESS | 1659 | 13:29:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:25 INFO - PROCESS | 1659 | RSS: Main: 320286720 13:29:25 INFO - PROCESS | 1659 | 13:29:27 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:28 INFO - PROCESS | 1659 | RSS: Main: 318197760 13:29:28 INFO - PROCESS | 1659 | 13:29:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:31 INFO - PROCESS | 1659 | RSS: Main: 333799424 13:29:31 INFO - PROCESS | 1659 | 13:29:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:35 INFO - PROCESS | 1659 | RSS: Main: 329670656 13:29:35 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 13:29:37 INFO - PROCESS | 1659 | RSS: Main: 373248000 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | __start_tp_report 13:29:37 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 13:29:37 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 13:29:37 INFO - PROCESS | 1659 | |i|pagename|runs| 13:29:37 INFO - PROCESS | 1659 | |0;ai-astar;101;113;113;112;113;112;112;112;112;112 13:29:37 INFO - PROCESS | 1659 | |1;audio-beat-detection;141;108;105;155;108;106;137;105;138;124 13:29:37 INFO - PROCESS | 1659 | |2;audio-dft;181;182;183;187;218;184;182;182;183;182 13:29:37 INFO - PROCESS | 1659 | |3;audio-fft;82;74;56;85;59;57;62;58;125;72 13:29:37 INFO - PROCESS | 1659 | |4;audio-oscillator;86;86;92;71;72;68;95;69;67;99 13:29:37 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;87;84;86;84;87;83;86;83;89;132 13:29:37 INFO - PROCESS | 1659 | |6;imaging-darkroom;97;92;93;93;92;93;93;93;92;92 13:29:37 INFO - PROCESS | 1659 | |7;imaging-desaturate;124;132;92;96;138;124;84;86;85;96 13:29:37 INFO - PROCESS | 1659 | |8;json-parse-financial;56;57;58;56;56;57;54;55;52;55 13:29:37 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;65;70;82;74;70;71;70;70;74;72 13:29:37 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;84;82;83;82;84;83;84;82;82;83 13:29:37 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;137;136;132;146;127;142;148;126;179;150 13:29:37 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;214;227;180;161;162;160;162;166;221;200 13:29:37 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;66;66;64;67;65;66;66;66;66;63 13:29:37 INFO - PROCESS | 1659 | __end_tp_report 13:29:37 INFO - PROCESS | 1659 | __start_cc_report 13:29:37 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2109 13:29:37 INFO - PROCESS | 1659 | __end_cc_report 13:29:37 INFO - PROCESS | 1659 | __startTimestamp1468355377497__endTimestamp 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | ------- Summary: start ------- 13:29:37 INFO - PROCESS | 1659 | Number of tests: 14 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.61 (3.2%) stddev-sans-first:0.50 13:29:37 INFO - PROCESS | 1659 | Values: 101.0 113.0 113.0 112.0 113.0 112.0 112.0 112.0 112.0 112.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:130.50 stddev:18.73 (14.3%) stddev-sans-first:18.65 13:29:37 INFO - PROCESS | 1659 | Values: 141.0 108.0 105.0 155.0 108.0 106.0 137.0 105.0 138.0 124.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:186.40 Median:183.00 stddev:11.23 (6.1%) stddev-sans-first:11.74 13:29:37 INFO - PROCESS | 1659 | Values: 181.0 182.0 183.0 187.0 218.0 184.0 182.0 182.0 183.0 182.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:73.00 Median:67.00 stddev:21.13 (31.5%) stddev-sans-first:22.16 13:29:37 INFO - PROCESS | 1659 | Values: 82.0 74.0 56.0 85.0 59.0 57.0 62.0 58.0 125.0 72.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:86.00 stddev:12.38 (14.4%) stddev-sans-first:12.97 13:29:37 INFO - PROCESS | 1659 | Values: 86.0 86.0 92.0 71.0 72.0 68.0 95.0 69.0 67.0 99.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:86.00 stddev:14.85 (17.3%) stddev-sans-first:15.71 13:29:37 INFO - PROCESS | 1659 | Values: 87.0 84.0 86.0 84.0 87.0 83.0 86.0 83.0 89.0 132.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:1.49 (1.6%) stddev-sans-first:0.53 13:29:37 INFO - PROCESS | 1659 | Values: 97.0 92.0 93.0 93.0 92.0 93.0 93.0 93.0 92.0 92.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:105.70 Median:85.50 stddev:21.26 (24.9%) stddev-sans-first:21.49 13:29:37 INFO - PROCESS | 1659 | Values: 124.0 132.0 92.0 96.0 138.0 124.0 84.0 86.0 85.0 96.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.71 (3.1%) stddev-sans-first:1.81 13:29:37 INFO - PROCESS | 1659 | Values: 56.0 57.0 58.0 56.0 56.0 57.0 54.0 55.0 52.0 55.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.50 stddev:4.39 (6.1%) stddev-sans-first:3.91 13:29:37 INFO - PROCESS | 1659 | Values: 65.0 70.0 82.0 74.0 70.0 71.0 70.0 70.0 74.0 72.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.88 (1.1%) stddev-sans-first:0.83 13:29:37 INFO - PROCESS | 1659 | Values: 84.0 82.0 83.0 82.0 84.0 83.0 84.0 82.0 82.0 83.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:144.00 stddev:15.37 (10.7%) stddev-sans-first:16.18 13:29:37 INFO - PROCESS | 1659 | Values: 137.0 136.0 132.0 146.0 127.0 142.0 148.0 126.0 179.0 150.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.30 Median:190.00 stddev:27.43 (14.4%) stddev-sans-first:27.05 13:29:37 INFO - PROCESS | 1659 | Values: 214.0 227.0 180.0 161.0 162.0 160.0 162.0 166.0 221.0 200.0 13:29:37 INFO - PROCESS | 1659 | 13:29:37 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 13:29:37 INFO - PROCESS | 1659 | Values: 66.0 66.0 64.0 67.0 65.0 66.0 66.0 66.0 66.0 63.0 13:29:37 INFO - PROCESS | 1659 | -------- Summary: end -------- 13:29:37 INFO - PROCESS | 1659 | 13:29:38 INFO - TEST-INFO | 1659: exit 0 13:29:38 INFO - TEST-OK | kraken | took 59106ms 13:29:38 INFO - SUITE-END | took 1175s 13:29:38 INFO - Completed test suite (00:19:35) 13:29:38 INFO - javascript benchmark 13:29:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2757.931051723707, 3368.0906155338043, 3379.9831000844993, 3392.9821053683895, 3407.369636617226, 5585.0, 5680.318361796591, 5696.8860622787515, 5775.682337471442, 5786.623869448483, 5743.712814359286, 5801.07182850744, 5801.274840644919, 5807.709614519278, 5809.186713860063, 5213.244079608455, 5246.606504512158, 5300.257963885059, 5306.044911915854, 5359.0, 5310.92033619496, 5347.786088556453, 5349.4753995111405, 5353.304070470834, 5359.981603495343, 5229.450907654679, 5252.264682944391, 5279.5512381447625, 5296.0, 5359.1425371940495, 5327.893442131136, 5349.037173308803, 5356.946430535722, 5366.758495867695, 5369.865753356158, 5160.664556803796, 5166.276721259027, 5176.171812509981, 5282.867928301785, 5289.206619007141, 4878.585320247783, 5651.9152212716845, 5704.657720536781, 5729.598928075036, 5777.0467872801355, 6267.122602835607, 6301.40136687014, 6306.463950564207, 6310.1481300024825, 6331.05034244867, 6236.844078898019, 6272.435480806749, 6347.936520634781, 6395.744170233185, 6421.582597131218, 5854.941450585439, 5872.0898260769645, 5894.528437725015, 5923.466887980059, 5939.851503712355, 6356.364363563606, 6365.4589359904, 6370.426661600478, 6374.426301632875, 6385.904211436832, 5942.970285148633, 6010.759569617254, 6127.036821038966, 6184.938150618526, 6186.443220110212, 6350.650714210763, 6357.745690172434, 6375.394337537927, 6377.904331435032, 6390.0734393512685, 6261.906071408933, 6315.305316415191, 6315.305316415191, 6325.272593651697, 6330.145430366933, 6134.877302453926, 6154.415330543591, 6157.907631385533, 6230.096635987757, 6335.176427064452, 4911.63162762787, 4936.851894443173, 4937.7777999990085, 4948.604111671058, 4949.727764972961, 4493.752843593568, 4499.955000450019, 4507.391502147234, 4513.503514613456, 4551.817927282872, 4927.679700819435, 5868.647881127146, 5876.41235876409, 5882.941170588325, 5933.881322373529, 6185.938140618537, 6274.403931626488, 6297.874042519124, 6348.0, 6415.133956915756, 5801.216835727123, 5820.388859169726, 5820.417958204231, 5824.621399609012, 5825.621334613236, 5423.403425623178, 5467.4532546745, 5484.149956756709, 5502.257195278667, 5529.529989950899, 6366.299707032223, 6424.453921416545, 6426.0, 6430.742770289323, 6440.420362167428, 6389.9361006389345, 6397.808065758035, 6408.711607977745, 6410.326915673973, 6420.486361091195, 6274.341194174728, 6283.8114856554375, 6334.9366506334345, 6349.68251587428, 6404.71178796946, 6255.0, 6270.9372906270355, 6277.811665650038, 6282.560220784501, 6298.338674439118, 6305.747770089145, 6365.2361716594305, 6370.044493326038, 6388.968055159695, 6391.424771770563, 5930.199423077829, 6004.309504407049, 6113.877722445615, 6133.579501509479, 6135.600157732601, 6207.565470417208, 6210.596311239755, 6215.316315205233, 6218.129461875251, 6218.22272215973, 6033.54748393881, 6058.818235452944, 6059.37393080821, 6059.969700151471, 6082.939170608237, 5512.255845460972, 6032.276126864805, 6092.839971250802, 6109.541784366102, 6112.602680825732, 5983.970080149571, 6006.918754624035, 6017.699115044318, 6020.187274717857, 6041.852048110845], "value": 5759.029186022625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.60328943424145, 517.131219551154, 522.5271129627687, 534.2493796216315, 539.6923753460527, 29687.554686679716, 30222.848885755568, 40617.59382406179, 41220.0, 41242.55651052214, 42964.355534667004, 43006.35490467645, 43235.3514697279, 43242.351364729475, 43358.783206084, 8601.182887625697, 9527.142557169871, 9699.951500242489, 9702.126808587225, 9713.46575938323, 8736.344774141933, 11567.595134170306, 11776.646700598996, 11777.116716246315, 12139.817902731465, 11757.294562326246, 11831.290122592629, 11836.289822610628, 11839.7632047359, 11858.169928105037, 8567.057623661392, 11536.59621913229, 11727.648170554854, 11752.0, 11798.23311484755, 11657.475413606408, 11737.530498780125, 11752.588659396966, 11754.29474231549, 11756.0, 33790.0, 40575.59424405748, 40975.0, 41057.0, 41158.58841411577, 3505.0711561435983, 3507.0530956641564, 3513.94729079064, 3565.2691198304287, 3696.632246068945, 31213.0, 31771.887983920682, 31879.840600796848, 32131.03606891797, 32169.356612867847, 3251.7723759336855, 3312.420326442887, 3333.666633336671, 3366.7979921204806, 3414.573178352706, 539747.0, 542788.0, 543416.0, 543847.0, 544669.2766536182, 33482.49776253358, 62042.68978655078, 63237.0, 63292.68353658202, 63365.68317158385, 34429.48355774665, 35940.64059359425, 35952.64047359545, 35969.820150899075, 36067.639323606956, 12549.435275412447, 14753.483628072965, 14978.850211497745, 14984.850151498564, 14992.925035374754, 11461.197716159788, 11682.824757628643, 12535.059870509565, 12721.236725796482, 12772.361381931052, 7799.415043871732, 7816.765497035098, 7848.803779905434, 7887.44787864844, 7901.683932642745, 3272.574565306495, 3290.341931613687, 3300.9834950825093, 3323.9169020774675, 3335.0995231287416, 923.8475651517559, 934.3366209990846, 1005.0903931941605, 1042.0621440703276, 1059.1950117910444, 30255.243618909702, 30256.243593909887, 30803.845980770402, 31036.53445198324, 31080.533791993137, 1010.8534262532039, 1063.404493483636, 1135.5855112883737, 1151.78691941991, 1172.5954545681727, 15836.92081539585, 15861.0, 15887.364505419653, 16314.592135196715, 16494.34022639081, 729497.0, 735228.0, 736449.0, 737500.0, 739326.0, 59549.404505954386, 60170.0, 60190.09714854281, 60290.0, 60316.0, 1269.536619134028, 1382.3710211853584, 1406.4444544405108, 1429.4139402844783, 1436.3321055708936, 26542.734572654026, 31131.0, 31583.36833263368, 32352.676473235908, 33596.83201583976, 49541.50458495369, 49691.0, 50337.49662503474, 50448.0, 50469.242961354874, 576912.0, 577971.0, 578143.0, 578564.0, 578795.1060244672, 22319.665205022262, 24096.0, 24746.0, 26100.34749131287, 26829.865850670623, 47511.0, 48853.5114648849, 48931.26603101027, 49040.5095949036, 49302.26046609376, 38797.61202388053, 39636.0, 40160.59839401569, 41030.79484602558, 41143.17713645651, 39606.80196598999, 40146.59853401545, 40811.0, 41790.95522611959, 42991.1401771969, 32504.512432313062, 38941.0, 39036.41445378265, 39698.40452393274, 39809.80095099506, 28747.0, 34044.65955340415, 35502.0, 35566.822165889, 35583.64416355907, 22634.773652263924, 25541.9783208677, 25593.0, 26086.0, 27397.0], "value": 19325.48415277939, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.72584835525026, 383.8541354285372, 387.7867173054821, 390.23708649590054, 413.0582272418884, 14956.177410242432, 15669.52991410258, 21041.737495750265, 21575.676364854502, 21709.0, 21331.0, 22340.441488962784, 22448.0, 22798.54402911945, 22899.771002290014, 5956.225690660208, 6006.309274433442, 6164.7534098636, 6193.256809182882, 6201.906971395432, 4232.788360581974, 6096.4513193812545, 6143.262808462969, 6583.275839657634, 6922.757703480379, 6917.861642767141, 6919.550229235084, 6920.861582768342, 6932.514723969299, 6934.583924964493, 7048.506604537684, 7832.0, 7848.136704962478, 7901.723439679584, 7907.169747176521, 7460.552366858006, 7530.1340345859835, 7648.808779780495, 7650.42621803367, 7670.578118203496, 27948.860255698793, 29180.416391672046, 29445.411091778045, 29471.0, 29929.551056734166, 2416.516696660675, 2417.5648383291, 2470.110760126353, 2832.6459192600923, 2991.7157870002316, 16201.669595782154, 16638.83361166385, 17215.22531486086, 17479.737803932952, 18107.45677629673, 1790.8030116687155, 1977.1399441243104, 2068.75174979002, 2154.8491605587615, 2188.376312750874, 132646.6735332644, 133593.99609005873, 135041.0, 136597.0, 137356.0, 20914.16343346249, 20949.162033518794, 20982.950852457318, 21010.949452527617, 21154.682679759815, 35200.64799352025, 35278.29443411117, 35298.76454324086, 35368.46947295793, 35387.82306088504, 10958.232923695265, 11128.888711112948, 11145.721356965978, 11156.274842135235, 11321.264117832314, 8894.777630559158, 8960.507172105597, 9226.53867306632, 9279.860802087975, 9394.342396032349, 9418.681384606161, 9728.854067188999, 9742.561584728704, 9848.359856609297, 9892.653757118467, 3151.4158390119883, 3299.736021118305, 3794.79128647927, 3801.695864330902, 3814.7329686922203, 891.4250308550949, 944.900785417535, 956.086936975187, 1006.8842083160383, 1047.6887607495103, 19739.506512337306, 20803.791962080184, 21081.683774743393, 21236.36290911275, 21249.36251912445, 930.7486978515763, 955.5604421965974, 965.9758506037265, 982.1455333859587, 1046.2048842879467, 10732.463376831127, 10943.781124377469, 10968.067714244378, 11019.0, 11057.22599418033, 557684.0, 563224.0, 567802.0, 569927.0, 573155.0, 75312.0, 77601.0, 110553.0, 118763.40618296854, 120655.0, 963.4893506441597, 988.1847475832467, 998.730342807438, 1002.1331548210891, 1002.4336250018716, 18685.90657046706, 19061.237550497826, 19084.85490870552, 19144.712829307293, 19157.904210478857, 37013.0, 48428.7578562119, 49742.0, 52227.0, 53113.7344313276, 63965.04052439124, 76068.61965690136, 77818.44363112593, 79838.00404989922, 80268.59865700868, 7332.826747720339, 7682.6158692064055, 7920.960395198218, 8143.918560814316, 8397.748067557983, 9280.489573073546, 12447.0, 12619.74760504803, 13083.803742944054, 13233.602991910258, 11460.369679667698, 11588.594399195988, 11793.705157371134, 11878.287302761863, 11981.76036479248, 9603.135717785433, 11469.942650286695, 11600.955913967784, 11641.53433862636, 11831.349275789915, 11653.41732913368, 11839.940800296288, 11957.94021029924, 11992.100592455776, 12002.519899203933, 8200.917990820015, 8389.95805020971, 8568.957155214184, 8572.27135693473, 8652.351073669373, 10224.13094886943, 10904.34573925567, 11129.443527823738, 11314.208005439541, 11808.586699465477], "value": 10965.635875842647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.7178192579559, 1467.9266036698161, 1504.9473268435606, 1532.532577563843, 1852.5461261990815, 7898.289153976141, 8205.302549283311, 8206.343492520606, 8511.659533618647, 8779.2098711116, 8581.141885811416, 8692.261157801595, 8769.736907892757, 8800.823983520326, 8813.4711917285, 2346.354752443079, 2375.596148654733, 2375.893084811179, 2376.702912135983, 2382.4996750682376, 2307.238611258281, 2346.6128088865316, 2350.717913850332, 2350.870702111392, 2352.6118190498632, 2308.3305841306087, 2323.6049871521795, 2333.3583264602203, 2362.2676970139228, 2373.0, 2286.942826429336, 2319.1446842525997, 2326.93019209424, 2329.615613423783, 2334.8832558372014, 2305.5849947009533, 2306.2965795432387, 2308.1113771198043, 2311.7688231176917, 2319.026009076192, 8723.0, 8787.736367908909, 8808.823823523493, 8810.339224558184, 8834.337424693174, 5136.460671629462, 5320.441353657849, 5322.33470816148, 5364.839054828361, 5394.460553944614, 3438.8108654024018, 3544.2379888323876, 3594.4248920172645, 3610.656987586175, 3622.9094272643133, 1067.7010437077631, 1079.22835172851, 1085.2240647936762, 1086.283053184902, 1101.0255923507752, 11464.885351146466, 11558.768824623461, 11578.073754099652, 11595.01442377399, 11620.0, 4310.4611923509565, 4345.543717909637, 4532.501424843264, 4533.274676051816, 4565.680402371869, 9060.95469522648, 9099.226565741987, 9102.317326200562, 9102.362834601514, 9104.089591040974, 4401.867943961686, 5197.66215196011, 5200.947990520122, 5205.687658740488, 5212.921806172911, 4330.069035157457, 4383.211022016004, 4478.104379124123, 4663.417072865892, 4871.537203965618, 3254.7558933080113, 3647.814460300413, 3702.9814850925573, 3793.0, 3837.9232415351535, 1150.872145297613, 1159.310210424796, 1162.3258510064143, 1167.5947548051042, 1172.8123500239922, 937.2829785214317, 947.7204224753714, 949.2026697574071, 950.4392408478892, 994.2193107601819, 5820.272465941757, 5847.590668653239, 5899.056151015817, 6045.848853778691, 6261.906071408933, 429.4524481286322, 438.62935819232695, 441.83210380055374, 448.8339314453673, 455.8860284928768, 3678.6689197971778, 3684.9263014739554, 3796.1405244928255, 4044.9797751011647, 4089.3865920111625, 9925.702228933143, 10261.692149235534, 10290.3825770454, 10397.376157430579, 10675.57297708083, 10045.598176073021, 10223.591056357662, 10372.896271037343, 10374.17006639467, 10377.688669339932, 7682.846343073107, 8103.068147163034, 8172.305354044854, 8173.754787356389, 8186.467879587927, 5946.910796338145, 6122.908156377569, 6156.476699480594, 6157.84605384869, 6159.784407545714, 9412.576434060347, 9893.159081478156, 9902.356346837432, 9904.851427228741, 9911.950440247752, 9593.568289426852, 10105.191584673355, 10116.544755485873, 10129.240306977154, 10163.475478677961, 7539.434542409232, 7763.146053934176, 7767.495112817649, 8230.917690823015, 8399.874001889855, 7281.963590182015, 7881.802954926173, 8377.748667539983, 8519.74440766778, 8527.616257268313, 7163.856722865409, 7418.146913105062, 7521.135069467081, 7577.431692622965, 7588.354989825927, 7391.113066432063, 7429.14564825052, 7444.888326674996, 7515.436342274461, 7522.097348318237, 5663.943360566342, 6965.199002114821, 7034.613096279753, 7137.892931606134, 7139.21468638439, 4288.378185163197, 4449.9777501112285, 4890.779914903909, 5004.84985450437, 5160.561352284948, 4148.191102734938, 5075.8477245681215, 5107.310513080686, 5118.820841270538, 5151.25306830515], "value": 4427.837118770753, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3160126512816, 307.93687294104706, 317.09469464678335, 320.30014418495574, 320.98074115553067, 3989.780562069089, 4672.229082201441, 5123.820666276681, 5154.149565321717, 5311.0, 5155.948440515594, 5317.5480084192795, 5327.786888524454, 5342.492463215998, 5361.544268737162, 3601.7298702597277, 4095.9180816383655, 4130.938035929464, 4150.149219410029, 4161.791910404483, 3897.395903634927, 4090.9363565472895, 4170.77060761658, 4186.853460128896, 4259.446271984638, 3450.396180668373, 3965.2267807777494, 4027.3153563894207, 4047.7166598338126, 4061.451704019949, 3505.6494350564994, 4059.5737447567876, 4072.3891416287497, 4074.8981275468054, 4090.97954510227, 3074.9391459946282, 3367.9158021049425, 3394.4738565522384, 3550.236699109678, 3555.928881422357, 4195.202911446815, 4264.893377665552, 4288.485381754178, 4780.040183524773, 4935.481774413706, 3902.317094508478, 3966.3455529837543, 4621.260598304255, 4656.674032817704, 4660.650451216173, 4943.357363542752, 5051.0, 5442.455754424565, 5532.723363831792, 5636.351819540764, 3376.763626546143, 3453.3783918894587, 3647.215848592539, 3814.828332725034, 3856.4986551748093, 5040.487853643929, 5761.942380576183, 5791.652500849962, 5797.724285778521, 5816.709164541799, 3549.432090865449, 3655.814554655776, 3845.1925095729653, 3862.4013277941963, 3864.8840534784003, 3882.941755873664, 3899.9610003900166, 3913.295606790748, 3915.667168290727, 3918.529776426847, 4493.73037617744, 4520.932186017212, 4528.43394575678, 4529.207388706963, 4541.386912766734, 4579.496255411902, 5366.731663416814, 5527.972360138174, 5533.4782934693285, 5555.333359996826, 1074.4573990134932, 1273.2296960339047, 1294.9287789171685, 1342.7448784731066, 1350.6960933790015, 886.2334081019872, 888.5512816027865, 904.895936967244, 908.9863652045225, 914.5244472874068, 4609.654275929319, 4698.506656800987, 5228.4510126436935, 5240.4497527759795, 5255.84371438283, 5726.3700992890745, 5729.0, 5737.254156959569, 5740.47419135579, 5879.824464947997, 4864.416270047546, 4969.602431805447, 5203.609729270244, 5208.85405210853, 5214.530692237641, 2118.9682154767693, 2159.492519257973, 2165.8917054147228, 2537.67010288665, 2545.7454254574395, 4675.335059016328, 4966.379202599675, 5001.0, 5004.649674522749, 5006.322881834553, 3752.699784017272, 4409.2724700424715, 4835.8065677373215, 4928.605711543068, 4952.678075925053, 4094.3653733670735, 4424.070945101565, 4981.551660350586, 5008.5993120550265, 5044.511868998654, 4015.277250094894, 4613.569793364068, 4723.748206725152, 4840.491748366371, 4847.2729090636685, 3695.7043436524477, 4311.2455320318195, 4760.214564596803, 4782.928256076231, 4815.3499277597075, 4131.648809851196, 4392.407025051577, 5008.749562521933, 5013.573846222966, 5056.8988620226655, 3100.891468798581, 3235.951460728044, 3606.3688854450893, 3779.4519794629073, 3795.7532760370486, 5752.453516915886, 5761.971190144022, 5768.884622307446, 5781.988152073286, 5790.870780197821, 5159.716215608028, 5603.35561410443, 5605.383407825218, 5632.746526406239, 5636.731735359512, 4915.311856340187, 5310.627751377826, 5563.276774019351, 5593.846369147826, 5597.285316621516, 5428.430014848384, 5467.644603100785, 5469.835904922858, 5471.2887324647545, 5487.670739755627, 5245.265662807134, 5311.893762124813, 5576.525995290283, 5583.134614134816, 5626.5780066496, 5453.291072160594, 5453.536449401687, 5468.316460442445, 5477.4796394342475, 5499.807506737245], "value": 3910.470306059903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.100726609903, 792.1800936031207, 793.8134538383479, 835.098094058417, 852.3053711225355, 17364.0, 17937.730934036, 17938.82061179388, 17966.0, 17986.910065449672, 16777.832221677778, 16942.3223071077, 16944.576385590368, 16965.236564354604, 17028.914855425737, 589.9498542623882, 742.3652776875774, 746.2500187311745, 925.3568769705058, 928.7538802217417, 874.1564390363299, 905.2350763604743, 910.0126362896233, 911.9726408207731, 913.0139449394638, 949.392388871123, 962.5668449197854, 962.9807403851919, 963.330485312708, 966.3911735606558, 748.6294284329292, 922.4741897118645, 955.5556666150273, 957.5260246178117, 958.6644674363987, 714.9356557909813, 716.1227496317022, 719.5358993449248, 719.6473727873357, 721.1778572427437, 15329.156896370696, 15365.308561114776, 15384.692306153926, 15386.9230653846, 15443.768343474856, 13222.338883055905, 13535.864641353559, 13812.792808107886, 13857.792133118011, 13860.960427967942, 12875.935620321932, 12894.677633059155, 13058.2817945013, 13125.015623828156, 13521.52674656392, 4046.6358027777346, 4617.683960071397, 4644.0, 4739.312799644067, 4791.281307803857, 110774.0, 112227.0, 112396.0, 112594.0, 112728.4363578185, 10351.896481035245, 10515.631952881766, 10631.043206111332, 10676.466176691134, 10794.568217271379, 21055.473613159487, 21063.78936210649, 21100.261490847748, 21116.78883211179, 21118.683219751714, 7886.487378320391, 8022.879656805153, 8074.152214017444, 8261.504309741435, 8348.998120225611, 4522.389477420572, 4594.839180628729, 4617.538246175355, 4675.509071547506, 4744.691595046311, 3483.7909725416557, 3625.492431059654, 3628.6915612172734, 3633.3459977204357, 3633.5276414066, 694.7672529702505, 716.6560051175464, 727.7925791149603, 734.075065417567, 747.2788758847738, 648.3775575447623, 652.6638781027774, 688.8587839492892, 689.9655017249117, 690.3545185251805, 8611.78470538229, 8781.956090219635, 9616.95191524038, 9725.708228753148, 9815.36200146988, 636.8439732265624, 671.5597420735173, 674.3458844920517, 693.3032302535919, 694.5277211496131, 4056.3307054336296, 4535.866033491627, 4644.442666879929, 4812.8796780080775, 4828.497740199633, 170267.28934817022, 171518.99683511019, 172580.0, 173432.0, 174130.12934935244, 142289.0, 144651.5534844638, 145873.0, 147173.0, 150590.0, 113691.86308136812, 121227.0, 122380.0, 122422.38788806, 123022.0, 9517.238620910171, 9646.90353096488, 9653.227741780782, 9665.323427360017, 9768.462734549385, 41777.43562569727, 45071.77464112658, 58184.254472365894, 62205.37794622177, 63739.6813015932, 81744.59127704323, 85987.0, 97427.0, 97844.0, 98724.0, 13312.600621981355, 13440.991925605815, 13500.257485838372, 13644.249566273951, 13732.0, 15181.772273416129, 15182.0, 15197.77203341973, 15226.619334516725, 15417.229138542803, 13946.0, 13956.421562785346, 13973.510927117502, 14095.436182552583, 14205.360758765673, 13610.931945340606, 13820.378082986088, 14051.768629163556, 14116.78824817608, 14596.85403145955, 11680.415979200836, 13732.588022359345, 13844.86155138476, 13877.0, 14406.711865762416, 11416.0, 11428.742838287615, 11618.88381116178, 11681.259554867314, 12097.2136811107, 11401.543938242708, 11539.36533490666, 11680.06559475223, 11688.357140357022, 11710.765784684088], "value": 8175.039524853749, "unit": "score"}], "name": "dromaeo_css", "value": 7462.982546179648, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 105.0, 155.0, 108.0, 106.0, 137.0, 105.0, 138.0, 124.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 183.0, 187.0, 218.0, 184.0, 182.0, 182.0, 183.0, 182.0], "value": 186.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 56.0, 85.0, 59.0, 57.0, 62.0, 58.0, 125.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 92.0, 71.0, 72.0, 68.0, 95.0, 69.0, 67.0, 99.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 87.0, 83.0, 86.0, 83.0, 89.0, 132.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0, 92.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 132.0, 92.0, 96.0, 138.0, 124.0, 84.0, 86.0, 85.0, 96.0], "value": 105.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 56.0, 56.0, 57.0, 54.0, 55.0, 52.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 82.0, 74.0, 70.0, 71.0, 70.0, 70.0, 74.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 82.0, 84.0, 83.0, 84.0, 82.0, 82.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 132.0, 146.0, 127.0, 142.0, 148.0, 126.0, 179.0, 150.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 227.0, 180.0, 161.0, 162.0, 160.0, 162.0, 166.0, 221.0, 200.0], "value": 185.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 63.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1466.0, "alertThreshold": 2.0}]} 13:29:38 INFO - Return code: 0 13:29:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:38 INFO - # TBPL SUCCESS # 13:29:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:29:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:29:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:29:38 INFO - 2016-07-12 13:29:38.783 screenresolution[1663:9930] starting screenresolution argv=screenresolution get 13:29:38 INFO - 2016-07-12 13:29:38.786 screenresolution[1663:9930] Display 0: 1600x1200x32@60 13:29:38 INFO - 2016-07-12 13:29:38.792 screenresolution[1664:9933] starting screenresolution argv=screenresolution list 13:29:38 INFO - Available Modes on Display 0 13:29:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:29:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:29:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:29:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:29:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:29:39 INFO - Intel Iris: 13:29:39 INFO - Chipset Model: Intel Iris 13:29:39 INFO - Type: GPU 13:29:39 INFO - Bus: Built-In 13:29:39 INFO - VRAM (Dynamic, Max): 1536 MB 13:29:39 INFO - Vendor: Intel (0x8086) 13:29:39 INFO - Device ID: 0x0a2e 13:29:39 INFO - Revision ID: 0x0009 13:29:39 INFO - Displays: 13:29:39 INFO - Display: 13:29:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:29:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:29:39 INFO - Display Serial Number: 1600x1200 60 13:29:39 INFO - Main Display: Yes 13:29:39 INFO - Mirror: Off 13:29:39 INFO - Online: Yes 13:29:39 INFO - Rotation: Supported 13:29:39 INFO - Return code: 0 13:29:39 INFO - Running post-action listener: _resource_record_post_action 13:29:39 INFO - ##### 13:29:39 INFO - ##### Finished run-tests step (success) 13:29:39 INFO - ##### 13:29:39 INFO - Running post-run listener: _resource_record_post_run 13:29:39 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 31563264; Write bytes: 705744384; Read time: 198; Write time: 1955 13:29:39 INFO - TinderboxPrint: CPU usage
53.6% 13:29:39 INFO - TinderboxPrint: I/O read bytes / time
31,563,264 / 198 13:29:39 INFO - TinderboxPrint: I/O write bytes / time
705,744,384 / 1,955 13:29:39 INFO - TinderboxPrint: CPU idle
2,247.5 (46.4%) 13:29:39 INFO - TinderboxPrint: CPU system
969.1 (20.0%) 13:29:39 INFO - TinderboxPrint: CPU user
1,625.1 (33.6%) 13:29:39 INFO - TinderboxPrint: Swap in / out
433,827,840 / 0 13:29:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404367872; Write bytes: 398325248; Read time: 29752; Write time: 852 13:29:39 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29052416; Write bytes: 295598080; Read time: 173; Write time: 1068 13:29:39 INFO - Running post-run listener: _upload_blobber_files 13:29:39 INFO - Blob upload gear active. 13:29:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:39 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 13:29:39 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:39 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:39 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:40 INFO - (blobuploader) - INFO - Done attempting. 13:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:41 INFO - (blobuploader) - INFO - Done attempting. 13:29:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:43 INFO - (blobuploader) - INFO - Done attempting. 13:29:43 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:43 INFO - Return code: 0 13:29:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd4a3021e72c8def4b23a2409fedef6a23c161c340960f48635aee95333df750447601c590c53000f8da26fdd5f8a8b515f7ede23112dcbae8bfeeb118392a93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f3e5e67dcbd637d2ed7e950bb2de37a90ff06ba9a5829ee26dbb9d834384f94baf6975c7424bcb0e36cff01fd0c86ac25b84aad46ff6357148c0d3a9f183a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b15b70b9c8193e7561289257b0f40748fb9b83435f30f448aae2f8e1ed2c401dfee7b7f89225ea273c105403905ba4d9411484086ed7eb2d0b24781e10030892"} 13:29:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:43 INFO - Contents: 13:29:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd4a3021e72c8def4b23a2409fedef6a23c161c340960f48635aee95333df750447601c590c53000f8da26fdd5f8a8b515f7ede23112dcbae8bfeeb118392a93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f3e5e67dcbd637d2ed7e950bb2de37a90ff06ba9a5829ee26dbb9d834384f94baf6975c7424bcb0e36cff01fd0c86ac25b84aad46ff6357148c0d3a9f183a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b15b70b9c8193e7561289257b0f40748fb9b83435f30f448aae2f8e1ed2c401dfee7b7f89225ea273c105403905ba4d9411484086ed7eb2d0b24781e10030892"} 13:29:43 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:43 INFO - Copying logs to upload dir... 13:29:43 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.213505 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-07-12 13:29:44.058771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 13:29:44.062435) ========= 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.jneSx0JIOE/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.R62zdz0ak6/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/Fx-Team/sha512/dd4a3021e72c8def4b23a2409fedef6a23c161c340960f48635aee95333df750447601c590c53000f8da26fdd5f8a8b515f7ede23112dcbae8bfeeb118392a93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f3e5e67dcbd637d2ed7e950bb2de37a90ff06ba9a5829ee26dbb9d834384f94baf6975c7424bcb0e36cff01fd0c86ac25b84aad46ff6357148c0d3a9f183a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b15b70b9c8193e7561289257b0f40748fb9b83435f30f448aae2f8e1ed2c401dfee7b7f89225ea273c105403905ba4d9411484086ed7eb2d0b24781e10030892"} build_url:https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011074 build_url: 'https://queue.taskcluster.net/v1/task/CRU5delrTC2rH9R7VKno4Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd4a3021e72c8def4b23a2409fedef6a23c161c340960f48635aee95333df750447601c590c53000f8da26fdd5f8a8b515f7ede23112dcbae8bfeeb118392a93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f3e5e67dcbd637d2ed7e950bb2de37a90ff06ba9a5829ee26dbb9d834384f94baf6975c7424bcb0e36cff01fd0c86ac25b84aad46ff6357148c0d3a9f183a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b15b70b9c8193e7561289257b0f40748fb9b83435f30f448aae2f8e1ed2c401dfee7b7f89225ea273c105403905ba4d9411484086ed7eb2d0b24781e10030892"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 13:29:44.094867) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:29:44.095208) ========= 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.jneSx0JIOE/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.R62zdz0ak6/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005190 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:29:44.143910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 13:29:44.144302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 13:29:44.144728) ========= ========= Total master_lag: 3.07 =========