builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1467975366.75 results: success (0) buildid: 20160708022626 builduid: 91e0a894a7dd41bfa26563067f62c440 revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:06.754541) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:06.755278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:06.755857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:06.782711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:06.783233) ========= 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.dqC1uBUHpf/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.iqrg0cyH89/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-08 03:56:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.7M=0.001s 2016-07-08 03:56:06 (13.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167784 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:06.974574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:06.974890) ========= 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.dqC1uBUHpf/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.iqrg0cyH89/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.028583 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:07.025504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:07.026040) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 806cd7a7b68de8777caf419239e2f4e671aaa80b --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 806cd7a7b68de8777caf419239e2f4e671aaa80b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dqC1uBUHpf/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.iqrg0cyH89/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-08 03:56:07,102 truncating revision to first 12 chars 2016-07-08 03:56:07,102 Setting DEBUG logging. 2016-07-08 03:56:07,102 attempt 1/10 2016-07-08 03:56:07,103 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/806cd7a7b68d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 03:56:07,816 unpacking tar archive at: fx-team-806cd7a7b68d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:08.005117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:08.005424) ========= script_repo_revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:08.005850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:08.006154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:56:08.024840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 44 mins, 24 secs) (at 2016-07-08 03:56:08.025280) ========= /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.dqC1uBUHpf/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.iqrg0cyH89/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:08 INFO - MultiFileLogger online at 20160708 03:56:08 in /builds/slave/test 03:56:08 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 03:56:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:56:08 INFO - {'append_to_log': False, 03:56:08 INFO - 'base_work_dir': '/builds/slave/test', 03:56:08 INFO - 'blob_upload_branch': 'Fx-Team', 03:56:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:56:08 INFO - 'branch': 'Fx-Team', 03:56:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:56:08 INFO - 'config_files': ('talos/mac_config.py',), 03:56:08 INFO - 'default_actions': ('clobber', 03:56:08 INFO - 'read-buildbot-config', 03:56:08 INFO - 'download-and-extract', 03:56:08 INFO - 'populate-webroot', 03:56:08 INFO - 'create-virtualenv', 03:56:08 INFO - 'install', 03:56:08 INFO - 'run-tests'), 03:56:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:56:08 INFO - 'download_minidump_stackwalk': True, 03:56:08 INFO - 'download_symbols': 'ondemand', 03:56:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:56:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:56:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:56:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:56:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:56:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:56:08 INFO - 'installer_path': 'installer.exe', 03:56:08 INFO - 'log_level': 'info', 03:56:08 INFO - 'log_name': 'talos', 03:56:08 INFO - 'log_to_console': True, 03:56:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:56:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:56:08 INFO - 'opt_config_files': (), 03:56:08 INFO - 'pip_index': False, 03:56:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:56:08 INFO - 'cmd': ('bash', 03:56:08 INFO - '-c', 03:56:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:56:08 INFO - 'enabled': True, 03:56:08 INFO - 'halt_on_failure': False, 03:56:08 INFO - 'name': 'check_screen_resolution'},), 03:56:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:56:08 INFO - 'cmd': ('bash', 03:56:08 INFO - '-c', 03:56:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:56:08 INFO - 'enabled': True, 03:56:08 INFO - 'halt_on_failure': False, 03:56:08 INFO - 'name': 'check_screen_resolution'},), 03:56:08 INFO - 'run_cmd_checks_enabled': True, 03:56:08 INFO - 'sps_profile': False, 03:56:08 INFO - 'sps_profile_interval': 0, 03:56:08 INFO - 'suite': 'dromaeojs', 03:56:08 INFO - 'system_bits': '32', 03:56:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:56:08 INFO - 'title': 't-yosemite-r7-0177', 03:56:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:56:08 INFO - 'use_talos_json': True, 03:56:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:56:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:56:08 INFO - 'work_dir': 'build'} 03:56:08 INFO - ##### 03:56:08 INFO - ##### Running clobber step. 03:56:08 INFO - ##### 03:56:08 INFO - Running pre-action listener: _resource_record_pre_action 03:56:08 INFO - Running main action method: clobber 03:56:08 INFO - rmtree: /builds/slave/test/build 03:56:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:56:09 INFO - Running post-action listener: _resource_record_post_action 03:56:09 INFO - ##### 03:56:09 INFO - ##### Finished clobber step (success) 03:56:09 INFO - ##### 03:56:09 INFO - ##### 03:56:09 INFO - ##### Running read-buildbot-config step. 03:56:09 INFO - ##### 03:56:09 INFO - Running pre-action listener: _resource_record_pre_action 03:56:09 INFO - Running main action method: read_buildbot_config 03:56:09 INFO - Using buildbot properties: 03:56:09 INFO - { 03:56:09 INFO - "project": "", 03:56:09 INFO - "product": "firefox", 03:56:09 INFO - "script_repo_revision": "production", 03:56:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:56:09 INFO - "repository": "", 03:56:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:56:09 INFO - "buildid": "20160708022626", 03:56:09 INFO - "pgo_build": "False", 03:56:09 INFO - "basedir": "/builds/slave/test", 03:56:09 INFO - "buildnumber": 877, 03:56:09 INFO - "slavename": "t-yosemite-r7-0177", 03:56:09 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:56:09 INFO - "platform": "yosemite_r7", 03:56:09 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:56:09 INFO - "branch": "fx-team", 03:56:09 INFO - "repo_path": "integration/fx-team", 03:56:09 INFO - "revision": "806cd7a7b68de8777caf419239e2f4e671aaa80b", 03:56:09 INFO - "stage_platform": "macosx64", 03:56:09 INFO - "builduid": "91e0a894a7dd41bfa26563067f62c440", 03:56:09 INFO - "slavebuilddir": "test" 03:56:09 INFO - } 03:56:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 03:56:09 INFO - Running post-action listener: _resource_record_post_action 03:56:09 INFO - ##### 03:56:09 INFO - ##### Finished read-buildbot-config step (success) 03:56:09 INFO - ##### 03:56:09 INFO - ##### 03:56:09 INFO - ##### Running download-and-extract step. 03:56:09 INFO - ##### 03:56:09 INFO - Running pre-action listener: _resource_record_pre_action 03:56:09 INFO - Running main action method: download_and_extract 03:56:09 INFO - mkdir: /builds/slave/test/build/tests 03:56: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')]} 03:56:09 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:11 INFO - Downloaded 1199 bytes. 03:56:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 03:56:11 INFO - Using the following test package requirements: 03:56:11 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:56:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 03:56:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 03:56:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'jsshell-mac.zip'], 03:56:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 03:56:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:56:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 03:56:11 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 03:56:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 03:56:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:56:11 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 03:56:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:11 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:12 INFO - Downloaded 18806272 bytes. 03:56:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:56:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:56:15 INFO - Return code: 0 03:56:15 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 03:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:15 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:16 INFO - Downloaded 18806272 bytes. 03:56:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:56:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:56:20 INFO - Return code: 0 03:56:20 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')]} 03:56:20 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:56:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:56:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:56:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:21 INFO - Downloaded 14403333 bytes. 03:56:21 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'] 03:56:21 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 03:56:21 INFO - Return code: 0 03:56: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')]} 03:56:21 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:56:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:56:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:56:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 03:56:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/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 03:56:24 INFO - Downloaded 112425256 bytes. 03:56:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:56:24 INFO - mkdir: /builds/slave/test/properties 03:56:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:56:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:56:24 INFO - Contents: 03:56:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:56:25 INFO - Running post-action listener: _resource_record_post_action 03:56:25 INFO - Running post-action listener: set_extra_try_arguments 03:56:25 INFO - ##### 03:56:25 INFO - ##### Finished download-and-extract step (success) 03:56:25 INFO - ##### 03:56:25 INFO - ##### 03:56:25 INFO - ##### Running populate-webroot step. 03:56:25 INFO - ##### 03:56:25 INFO - Running pre-action listener: _resource_record_pre_action 03:56:25 INFO - Running main action method: populate_webroot 03:56:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:56:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:56:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:56:25 INFO - '--tppagecycles', 03:56:25 INFO - '7'], 03:56:25 INFO - 'tests': ['tsvgm']}}, 03:56:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:56:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:56:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:56:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:56:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['damp', 'tps']}, 03:56:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'tests': ['damp', 'tps']}, 03:56:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['dromaeo_dom']}, 03:56:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:56:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['basic_compositor_video']}, 03:56:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:56:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['a11yr', 03:56:25 INFO - 'ts_paint', 03:56:25 INFO - 'tpaint', 03:56:25 INFO - 'sessionrestore', 03:56:25 INFO - 'sessionrestore_no_auto_restore', 03:56:25 INFO - 'tabpaint']}, 03:56:25 INFO - 'other-e10s': {'tests': ['a11yr', 03:56:25 INFO - 'ts_paint', 03:56:25 INFO - 'tpaint', 03:56:25 INFO - 'sessionrestore', 03:56:25 INFO - 'sessionrestore_no_auto_restore', 03:56:25 INFO - 'tabpaint']}, 03:56:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:56:25 INFO - 'ts_paint', 03:56:25 INFO - 'tpaint', 03:56:25 INFO - 'sessionrestore', 03:56:25 INFO - 'sessionrestore_no_auto_restore', 03:56:25 INFO - 'tabpaint']}, 03:56:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:56:25 INFO - 'ts_paint', 03:56:25 INFO - 'tpaint', 03:56:25 INFO - 'sessionrestore', 03:56:25 INFO - 'sessionrestore_no_auto_restore', 03:56:25 INFO - 'tabpaint']}, 03:56:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['a11yr', 03:56:25 INFO - 'ts_paint', 03:56:25 INFO - 'tpaint', 03:56:25 INFO - 'sessionrestore', 03:56:25 INFO - 'sessionrestore_no_auto_restore', 03:56:25 INFO - 'tabpaint']}, 03:56:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['a11yr', 03:56:25 INFO - 'ts_paint', 03:56:25 INFO - 'tpaint', 03:56:25 INFO - 'sessionrestore', 03:56:25 INFO - 'sessionrestore_no_auto_restore', 03:56:25 INFO - 'tabpaint']}, 03:56:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['tsvgx', 03:56:25 INFO - 'tsvgr_opacity', 03:56:25 INFO - 'tart', 03:56:25 INFO - 'tscrollx', 03:56:25 INFO - 'cart']}, 03:56:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:56:25 INFO - 'tsvgr_opacity', 03:56:25 INFO - 'tart', 03:56:25 INFO - 'tscrollx', 03:56:25 INFO - 'cart']}, 03:56:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'talos_options': ['--disable-e10s'], 03:56:25 INFO - 'tests': ['tp5o']}, 03:56:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'tests': ['tp5o']}, 03:56:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'talos_options': ['--disable-e10s', 03:56:25 INFO - '--xperf_path', 03:56:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:25 INFO - 'tests': ['tp5n']}, 03:56:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:25 INFO - 'talos_options': ['--xperf_path', 03:56:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:25 INFO - 'tests': ['tp5n']}}, 03:56:25 INFO - 'talos.zip': {'path': '', 03:56:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:56:25 INFO - Running post-action listener: _resource_record_post_action 03:56:25 INFO - ##### 03:56:25 INFO - ##### Finished populate-webroot step (success) 03:56:25 INFO - ##### 03:56:25 INFO - ##### 03:56:25 INFO - ##### Running create-virtualenv step. 03:56:25 INFO - ##### 03:56:25 INFO - Running pre-action listener: _resource_record_pre_action 03:56:25 INFO - Running main action method: create_virtualenv 03:56:25 INFO - Creating virtualenv /builds/slave/test/build/venv 03:56:25 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 03:56:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:56:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:56:25 INFO - Using real prefix '/tools/python27' 03:56:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:56:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:56:29 INFO - Installing pip.................done. 03:56:29 INFO - Return code: 0 03:56:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:29 INFO - 'HOME': '/Users/cltbld', 03:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:29 INFO - 'LOGNAME': 'cltbld', 03:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:29 INFO - 'MOZ_NO_REMOTE': '1', 03:56:29 INFO - 'NO_EM_RESTART': '1', 03:56:29 INFO - 'PAGER': '/bin/cat', 03:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:29 INFO - 'PWD': '/builds/slave/test', 03:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:29 INFO - 'SHELL': '/bin/bash', 03:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:29 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:29 INFO - 'USER': 'cltbld', 03:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:29 INFO - 'XPC_FLAGS': '0x0', 03:56:29 INFO - 'XPC_SERVICE_NAME': '0', 03:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:29 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 03:56:29 INFO - Cleaning up... 03:56:29 INFO - Return code: 0 03:56:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:29 INFO - 'HOME': '/Users/cltbld', 03:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:29 INFO - 'LOGNAME': 'cltbld', 03:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:29 INFO - 'MOZ_NO_REMOTE': '1', 03:56:29 INFO - 'NO_EM_RESTART': '1', 03:56:29 INFO - 'PAGER': '/bin/cat', 03:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:29 INFO - 'PWD': '/builds/slave/test', 03:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:29 INFO - 'SHELL': '/bin/bash', 03:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:29 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:29 INFO - 'USER': 'cltbld', 03:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:29 INFO - 'XPC_FLAGS': '0x0', 03:56:29 INFO - 'XPC_SERVICE_NAME': '0', 03:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:29 INFO - Downloading/unpacking psutil>=3.1.1 03:56:29 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 03:56:29 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 03:56:29 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 03:56:29 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 03:56:29 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 03:56:29 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 03:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:32 INFO - Installing collected packages: psutil 03:56:32 INFO - Running setup.py install for psutil 03:56:32 INFO - building 'psutil._psutil_osx' extension 03:56:32 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 03:56:33 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 03:56:33 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 03:56:33 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 03:56:33 INFO - building 'psutil._psutil_posix' extension 03:56:33 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 03:56:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:56:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:56:33 INFO - ^ 03:56:33 INFO - 1 warning generated. 03:56:33 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 03:56:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:33 INFO - Successfully installed psutil 03:56:33 INFO - Cleaning up... 03:56:33 INFO - Return code: 0 03:56:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:56:33 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')]} 03:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:33 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')]} 03:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:33 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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:33 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 03:56:33 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 03:56:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:33 INFO - 'HOME': '/Users/cltbld', 03:56:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:33 INFO - 'LOGNAME': 'cltbld', 03:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:33 INFO - 'MOZ_NO_REMOTE': '1', 03:56:33 INFO - 'NO_EM_RESTART': '1', 03:56:33 INFO - 'PAGER': '/bin/cat', 03:56:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:33 INFO - 'PWD': '/builds/slave/test', 03:56:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:33 INFO - 'SHELL': '/bin/bash', 03:56:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:33 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:33 INFO - 'USER': 'cltbld', 03:56:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:33 INFO - 'XPC_FLAGS': '0x0', 03:56:33 INFO - 'XPC_SERVICE_NAME': '0', 03:56:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:56:34 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 03:56:34 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 03:56:34 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 03:56:34 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 03:56:34 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 03:56:34 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 03:56:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:56:36 INFO - Installing collected packages: mozsystemmonitor 03:56:36 INFO - Running setup.py install for mozsystemmonitor 03:56:36 INFO - Successfully installed mozsystemmonitor 03:56:36 INFO - Cleaning up... 03:56:36 INFO - Return code: 0 03:56:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:56:36 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')]} 03:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:36 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')]} 03:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:36 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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:36 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 03:56:36 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 03:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:36 INFO - 'HOME': '/Users/cltbld', 03:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:36 INFO - 'LOGNAME': 'cltbld', 03:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:36 INFO - 'MOZ_NO_REMOTE': '1', 03:56:36 INFO - 'NO_EM_RESTART': '1', 03:56:36 INFO - 'PAGER': '/bin/cat', 03:56:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:36 INFO - 'PWD': '/builds/slave/test', 03:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:36 INFO - 'SHELL': '/bin/bash', 03:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:36 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:36 INFO - 'USER': 'cltbld', 03:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:36 INFO - 'XPC_FLAGS': '0x0', 03:56:36 INFO - 'XPC_SERVICE_NAME': '0', 03:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:37 INFO - Downloading/unpacking jsonschema==2.5.1 03:56:37 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 03:56:37 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 03:56:37 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 03:56:37 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 03:56:37 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 03:56:37 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 03:56:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:56:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:56:39 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 03:56:39 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 03:56:39 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 03:56:39 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 03:56:39 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 03:56:39 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 03:56:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:56:40 INFO - warning: no files found matching '*.txt' 03:56:40 INFO - no previously-included directories found matching 'build' 03:56:40 INFO - no previously-included directories found matching 'dist' 03:56:40 INFO - no previously-included directories found matching '.git*' 03:56:40 INFO - Installing collected packages: jsonschema, functools32 03:56:40 INFO - Running setup.py install for functools32 03:56:40 INFO - warning: no files found matching '*.txt' 03:56:40 INFO - no previously-included directories found matching 'build' 03:56:40 INFO - no previously-included directories found matching 'dist' 03:56:40 INFO - no previously-included directories found matching '.git*' 03:56:40 INFO - Successfully installed jsonschema functools32 03:56:40 INFO - Cleaning up... 03:56:40 INFO - Return code: 0 03:56:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:56:40 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')]} 03:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:40 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')]} 03:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:40 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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:40 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 03:56:40 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 03:56:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:40 INFO - 'HOME': '/Users/cltbld', 03:56:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:40 INFO - 'LOGNAME': 'cltbld', 03:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:40 INFO - 'MOZ_NO_REMOTE': '1', 03:56:40 INFO - 'NO_EM_RESTART': '1', 03:56:40 INFO - 'PAGER': '/bin/cat', 03:56:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:40 INFO - 'PWD': '/builds/slave/test', 03:56:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:40 INFO - 'SHELL': '/bin/bash', 03:56:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:40 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:40 INFO - 'USER': 'cltbld', 03:56:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:40 INFO - 'XPC_FLAGS': '0x0', 03:56:40 INFO - 'XPC_SERVICE_NAME': '0', 03:56:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:56:40 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 03:56:40 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 03:56:40 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 03:56:40 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 03:56:40 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 03:56:40 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 03:56:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:56:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:56:43 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 03:56:43 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 03:56:43 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 03:56:43 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 03:56:43 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 03:56:43 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 03:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:56:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:56:43 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 03:56:43 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 03:56:43 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 03:56:43 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 03:56:43 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 03:56:43 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 03:56:44 INFO - Downloading docopt-0.6.1.tar.gz 03:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:56:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:56:44 INFO - Running setup.py install for blobuploader 03:56:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:56:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:56:44 INFO - Running setup.py install for requests 03:56:45 INFO - Running setup.py install for docopt 03:56:45 INFO - Successfully installed blobuploader requests docopt 03:56:45 INFO - Cleaning up... 03:56:45 INFO - Return code: 0 03:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:45 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')]} 03:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:45 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')]} 03:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:45 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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:45 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 03:56:45 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 03:56:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:45 INFO - 'HOME': '/Users/cltbld', 03:56:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:45 INFO - 'LOGNAME': 'cltbld', 03:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:45 INFO - 'MOZ_NO_REMOTE': '1', 03:56:45 INFO - 'NO_EM_RESTART': '1', 03:56:45 INFO - 'PAGER': '/bin/cat', 03:56:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:45 INFO - 'PWD': '/builds/slave/test', 03:56:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:45 INFO - 'SHELL': '/bin/bash', 03:56:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:45 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:45 INFO - 'USER': 'cltbld', 03:56:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:45 INFO - 'XPC_FLAGS': '0x0', 03:56:45 INFO - 'XPC_SERVICE_NAME': '0', 03:56:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-cgaAKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-fVERtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-vGPOw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-qsZIzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:45 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3P_aFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-DsVGTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-z34QsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-SztFG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-XiSh0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0iaXMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-D9q5FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-NZNsEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-w0gipd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-JKYeXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:46 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-9hC3ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:47 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-YCHPO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:47 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wgWR0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:47 INFO - Running setup.py install for manifestparser 03:56:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:56:47 INFO - Running setup.py install for mozcrash 03:56:47 INFO - Running setup.py install for mozdebug 03:56:47 INFO - Running setup.py install for mozdevice 03:56:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:56:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:56:47 INFO - Running setup.py install for mozfile 03:56:48 INFO - Running setup.py install for mozhttpd 03:56:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Running setup.py install for mozinfo 03:56:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Running setup.py install for mozInstall 03:56:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Running setup.py install for mozleak 03:56:48 INFO - Running setup.py install for mozlog 03:56:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Running setup.py install for moznetwork 03:56:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:56:48 INFO - Running setup.py install for mozprocess 03:56:49 INFO - Running setup.py install for mozprofile 03:56:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:56:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:56:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:56:49 INFO - Running setup.py install for mozrunner 03:56:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:56:49 INFO - Running setup.py install for mozscreenshot 03:56:49 INFO - Running setup.py install for moztest 03:56:49 INFO - Running setup.py install for mozversion 03:56:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:56:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:49 INFO - Cleaning up... 03:56:49 INFO - Return code: 0 03:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56: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')]} 03:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:49 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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:49 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 03:56:49 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 03:56:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:49 INFO - 'HOME': '/Users/cltbld', 03:56:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:49 INFO - 'LOGNAME': 'cltbld', 03:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:49 INFO - 'MOZ_NO_REMOTE': '1', 03:56:49 INFO - 'NO_EM_RESTART': '1', 03:56:49 INFO - 'PAGER': '/bin/cat', 03:56:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:49 INFO - 'PWD': '/builds/slave/test', 03:56:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:49 INFO - 'SHELL': '/bin/bash', 03:56:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:49 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:49 INFO - 'USER': 'cltbld', 03:56:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:49 INFO - 'XPC_FLAGS': '0x0', 03:56:49 INFO - 'XPC_SERVICE_NAME': '0', 03:56:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-1eCO2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-yCyXwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-jUdqQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-qmfTTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Q8reWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Dj7fwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-6LEvkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ivKdk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:50 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)) 03:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-cZHAzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-K23cor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3hbeSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8_TIHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-dv1JKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-tmuFBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-fTauW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-FZZJmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:51 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)) 03:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-oZGgAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:51 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)) 03:56:51 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)) 03:56:51 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)) 03:56:51 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)) 03:56:51 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)) 03:56:51 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)) 03:56:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:51 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 03:56:51 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 03:56:51 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 03:56:51 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 03:56:51 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 03:56:51 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 03:56:54 INFO - Downloading blessings-1.6.tar.gz 03:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:54 INFO - Installing collected packages: blessings 03:56:54 INFO - Running setup.py install for blessings 03:56:54 INFO - Successfully installed blessings 03:56:54 INFO - Cleaning up... 03:56:54 INFO - Return code: 0 03:56:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:56:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:54 INFO - Reading from file tmpfile_stdout 03:56:54 INFO - Current package versions: 03:56:54 INFO - blessings == 1.6 03:56:54 INFO - blobuploader == 1.2.4 03:56:54 INFO - docopt == 0.6.1 03:56:54 INFO - functools32 == 3.2.3-2 03:56:54 INFO - jsonschema == 2.5.1 03:56:54 INFO - manifestparser == 1.1 03:56:54 INFO - mozInstall == 1.12 03:56:54 INFO - mozcrash == 0.17 03:56:54 INFO - mozdebug == 0.1 03:56:54 INFO - mozdevice == 0.48 03:56:54 INFO - mozfile == 1.2 03:56:54 INFO - mozhttpd == 0.7 03:56:54 INFO - mozinfo == 0.9 03:56:54 INFO - mozleak == 0.1 03:56:54 INFO - mozlog == 3.2 03:56:54 INFO - moznetwork == 0.27 03:56:54 INFO - mozprocess == 0.23 03:56:54 INFO - mozprofile == 0.28 03:56:54 INFO - mozrunner == 6.12 03:56:54 INFO - mozscreenshot == 0.1 03:56:54 INFO - mozsystemmonitor == 0.3 03:56:54 INFO - moztest == 0.7 03:56:54 INFO - mozversion == 1.4 03:56:54 INFO - psutil == 3.1.1 03:56:54 INFO - requests == 1.2.3 03:56:54 INFO - wsgiref == 0.1.2 03:56:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:54 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')]} 03:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:54 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')]} 03:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:54 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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:54 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 03:56:54 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 03:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:54 INFO - 'HOME': '/Users/cltbld', 03:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:54 INFO - 'LOGNAME': 'cltbld', 03:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:54 INFO - 'MOZ_NO_REMOTE': '1', 03:56:54 INFO - 'NO_EM_RESTART': '1', 03:56:54 INFO - 'PAGER': '/bin/cat', 03:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:54 INFO - 'PWD': '/builds/slave/test', 03:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:54 INFO - 'SHELL': '/bin/bash', 03:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:54 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:54 INFO - 'USER': 'cltbld', 03:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:54 INFO - 'XPC_FLAGS': '0x0', 03:56:54 INFO - 'XPC_SERVICE_NAME': '0', 03:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 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)) 03:56:55 INFO - Cleaning up... 03:56:55 INFO - Return code: 0 03:56:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:56:55 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')]} 03:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:55 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')]} 03:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:55 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 0x10ec20a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ecb5618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa084af920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, '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.dqC1uBUHpf/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.iqrg0cyH89/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 03:56:55 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 03:56:55 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 03:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:55 INFO - 'HOME': '/Users/cltbld', 03:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:55 INFO - 'LOGNAME': 'cltbld', 03:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:55 INFO - 'MOZ_NO_REMOTE': '1', 03:56:55 INFO - 'NO_EM_RESTART': '1', 03:56:55 INFO - 'PAGER': '/bin/cat', 03:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:55 INFO - 'PWD': '/builds/slave/test', 03:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:55 INFO - 'SHELL': '/bin/bash', 03:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:56:55 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:55 INFO - 'USER': 'cltbld', 03:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:55 INFO - 'XPC_FLAGS': '0x0', 03:56:55 INFO - 'XPC_SERVICE_NAME': '0', 03:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:56:55 INFO - Cleaning up... 03:56:55 INFO - Return code: 0 03:56:55 INFO - Running post-action listener: _resource_record_post_action 03:56:55 INFO - Running post-action listener: _start_resource_monitoring 03:56:55 INFO - Starting resource monitoring. 03:56:55 INFO - ##### 03:56:55 INFO - ##### Finished create-virtualenv step (success) 03:56:55 INFO - ##### 03:56:55 INFO - ##### 03:56:55 INFO - ##### Running install step. 03:56:55 INFO - ##### 03:56:55 INFO - Running pre-action listener: _resource_record_pre_action 03:56:55 INFO - Running main action method: install 03:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:55 INFO - Reading from file tmpfile_stdout 03:56:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:56:55 INFO - Reading from file tmpfile_stdout 03:56:55 INFO - Output received: 03:56:55 INFO - Usage: mozinstall [options] installer 03:56:55 INFO - Options: 03:56:55 INFO - -h, --help show this help message and exit 03:56:55 INFO - -d DEST, --destination=DEST 03:56:55 INFO - Directory to install application into. [default: 03:56:55 INFO - "/builds/slave/test"] 03:56:55 INFO - --app=APP Application being installed. [default: firefox] 03:56:55 INFO - mkdir: /builds/slave/test/build/application 03:56:55 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'] 03:56:55 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 03:57:30 INFO - Reading from file tmpfile_stdout 03:57:30 INFO - Output received: 03:57:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:57:30 INFO - Running post-action listener: _resource_record_post_action 03:57:30 INFO - ##### 03:57:30 INFO - ##### Finished install step (success) 03:57:30 INFO - ##### 03:57:30 INFO - ##### 03:57:30 INFO - ##### Running run-tests step. 03:57:30 INFO - ##### 03:57:30 INFO - Running pre-action listener: _resource_record_pre_action 03:57:30 INFO - Running main action method: run_tests 03:57:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:57:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:57:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:57:30 INFO - 2016-07-08 03:57:30.346 screenresolution[1642:7457] starting screenresolution argv=screenresolution get 03:57:30 INFO - 2016-07-08 03:57:30.349 screenresolution[1642:7457] Display 0: 1600x1200x32@60 03:57:30 INFO - 2016-07-08 03:57:30.354 screenresolution[1643:7459] starting screenresolution argv=screenresolution list 03:57:30 INFO - Available Modes on Display 0 03:57:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:57:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:57:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:57:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:57:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:57:30 INFO - Intel Iris: 03:57:30 INFO - Chipset Model: Intel Iris 03:57:30 INFO - Type: GPU 03:57:30 INFO - Bus: Built-In 03:57:30 INFO - VRAM (Dynamic, Max): 1536 MB 03:57:30 INFO - Vendor: Intel (0x8086) 03:57:30 INFO - Device ID: 0x0a2e 03:57:30 INFO - Revision ID: 0x0009 03:57:30 INFO - Displays: 03:57:30 INFO - Display: 03:57:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:57:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:57:30 INFO - Display Serial Number: 1600x1200 60 03:57:30 INFO - Main Display: Yes 03:57:30 INFO - Mirror: Off 03:57:30 INFO - Online: Yes 03:57:30 INFO - Rotation: Supported 03:57:30 INFO - Return code: 0 03:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:30 INFO - Python 2.7.3 03:57:30 INFO - Return code: 0 03:57:30 INFO - grabbing minidump binary from tooltool 03:57:30 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')]} 03:57:30 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 0x10eb84d30>, '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 0x10e8e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb7cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:30 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 03:57:30 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 03:57:30 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 03:57:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:30 INFO - Return code: 0 03:57:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:57:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:57:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:30 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/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 03:57:30 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/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --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 03:57:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dqC1uBUHpf/Render', 03:57:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:57:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:57:30 INFO - 'HOME': '/Users/cltbld', 03:57:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:57:30 INFO - 'LOGNAME': 'cltbld', 03:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:30 INFO - 'MOZ_NO_REMOTE': '1', 03:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:30 INFO - 'NO_EM_RESTART': '1', 03:57:30 INFO - 'PAGER': '/bin/cat', 03:57:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:30 INFO - 'PWD': '/builds/slave/test', 03:57:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:57:30 INFO - 'SHELL': '/bin/bash', 03:57:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iqrg0cyH89/Listeners', 03:57:30 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:57:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:57:30 INFO - 'USER': 'cltbld', 03:57:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:57:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:30 INFO - 'XPC_FLAGS': '0x0', 03:57:30 INFO - 'XPC_SERVICE_NAME': '0', 03:57:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:57:30 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/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 03:57:30 INFO - mozversion application_buildid: 20160708022626 03:57:30 INFO - mozversion application_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 03:57:30 INFO - mozversion application_display_name: Nightly 03:57:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:30 INFO - mozversion application_name: Firefox 03:57:30 INFO - mozversion application_remotingname: firefox 03:57:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:57:30 INFO - mozversion application_vendor: Mozilla 03:57:30 INFO - mozversion application_version: 50.0a1 03:57:30 INFO - mozversion platform_buildid: 20160708022626 03:57:30 INFO - mozversion platform_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 03:57:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:57:30 INFO - mozversion platform_version: 50.0a1 03:57:30 INFO - using testdate: 1467975450 03:57:30 INFO - actual date: 1467975450 03:57:30 INFO - starting webserver on 'localhost:49271' 03:57:30 INFO - SUITE-START | Running 2 tests 03:57:30 INFO - TEST-START | dromaeo_css 03:57:30 INFO - operating with platform_type : mac_ 03:57:30 INFO - Initialising browser for dromaeo_css test... 03:57:30 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpaeRZsY/profile http://localhost:49271/getInfo.html) 03:57:33 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 03:57:33 INFO - PROCESS | 1653 | colorDepth:24 03:57:33 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 03:57:33 INFO - PROCESS | 1653 | __metrics 03:57:33 INFO - PROCESS | 1653 | 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" 03:57:33 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:57:34 INFO - TEST-INFO | 1653: exit 0 03:57:34 INFO - Browser initialized. 03:57:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:57:34 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpaeRZsY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:46 INFO - PROCESS | 1655 | RSS: Main: 243511296 03:57:46 INFO - PROCESS | 1655 | 03:58:37 INFO - PROCESS | 1655 | 1467975517598 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] 04:00:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 04:00:49 INFO - PROCESS | 1655 | RSS: Main: 385925120 04:00:49 INFO - PROCESS | 1655 | 04:03:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 04:03:53 INFO - PROCESS | 1655 | RSS: Main: 381837312 04:03:53 INFO - PROCESS | 1655 | 04:06:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 04:06:56 INFO - PROCESS | 1655 | RSS: Main: 370413568 04:06:56 INFO - PROCESS | 1655 | 04:09:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 04:09:59 INFO - PROCESS | 1655 | RSS: Main: 366702592 04:09:59 INFO - PROCESS | 1655 | 04:13:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 04:13:03 INFO - PROCESS | 1655 | RSS: Main: 337952768 04:13:03 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 04:16:06 INFO - PROCESS | 1655 | RSS: Main: 417800192 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | __start_tp_report 04:16:06 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 04:16:06 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 04:16:06 INFO - PROCESS | 1655 | |i|pagename|runs| 04:16:06 INFO - PROCESS | 1655 | |0;dojo.html;2680.4237089025855;3388.5090560153517;3389.457686770117;3399;3423.2468856851483;5701.372848986608;5733.283339582552;5743.253377060987;5789.044807606745;5804.245448091748;5791.189233507313;5814.331351894522;5833.270841144847;5889.941100588992;5920.171176035347;5138.768755405997;5153;5216.3218781558535;5227.32044834171;5318;5017.799288028493;5276.182191760283;5314.5748340132695;5319.122344813101;5376.865578360533;5154.252633368141;5155.226715992593;5184.144616138333;5195.558377537914;5249.711265880375;5190.299309593194;5197;5200.323957885488;5261.921071183935;5331.466853314676;5148.786997569998;5212.8957420851375;5219.608529360313;5266.289050978107;5298.337707786527;5722.055860782966;5875.236219291507;5910.143029260733;5931.139984702238;5961.284645842483;6166.784162554289;6231.875362492725;6233.750649973996;6235.625862448268;6279.717412716439;5281.52466278033;6297.590656607306;6298.716557754912;6302.086197501382;6308.432241098278;5760.395158508296;5804.303483581997;5916.674582897982;5917.674527900964;5998.340182579913;6343.524235682342;6375.3624637536805;6388.1376014237485;6396.776112836028;6406.487481001509;6183.103449999815;6198.442140207403;6213.00591905293;6214.25428948529;6220.066989951543;6129.970128114947;6197.25632924052;6227.844303892439;6324.3991820776955;6328.208973878265;6140.969295153495;6189.566730328924;6194.977828658311;6222.12890195373;6242.1261023456755;6225.657588832658;6241.625502469867;6246.187995560548;6250.437460628475;6254.15568898202;4607.838725644587;4786.851155722601;4976.975115124401;4984.4267909190185;5028.145215313405;4390.4511936008;4410.845620403271;4443.488998765119;4446.710963787344;4475.6419486441655;5849.61977471463;5863.149843272701;5867.973104706744;5871.236739223874;5897.616654917417;6185.938140618537;6243.843903902348;6297.338779428185;6305.432511074026;6316.210473690789;5767.682777447197;5796.188533605298;5808.738606762706;5824.475797178189;5831.737571809279;4619.653525985565;5408.080626293539;5463.48096930791;5471.206675032098;5479.287692599936;6317.684115794192;6358.491320694426;6382.170317858741;6389.361063893573;6391.328910464427;5269.868253293698;6231.2522497300615;6232;6272.310045895039;6289.559730818799;6215.9378406215355;6302.590331628429;6391.58454700443;6393.041043843461;6415.935840641534;6216.409441103088;6255.874882502233;6258.749650013949;6274.341194174728;6283.96858015707;6269.216347956505;6282.591631543935;6287.497000240061;6298.0552917062805;6301.0863424804065;6031.638101713911;6095.664738439428;6143.662098584442;6209.844753881189;6242.3133455320785;6113.020255720452;6119.058514554021;6140.631562106109;6146.938530614815;6164.938350616616;6072.05883088122;6075.817725468243;6094.75620975156;6096.817095487142;6099.782863703368;4699.389079419653;5990.071538911476;6094.329623741296;6118.908216376669;6217.906731399123;6004.0693692477735;6004.249468816398;6064.666443345482;6069.393060694072;6098.908516372169 04:16:06 INFO - PROCESS | 1655 | |1;ext.html;484.6825329409238;523.8585581892889;531.1236459841261;546.5299842135765;567.4835899331608;29372;30510;31426.371472570536;31487.842560787165;43057;34773.30453390937;44659.33011004837;44758;44806.551934480645;44827.32759008618;9783.461909594987;10004.099631033205;10004.999500049973;10005.54975026122;10010.499475026256;8762.386632935697;8983.595738191765;9772.560234789451;9914.801703965917;12021.699457513589;11825.586104486345;12223.205491643059;12245.326507042153;12261.080418968613;12261.141720079599;12039.939800300986;12157.69605759863;12179.208351457128;12187.573434929735;12191.939040304831;8686.956565217133;11769.529218831236;12046.397680115959;12061.492313460818;12104.39478026104;41988.950276243035;42327.15345693069;42406;42504.78747606273;42514.57485425137;3201.695838895301;3590.1563132663805;3623.8912832615065;3625.9456108158397;3689.114612493009;32414.027579172664;32965.681372745064;33195.83402082974;33973.15067123317;34225.82887085574;3118.5789918361183;3187;3227.8547465364113;3273.705366517001;3395.7283417326553;508173;510972;512021.9999999963;512116;512176;55717;63945;64294;64341.678291608245;64403;68275.3172468279;68340;68391.31608683949;68452.657736711;68531.62936741237;16493.505194844172;17027.744583831252;17046;17097.230624621923;17115.572110697332;12975.610731678065;13045.804312935314;13049;13050.021248406407;13053.34733263333;17293.481195564153;17587.73618395725;17599.82400175982;17684.46946591604;17749.911250443663;6900.6204658744255;7795.061470621869;7845.568493732785;7868.331191848757;7884;899.4423457456419;997.875265591801;1027.2039169643585;1060.6499855047816;1095.9397233152254;25548.23355299344;30938.381232375228;31259;31393.553609169554;32505;1075.2365820267541;1077.7251800790748;1078.2398409121552;1117.6479408986143;1173.9882601173879;16237;16251.59371015734;16304.673906521803;16443.56805459668;16590.25343859505;632251;639666;640850;641060;644869;60572.697136514034;61032.69483652553;61282.693586532674;61367.693161533905;61451.385486144565;1392.791081337787;1436.490046033664;1450.0647082631854;1454.7672372420361;1461.978070328946;28781.424371512872;30514.237144071576;31047.379052419277;31109.68890311068;31371.05886823399;52341.21488177604;52442.213366798765;52774.47225527695;52797.7360113197;52835.735821320646;554861;557567;558068;560151;561409;27201.72798272071;27360;27678.44643107167;27732.44535109327;27761.583576246776;37660.721692243795;40023.79988100041;47298.527014729414;50832.98334033225;53171.46828531665;40423.98940026523;41276.38085428781;41766.424592963405;42190;42387.57612423836;33911.491327630596;40833.79583102065;40984;41696.16607667891;42483.78758106189;38981.80509097436;39533.2093358137;39548.604513954495;39707.40438893477;40038;35318.94043178709;35534.46698299579;36296.09259768527;36356.45465318075;36418.90743277706;21417.78582214158;25027.624585630867;25448.491030179663;26079.869600651877;26579.33551661224 04:16:06 INFO - PROCESS | 1655 | |2;jquery.html;322.86116969703033;329.3002369963827;375.8834761224021;389.25457748411776;397.11047254150714;21099.68350474744;21145.471363215926;21860.23489177879;22158.88920555397;22189.001494932727;20085.096170672317;21781.564368712618;21834.672479912813;22122.33632991009;22142;5958.838026584817;5993.370696076903;6230.532710046742;6234.314225435199;6239.34486878878;4231.449911511515;4477;6098.268207815068;6226.750929962796;6587.407133357997;5865;6963.338482844147;6967.198772141192;6971.686274117652;6994.685239164224;6617.966910165443;6932.792016239521;6940.30596940307;6945.409640180591;6965.094537710116;5952.880942381172;6025.66858822769;6031.366706495843;6034.96982515089;6037.45662890342;27214.183574492796;27243.182704518895;27274.04540841061;27410;27486.725132748616;2312.8727919964394;2350.306659535441;2459.4712136890653;2474.2948259745885;2549.6557964674716;15085;16234.918825405915;16442.260098295606;16858.9884606924;16925.153742312836;1806.331657286799;1898.734177215191;1928.469670840516;1944.7277381166648;1985.205917632944;106786;107649;108092;108955;109792;9333.906660933304;10778.946105269424;11165.776684466266;11376.601818936297;11392.316461012366;13993.860061399459;14086;14214.360353784105;14221.360038798279;14232.644183895485;8672.479651220947;8856.64573417069;8895.154960278764;8927.642894284285;8998.640054397882;7373.631318434057;8972.878390201226;8975.910240897638;9046.502442365732;9150.908490915006;6838.692258848364;6898.793036208922;6941.930580694229;6959.304069593101;6968.686409111602;1703.948881533556;1755.4294854172445;1819.054091872219;1835.7608614185372;1841.2565277736078;868.1362044765499;925.2459245714721;985.8718366612438;1045.9592705258317;1055.0978913029248;21974.340769776933;22298.665520017214;22385.216517421813;22413.775862241495;22469.213577524708;816.5713000674693;828.556722153645;984.9852252216223;1067.4982758103679;1120.8767035626074;11196.440177991068;11505.367204803817;11572.18994670365;11604.30374177552;11629.24409913353;443455;570460;579157;582362;590616;121341;123016;124132;125167;135864.6413535852;964.238251781099;969.2294625772387;1007.9949600251952;1010.8079464901646;1019.2712210769336;18839;19399.2240310386;20282.087306070967;20287.391378258675;20455.79544204539;38195.809020954715;45685.62943111712;54919.45080549143;55402.61493462696;55850.16224756713;81679.5916020416;81695.77456338279;81700;82614;82615.586922065;8120.350371970347;8245.79385515367;8305.294050005576;8319.875201872097;8487.702930397407;10950.616728414467;12957.028222883133;13174.275414852274;13232.404541795835;13279.734405312032;8315;10983.560657573928;11196.888031119584;11227.989480946753;11234.325940443272;10802.919708029134;10902.836457453303;11078.446077696244;11269.211155219056;11321.377324247245;9273.907260927574;10993.780124397308;11328.037116844831;11513.597024104116;11547.826782598437;6502.544821862613;7535.397168226638;7561.757495757066;7575.886361704469;8456.788580285296;9994.250431217833;11140.665780026613;11199.272047317225;11355.318680879174;11428.771424571629 04:16:06 INFO - PROCESS | 1655 | |3;mootools.html;1526.6565022869852;1584.2316476508893;1798.163853807979;1893.0534732633682;1948.8635795494322;8642.178992995663;8958.776030599238;9103.59033843477;9123.77190570236;9160.35877488576;7915.1689072647405;8166.959165204165;8444.704435344764;8730.825383492327;8866.645334186625;2327.569399661064;2363.444590521226;2367.4554852383962;2368.7749663782;2375.6911601491784;2347.248880358286;2352.070931981866;2387.7015373078366;2387.713474383068;2390.3187591536416;1805.981940180601;2085.259732794859;2167.566486702658;2395;2395.35325462126;2358.2453614843257;2371.91698290559;2384.3204686664217;2389.187676190086;2392.7248366437907;2379;2395.257470184231;2395.6406539019113;2402.531506356261;2407.807375409963;8772.517511536864;8815.426997245158;8829.779255518664;8832.55837208137;8851.46891186531;5204.089284375219;5316.149416093406;5362.570994320445;5366.70483123428;5375.11310633745;3493.0788066563287;3543.8759643412614;3659.9451008234896;3662.688671462929;3668.6147954464664;1000.8398656214971;1018.1447584029451;1080.8432777247333;1084.0839490630406;1107.3134656512932;9671.371360861522;9938.552765125587;11631.418429078512;11643.592474263445;11647;3910.865848903843;4568.360429539867;4627.583517483443;4757.476677565465;4807.927881081787;9962;9968.252381071448;9979.351342162881;9996.650117245861;10000.549975251131;5326.97336513315;5327.440618735054;5335.359756829128;5336.066188417011;5336.092864213016;4694.953050469451;4717.386739723814;4777.976110119427;4785;4943.5797957174045;3433.3819912416006;3838.692904567628;3880.941785873214;3926.2540117377607;3956.8219430125714;1198.9700257493632;1230.1696354960366;1257.9685507862193;1263.7851565233748;1274.1654216488214;704.2886684448744;921.741912264567;980.9901900981041;994.6319861651235;1002.3361220374289;6074.149619053248;6075.696215189223;6147.631142131397;6202.596831205957;6318.4313411793155;923.5243849417556;940.1820416237916;946.4132238012339;960.5293406231036;998.5656239535825;3833.5783063862955;4230.576942305806;4351.477822661301;4427.180971520279;4459.977700111479;10134.746631334276;10810.783784324269;10817.296875703212;10931.289466184673;10974.231803773659;9879.80240395188;10343.534540945526;10885.510152043176;10916.672499825017;10941.45292735376;7197.712091516385;7925.445218834741;8285.088640249567;8291.212334828182;8404.07555168931;6085.2393450818645;6223.688815559113;6242.843928901813;6272.623642581277;6305.423644088978;9791.804163916824;9797.118259356692;10138.290319677551;10145.64490242838;10215.284930054824;10194.235432342752;10199.28604997643;10321.48392580383;10328.896711032794;10446.112080473245;7574.356179724785;7777;7781.727639532589;7786.571738554434;7787.688492460238;8223.14979129715;8291.875621865798;8423;8439.198276163756;8439.620217090123;7563.546187228784;7590.392768578611;7654.15804261542;7670.616469176631;7742.225777422213;7368.631568421664;7474.588897610466;7529.698812047676;7536.623168841646;7582.507137036075;7014.368706816411;7058.505904586835;7133.500654954311;7137.714491420285;7137.785866424016;5169.250458683545;5169.478102478797;5185.455527169744;5247.58019358458;5288.81489147878;4364.410804541473;4928.802847886044;5192.792288308426;5211.687298762086;5358.624896257381 04:16:06 INFO - PROCESS | 1655 | |4;prototype.html;287.6749273321147;293.79727987688494;295.85207396301837;297.9433907557564;303.2812235003043;5344.305240318758;5388.892222155555;5412.269343638613;5446.972765136169;5473.507384335409;4351.456067991501;4517.063908459503;4628.328892310621;5348.839534813962;5391.2452256684;3188.0595224408853;3260.8206548639814;3878.1661942682317;4031.8790436286813;4038.3134867072667;3940.389239667856;3990.8626041578154;4015.7590544567274;4032.346737837487;4034.6570541504007;4000.2599519089063;4001.25976694311;4007.7394969327047;4025.5370632377358;4033.616806403402;3775;3777.6033516480784;3899.844006239747;3921.803909804513;4049.5219244975665;3452.7755695879687;3458.654134586546;3471.427214509603;3488.9127771805656;3508.333416650854;5196.376434827807;5200.817971370984;5237.764300606444;5252.820079666972;5347.59893008022;3978.840846366171;4381.802818873159;4574.336721175444;4590.977045114753;4649.442066951953;4768.356271903283;5555.805546805843;5571;5596.804111856066;5664.291963504562;3846.8461261549505;3856.4986551748375;3856.804390638883;3864.845406183749;3866.6326698963553;4634.3048542718525;5544.1960915667405;5915.733791979285;5958.255218097738;5971.223740913653;3491.760425049071;3741.28915506053;3776.33914065043;3973.145773658677;4073.6130067643526;3220.710136087763;3988.900277493086;3998;4017.4375587417785;4022.6580740636787;3634.83643236055;4623.514530974267;4649.209634362167;4670.95329046712;4692.249240121632;5356.196570514376;5637.661740295595;5644.5484361251;5652.604317697804;5694.259746233046;1141.680329507739;1292.9094963352663;1335.3456806164909;1339.6985678222322;1347.4138749643937;716.5879619218865;792.4690457393444;795.8368534450424;808.2806302390877;811.9404177548238;5062.367204099488;5110.105731497048;5182.144946083929;5204.643005261661;5379.139337706027;5489.011977844027;5774.2782152230975;5831.88336233273;5845.064789633639;5915;4902.828401005948;5265.473452654704;5345.305110335631;5359.410464848864;5371.62398632092;2670.6795184577977;2721.3468767496056;2867.7705783537267;2891.7686585073143;2984.4329577380227;5284.339457567804;5923.674197919156;5934.8813023739285;6018.8194354169445;6021.217241758543;5618.190904547726;5904.291485021739;5922.3485416604135;6008.459238668541;6012.969935150296;5695.572832037531;5938.673372964442;5954;5964.642121472725;5990.820275391745;5148.4851514848215;5258.816766227721;5688.975984322861;5820.534357251495;5823.718781867982;4797.2564252540915;5612.85967850807;5669.31968163823;5685.545156387562;5695.519165017208;4943.283223932582;5734.139879018181;5926.496247818984;5938.376470470538;5958.480587450345;3203.19920019995;3363.5963684358035;3632.763870348419;3664.4320130379833;3700.410601716331;5701.287339082614;5721.284839395075;5725.2843394575675;5737.684427356536;5769.423057694365;5619.831405057855;5624.690642014729;5642.50164897766;5644.717764111861;5658.575606829587;5231.267622532772;5586.379949814508;5589.301337332833;5629;5635.971820140873;4843.491433399583;5274.156135018378;5490.203920431595;5536.557075434036;5560.777568897199;4975.228839529878;5006.349174607278;5108.540231379194;5301.693763213015;5461.371942226536;4596.448426188878;5021.84934451967;5402.379286214199;5510.421405752499;5523.1991361253195 04:16:06 INFO - PROCESS | 1655 | |5;yui.html;755.3541721827837;767.1829501580812;778.7897267737711;817.1379194949328;846.4075147396824;13809.447622095116;16442.177891105457;16448;16456.917715411422;16484.42304519342;15018.399264029425;15025.924870375633;15184.6963060739;15209.4676686316;15238;711.8078118907891;726.5967388099602;898.586650140936;921.4609453469728;924.1128516624016;891.5854127830557;914.5518695839024;918.2241006349624;923.1230331185367;925.9027802080785;961.1781926452887;971.0629242780715;974.133021610767;975.4147511493082;976.067855198284;741.847921176163;762.5081822224689;964.0407794244736;964.5514835601444;967.2697113679127;571.4514066496168;572.5905977226262;643.4144928115393;699.51034276007;717.1465955512923;15279.770803437958;15316.463923762727;15318.540443786704;15335;15354.001989870734;13878.791818122636;14214;14293.71356577913;14390.784138237936;14397.424103035866;13056.281904495248;13077.607671769862;13153.60539183826;13307.20156790586;13559.728805423836;4009.2382447335203;4599.885002874921;4630.351750754897;4750.904981900343;4788.832390866303;108884;112000.4399978003;114215;115307.42346288299;115599;11128.833067503994;11223.326600404002;11426.657200284004;11485.827712584318;11768.529258829722;22256.99843507046;22259.332220033426;22264.22075227359;22276.331710048726;22305.107795688316;6856.24581296057;7984.161663025415;8047.315978141924;8106.270435660819;8191;4369.453818272716;4451.888702782391;4475.619572336323;4490.640748740093;4629.8148074077335;3500.4749287607065;3615.746897717187;3621.511096002059;3622.909427264287;3625.057485053905;651.4788169464505;651.664392837689;660.4914216053708;679.6397909108181;681.7852376501386;545.4164044472456;576.4091805898987;605.3008774865037;656.2187131372623;666.5534092158168;8753.078463989972;9179.127982841619;9223.262139028862;9251.953740231256;9253.768655783524;595.9493443057302;611.5932904618379;615.2217444932164;631.3402494393279;634.7587916591666;3663.8900832975055;4305.547917468683;4354.651627869763;4381.539938306496;4475.753833539122;139301.3034934819;141558.2922085383;146442;149927;154518.22740886224;133947;134716.55104063428;138146;139025;141259;73528.63235683787;106135.46932265289;109819.45090274498;110597;112104;8605.35459840502;8648.1784230498;8721.839057497944;8726;8808.383413161273;65567.67216163888;66446.33553664401;66531;67461.32538674747;68146.61486847936;87145;92284;95973.52013239889;96973;98335.01664983545;11542.711432214262;11554.653360399201;11680.415979200836;12033;12092.334921579046;12028.879711202775;12101.878981210075;12123.333216672814;12684.302363369734;12720.87279127197;10170.389776613427;11563.537458501902;11801.35092569917;12220.755584888075;12357.32034738062;9091.54542272897;14033.158010518993;14150.4623844039;14186.077904936146;14681.339339729951;12479.812802807783;13938.30308484592;13950.023498355424;13994.670506301885;14219.09326942289;11439.970402663468;11545.769084618429;11598.956093951585;11615.419229038684;11722.531098755955;10543.578256869947;11432;11484.598039068593;11667.76664466689;11696.298222106701 04:16:06 INFO - PROCESS | 1655 | __end_tp_report 04:16:06 INFO - PROCESS | 1655 | __start_cc_report 04:16:06 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1457 04:16:06 INFO - PROCESS | 1655 | __end_cc_report 04:16:06 INFO - PROCESS | 1655 | __startTimestamp1467976566631__endTimestamp 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | ------- Summary: start ------- 04:16:06 INFO - PROCESS | 1655 | Number of tests: 6 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5771.05 Median:6064.67 stddev:678.47 (11.2%) stddev-sans-first:635.75 04:16:06 INFO - PROCESS | 1655 | Values: 2680.4 3388.5 3389.5 3399.0 3423.2 5701.4 5733.3 5743.3 5789.0 5804.2 5791.2 5814.3 5833.3 5889.9 5920.2 5138.8 5153.0 5216.3 5227.3 5318.0 5017.8 5276.2 5314.6 5319.1 5376.9 5154.3 5155.2 5184.1 5195.6 5249.7 5190.3 5197.0 5200.3 5261.9 5331.5 5148.8 5212.9 5219.6 5266.3 5298.3 5722.1 5875.2 5910.1 5931.1 5961.3 6166.8 6231.9 6233.8 6235.6 6279.7 5281.5 6297.6 6298.7 6302.1 6308.4 5760.4 5804.3 5916.7 5917.7 5998.3 6343.5 6375.4 6388.1 6396.8 6406.5 6183.1 6198.4 6213.0 6214.3 6220.1 6130.0 6197.3 6227.8 6324.4 6328.2 6141.0 6189.6 6195.0 6222.1 6242.1 6225.7 6241.6 6246.2 6250.4 6254.2 4607.8 4786.9 4977.0 4984.4 5028.1 4390.5 4410.8 4443.5 4446.7 4475.6 5849.6 5863.1 5868.0 5871.2 5897.6 6185.9 6243.8 6297.3 6305.4 6316.2 5767.7 5796.2 5808.7 5824.5 5831.7 4619.7 5408.1 5463.5 5471.2 5479.3 6317.7 6358.5 6382.2 6389.4 6391.3 5269.9 6231.3 6232.0 6272.3 6289.6 6215.9 6302.6 6391.6 6393.0 6415.9 6216.4 6255.9 6258.7 6274.3 6284.0 6269.2 6282.6 6287.5 6298.1 6301.1 6031.6 6095.7 6143.7 6209.8 6242.3 6113.0 6119.1 6140.6 6146.9 6164.9 6072.1 6075.8 6094.8 6096.8 6099.8 4699.4 5990.1 6094.3 6118.9 6217.9 6004.1 6004.2 6064.7 6069.4 6098.9 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:71107.26 Median:19562.31 stddev:152686.72 (780.5%) stddev-sans-first:153022.98 04:16:06 INFO - PROCESS | 1655 | Values: 484.7 523.9 531.1 546.5 567.5 29372.0 30510.0 31426.4 31487.8 43057.0 34773.3 44659.3 44758.0 44806.6 44827.3 9783.5 10004.1 10005.0 10005.5 10010.5 8762.4 8983.6 9772.6 9914.8 12021.7 11825.6 12223.2 12245.3 12261.1 12261.1 12039.9 12157.7 12179.2 12187.6 12191.9 8687.0 11769.5 12046.4 12061.5 12104.4 41989.0 42327.2 42406.0 42504.8 42514.6 3201.7 3590.2 3623.9 3625.9 3689.1 32414.0 32965.7 33195.8 33973.2 34225.8 3118.6 3187.0 3227.9 3273.7 3395.7 508173.0 510972.0 512022.0 512116.0 512176.0 55717.0 63945.0 64294.0 64341.7 64403.0 68275.3 68340.0 68391.3 68452.7 68531.6 16493.5 17027.7 17046.0 17097.2 17115.6 12975.6 13045.8 13049.0 13050.0 13053.3 17293.5 17587.7 17599.8 17684.5 17749.9 6900.6 7795.1 7845.6 7868.3 7884.0 899.4 997.9 1027.2 1060.6 1095.9 25548.2 30938.4 31259.0 31393.6 32505.0 1075.2 1077.7 1078.2 1117.6 1174.0 16237.0 16251.6 16304.7 16443.6 16590.3 632251.0 639666.0 640850.0 641060.0 644869.0 60572.7 61032.7 61282.7 61367.7 61451.4 1392.8 1436.5 1450.1 1454.8 1462.0 28781.4 30514.2 31047.4 31109.7 31371.1 52341.2 52442.2 52774.5 52797.7 52835.7 554861.0 557567.0 558068.0 560151.0 561409.0 27201.7 27360.0 27678.4 27732.4 27761.6 37660.7 40023.8 47298.5 50833.0 53171.5 40424.0 41276.4 41766.4 42190.0 42387.6 33911.5 40833.8 40984.0 41696.2 42483.8 38981.8 39533.2 39548.6 39707.4 40038.0 35318.9 35534.5 36296.1 36356.5 36418.9 21417.8 25027.6 25448.5 26079.9 26579.3 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33954.83 Median:2466.88 stddev:92896.95 (3765.8%) stddev-sans-first:93123.23 04:16:06 INFO - PROCESS | 1655 | Values: 322.9 329.3 375.9 389.3 397.1 21099.7 21145.5 21860.2 22158.9 22189.0 20085.1 21781.6 21834.7 22122.3 22142.0 5958.8 5993.4 6230.5 6234.3 6239.3 4231.4 4477.0 6098.3 6226.8 6587.4 5865.0 6963.3 6967.2 6971.7 6994.7 6618.0 6932.8 6940.3 6945.4 6965.1 5952.9 6025.7 6031.4 6035.0 6037.5 27214.2 27243.2 27274.0 27410.0 27486.7 2312.9 2350.3 2459.5 2474.3 2549.7 15085.0 16234.9 16442.3 16859.0 16925.2 1806.3 1898.7 1928.5 1944.7 1985.2 106786.0 107649.0 108092.0 108955.0 109792.0 9333.9 10778.9 11165.8 11376.6 11392.3 13993.9 14086.0 14214.4 14221.4 14232.6 8672.5 8856.6 8895.2 8927.6 8998.6 7373.6 8972.9 8975.9 9046.5 9150.9 6838.7 6898.8 6941.9 6959.3 6968.7 1703.9 1755.4 1819.1 1835.8 1841.3 868.1 925.2 985.9 1046.0 1055.1 21974.3 22298.7 22385.2 22413.8 22469.2 816.6 828.6 985.0 1067.5 1120.9 11196.4 11505.4 11572.2 11604.3 11629.2 443455.0 570460.0 579157.0 582362.0 590616.0 121341.0 123016.0 124132.0 125167.0 135864.6 964.2 969.2 1008.0 1010.8 1019.3 18839.0 19399.2 20282.1 20287.4 20455.8 38195.8 45685.6 54919.5 55402.6 55850.2 81679.6 81695.8 81700.0 82614.0 82615.6 8120.4 8245.8 8305.3 8319.9 8487.7 10950.6 12957.0 13174.3 13232.4 13279.7 8315.0 10983.6 11196.9 11228.0 11234.3 10802.9 10902.8 11078.4 11269.2 11321.4 9273.9 10993.8 11328.0 11513.6 11547.8 6502.5 7535.4 7561.8 7575.9 8456.8 9994.3 11140.7 11199.3 11355.3 11428.8 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5750.19 Median:5177.47 stddev:3183.05 (61.5%) stddev-sans-first:3176.16 04:16:06 INFO - PROCESS | 1655 | Values: 1526.7 1584.2 1798.2 1893.1 1948.9 8642.2 8958.8 9103.6 9123.8 9160.4 7915.2 8167.0 8444.7 8730.8 8866.6 2327.6 2363.4 2367.5 2368.8 2375.7 2347.2 2352.1 2387.7 2387.7 2390.3 1806.0 2085.3 2167.6 2395.0 2395.4 2358.2 2371.9 2384.3 2389.2 2392.7 2379.0 2395.3 2395.6 2402.5 2407.8 8772.5 8815.4 8829.8 8832.6 8851.5 5204.1 5316.1 5362.6 5366.7 5375.1 3493.1 3543.9 3659.9 3662.7 3668.6 1000.8 1018.1 1080.8 1084.1 1107.3 9671.4 9938.6 11631.4 11643.6 11647.0 3910.9 4568.4 4627.6 4757.5 4807.9 9962.0 9968.3 9979.4 9996.7 10000.5 5327.0 5327.4 5335.4 5336.1 5336.1 4695.0 4717.4 4778.0 4785.0 4943.6 3433.4 3838.7 3880.9 3926.3 3956.8 1199.0 1230.2 1258.0 1263.8 1274.2 704.3 921.7 981.0 994.6 1002.3 6074.1 6075.7 6147.6 6202.6 6318.4 923.5 940.2 946.4 960.5 998.6 3833.6 4230.6 4351.5 4427.2 4460.0 10134.7 10810.8 10817.3 10931.3 10974.2 9879.8 10343.5 10885.5 10916.7 10941.5 7197.7 7925.4 8285.1 8291.2 8404.1 6085.2 6223.7 6242.8 6272.6 6305.4 9791.8 9797.1 10138.3 10145.6 10215.3 10194.2 10199.3 10321.5 10328.9 10446.1 7574.4 7777.0 7781.7 7786.6 7787.7 8223.1 8291.9 8423.0 8439.2 8439.6 7563.5 7590.4 7654.2 7670.6 7742.2 7368.6 7474.6 7529.7 7536.6 7582.5 7014.4 7058.5 7133.5 7137.7 7137.8 5169.3 5169.5 5185.5 5247.6 5288.8 4364.4 4928.8 5192.8 5211.7 5358.6 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4542.51 Median:5217.96 stddev:1433.44 (27.5%) stddev-sans-first:1401.44 04:16:06 INFO - PROCESS | 1655 | Values: 287.7 293.8 295.9 297.9 303.3 5344.3 5388.9 5412.3 5447.0 5473.5 4351.5 4517.1 4628.3 5348.8 5391.2 3188.1 3260.8 3878.2 4031.9 4038.3 3940.4 3990.9 4015.8 4032.3 4034.7 4000.3 4001.3 4007.7 4025.5 4033.6 3775.0 3777.6 3899.8 3921.8 4049.5 3452.8 3458.7 3471.4 3488.9 3508.3 5196.4 5200.8 5237.8 5252.8 5347.6 3978.8 4381.8 4574.3 4591.0 4649.4 4768.4 5555.8 5571.0 5596.8 5664.3 3846.8 3856.5 3856.8 3864.8 3866.6 4634.3 5544.2 5915.7 5958.3 5971.2 3491.8 3741.3 3776.3 3973.1 4073.6 3220.7 3988.9 3998.0 4017.4 4022.7 3634.8 4623.5 4649.2 4671.0 4692.2 5356.2 5637.7 5644.5 5652.6 5694.3 1141.7 1292.9 1335.3 1339.7 1347.4 716.6 792.5 795.8 808.3 811.9 5062.4 5110.1 5182.1 5204.6 5379.1 5489.0 5774.3 5831.9 5845.1 5915.0 4902.8 5265.5 5345.3 5359.4 5371.6 2670.7 2721.3 2867.8 2891.8 2984.4 5284.3 5923.7 5934.9 6018.8 6021.2 5618.2 5904.3 5922.3 6008.5 6013.0 5695.6 5938.7 5954.0 5964.6 5990.8 5148.5 5258.8 5689.0 5820.5 5823.7 4797.3 5612.9 5669.3 5685.5 5695.5 4943.3 5734.1 5926.5 5938.4 5958.5 3203.2 3363.6 3632.8 3664.4 3700.4 5701.3 5721.3 5725.3 5737.7 5769.4 5619.8 5624.7 5642.5 5644.7 5658.6 5231.3 5586.4 5589.3 5629.0 5636.0 4843.5 5274.2 5490.2 5536.6 5560.8 4975.2 5006.3 5108.5 5301.7 5461.4 4596.4 5021.8 5402.4 5510.4 5523.2 04:16:06 INFO - PROCESS | 1655 | 04:16:06 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25083.63 Median:3622.21 stddev:40125.89 (1107.8%) stddev-sans-first:40196.87 04:16:06 INFO - PROCESS | 1655 | Values: 755.4 767.2 778.8 817.1 846.4 13809.4 16442.2 16448.0 16456.9 16484.4 15018.4 15025.9 15184.7 15209.5 15238.0 711.8 726.6 898.6 921.5 924.1 891.6 914.6 918.2 923.1 925.9 961.2 971.1 974.1 975.4 976.1 741.8 762.5 964.0 964.6 967.3 571.5 572.6 643.4 699.5 717.1 15279.8 15316.5 15318.5 15335.0 15354.0 13878.8 14214.0 14293.7 14390.8 14397.4 13056.3 13077.6 13153.6 13307.2 13559.7 4009.2 4599.9 4630.4 4750.9 4788.8 108884.0 112000.4 114215.0 115307.4 115599.0 11128.8 11223.3 11426.7 11485.8 11768.5 22257.0 22259.3 22264.2 22276.3 22305.1 6856.2 7984.2 8047.3 8106.3 8191.0 4369.5 4451.9 4475.6 4490.6 4629.8 3500.5 3615.7 3621.5 3622.9 3625.1 651.5 651.7 660.5 679.6 681.8 545.4 576.4 605.3 656.2 666.6 8753.1 9179.1 9223.3 9252.0 9253.8 595.9 611.6 615.2 631.3 634.8 3663.9 4305.5 4354.7 4381.5 4475.8 139301.3 141558.3 146442.0 149927.0 154518.2 133947.0 134716.6 138146.0 139025.0 141259.0 73528.6 106135.5 109819.5 110597.0 112104.0 8605.4 8648.2 8721.8 8726.0 8808.4 65567.7 66446.3 66531.0 67461.3 68146.6 87145.0 92284.0 95973.5 96973.0 98335.0 11542.7 11554.7 11680.4 12033.0 12092.3 12028.9 12101.9 12123.3 12684.3 12720.9 10170.4 11563.5 11801.4 12220.8 12357.3 9091.5 14033.2 14150.5 14186.1 14681.3 12479.8 13938.3 13950.0 13994.7 14219.1 11440.0 11545.8 11599.0 11615.4 11722.5 10543.6 11432.0 11484.6 11667.8 11696.3 04:16:06 INFO - PROCESS | 1655 | -------- Summary: end -------- 04:16:06 INFO - PROCESS | 1655 | 04:16:07 INFO - TEST-INFO | 1655: exit 0 04:16:07 INFO - TEST-OK | dromaeo_css | took 1116289ms 04:16:07 INFO - TEST-START | kraken 04:16:07 INFO - operating with platform_type : mac_ 04:16:07 INFO - Initialising browser for kraken test... 04:16:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp_nXfzi/profile http://localhost:49271/getInfo.html) 04:16:09 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 04:16:09 INFO - PROCESS | 1665 | colorDepth:24 04:16:09 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 04:16:09 INFO - PROCESS | 1665 | __metrics 04:16:09 INFO - PROCESS | 1665 | 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" 04:16:09 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:10 INFO - TEST-INFO | 1665: exit 0 04:16:10 INFO - Browser initialized. 04:16:10 INFO - Running cycle 1/1 for kraken test... 04:16:10 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp_nXfzi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:22 INFO - PROCESS | 1666 | RSS: Main: 243671040 04:16:22 INFO - PROCESS | 1666 | 04:16:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:25 INFO - PROCESS | 1666 | RSS: Main: 294248448 04:16:25 INFO - PROCESS | 1666 | 04:16:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 04:16:28 INFO - PROCESS | 1666 | RSS: Main: 304459776 04:16:28 INFO - PROCESS | 1666 | 04:16:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 04:16:33 INFO - PROCESS | 1666 | RSS: Main: 386600960 04:16:33 INFO - PROCESS | 1666 | 04:16:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 04:16:35 INFO - PROCESS | 1666 | RSS: Main: 288608256 04:16:35 INFO - PROCESS | 1666 | 04:16:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:38 INFO - PROCESS | 1666 | RSS: Main: 292638720 04:16:38 INFO - PROCESS | 1666 | 04:16:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:41 INFO - PROCESS | 1666 | RSS: Main: 328724480 04:16:41 INFO - PROCESS | 1666 | 04:16:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 04:16:45 INFO - PROCESS | 1666 | RSS: Main: 331993088 04:16:45 INFO - PROCESS | 1666 | 04:16:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 04:16:48 INFO - PROCESS | 1666 | RSS: Main: 330149888 04:16:48 INFO - PROCESS | 1666 | 04:16:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:50 INFO - PROCESS | 1666 | RSS: Main: 311463936 04:16:50 INFO - PROCESS | 1666 | 04:16:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:53 INFO - PROCESS | 1666 | RSS: Main: 318234624 04:16:53 INFO - PROCESS | 1666 | 04:16:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:56 INFO - PROCESS | 1666 | RSS: Main: 323391488 04:16:56 INFO - PROCESS | 1666 | 04:16:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:59 INFO - PROCESS | 1666 | RSS: Main: 324554752 04:16:59 INFO - PROCESS | 1666 | 04:17:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:17:03 INFO - PROCESS | 1666 | RSS: Main: 324993024 04:17:03 INFO - PROCESS | 1666 | 04:17:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 04:17:05 INFO - PROCESS | 1666 | RSS: Main: 368467968 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | __start_tp_report 04:17:05 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 04:17:05 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 04:17:05 INFO - PROCESS | 1666 | |i|pagename|runs| 04:17:05 INFO - PROCESS | 1666 | |0;ai-astar;100;111;113;106;112;112;110;110;112;112 04:17:05 INFO - PROCESS | 1666 | |1;audio-beat-detection;139;108;107;157;106;106;125;105;138;104 04:17:05 INFO - PROCESS | 1666 | |2;audio-dft;182;185;184;180;184;182;180;179;184;184 04:17:05 INFO - PROCESS | 1666 | |3;audio-fft;77;72;56;109;56;69;82;89;97;56 04:17:05 INFO - PROCESS | 1666 | |4;audio-oscillator;82;90;93;70;70;66;96;70;67;99 04:17:05 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;86;89;85;88;85;88;86;89;84 04:17:05 INFO - PROCESS | 1666 | |6;imaging-darkroom;94;95;116;150;104;94;95;94;94;94 04:17:05 INFO - PROCESS | 1666 | |7;imaging-desaturate;83;87;83;84;85;85;87;83;84;84 04:17:05 INFO - PROCESS | 1666 | |8;json-parse-financial;52;54;53;55;54;59;56;53;53;54 04:17:05 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;66;66;70;82;72;72;68;71;71;69 04:17:05 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;83;82;83;85;81;85;84;86;86;119 04:17:05 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;136;133;136;134;133;132;135;134;149;137 04:17:05 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;164;162;167;194;165;164;164;163;162;163 04:17:05 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;66;66;67;66;66 04:17:05 INFO - PROCESS | 1666 | __end_tp_report 04:17:05 INFO - PROCESS | 1666 | __start_cc_report 04:17:05 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1985 04:17:05 INFO - PROCESS | 1666 | __end_cc_report 04:17:05 INFO - PROCESS | 1666 | __startTimestamp1467976625031__endTimestamp 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | ------- Summary: start ------- 04:17:05 INFO - PROCESS | 1666 | Number of tests: 14 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:109.80 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:2.09 04:17:05 INFO - PROCESS | 1666 | Values: 100.0 111.0 113.0 106.0 112.0 112.0 110.0 110.0 112.0 112.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:116.50 stddev:19.04 (16.3%) stddev-sans-first:18.84 04:17:05 INFO - PROCESS | 1666 | Values: 139.0 108.0 107.0 157.0 106.0 106.0 125.0 105.0 138.0 104.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:182.40 Median:184.00 stddev:2.12 (1.2%) stddev-sans-first:2.24 04:17:05 INFO - PROCESS | 1666 | Values: 182.0 185.0 184.0 180.0 184.0 182.0 180.0 179.0 184.0 184.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:76.30 Median:74.50 stddev:18.26 (24.5%) stddev-sans-first:19.36 04:17:05 INFO - PROCESS | 1666 | Values: 77.0 72.0 56.0 109.0 56.0 69.0 82.0 89.0 97.0 56.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:86.00 stddev:13.14 (15.3%) stddev-sans-first:13.92 04:17:05 INFO - PROCESS | 1666 | Values: 82.0 90.0 93.0 70.0 70.0 66.0 96.0 70.0 67.0 99.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:1.91 (2.2%) stddev-sans-first:1.87 04:17:05 INFO - PROCESS | 1666 | Values: 89.0 86.0 89.0 85.0 88.0 85.0 88.0 86.0 89.0 84.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:94.00 stddev:17.99 (19.1%) stddev-sans-first:18.78 04:17:05 INFO - PROCESS | 1666 | Values: 94.0 95.0 116.0 150.0 104.0 94.0 95.0 94.0 94.0 94.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:1.51 (1.8%) stddev-sans-first:1.50 04:17:05 INFO - PROCESS | 1666 | Values: 83.0 87.0 83.0 84.0 85.0 85.0 87.0 83.0 84.0 84.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:2.00 (3.7%) stddev-sans-first:1.94 04:17:05 INFO - PROCESS | 1666 | Values: 52.0 54.0 53.0 55.0 54.0 59.0 56.0 53.0 53.0 54.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:4.55 (6.4%) stddev-sans-first:4.49 04:17:05 INFO - PROCESS | 1666 | Values: 66.0 66.0 70.0 82.0 72.0 72.0 68.0 71.0 71.0 69.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:84.50 stddev:11.23 (13.3%) stddev-sans-first:11.79 04:17:05 INFO - PROCESS | 1666 | Values: 83.0 82.0 83.0 85.0 81.0 85.0 84.0 86.0 86.0 119.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.50 stddev:4.86 (3.6%) stddev-sans-first:5.16 04:17:05 INFO - PROCESS | 1666 | Values: 136.0 133.0 136.0 134.0 133.0 132.0 135.0 134.0 149.0 137.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:164.00 stddev:9.67 (5.9%) stddev-sans-first:10.20 04:17:05 INFO - PROCESS | 1666 | Values: 164.0 162.0 167.0 194.0 165.0 164.0 164.0 163.0 162.0 163.0 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 04:17:05 INFO - PROCESS | 1666 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 04:17:05 INFO - PROCESS | 1666 | -------- Summary: end -------- 04:17:05 INFO - PROCESS | 1666 | 04:17:05 INFO - TEST-INFO | 1666: exit 0 04:17:05 INFO - TEST-OK | kraken | took 58619ms 04:17:05 INFO - SUITE-END | took 1174s 04:17:06 INFO - Completed test suite (00:19:35) 04:17:06 INFO - javascript benchmark 04:17:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2680.4237089025855, 3388.5090560153517, 3389.457686770117, 3399.0, 3423.2468856851483, 5701.372848986608, 5733.283339582552, 5743.253377060987, 5789.044807606745, 5804.245448091748, 5791.189233507313, 5814.331351894522, 5833.270841144847, 5889.941100588992, 5920.171176035347, 5138.768755405997, 5153.0, 5216.3218781558535, 5227.32044834171, 5318.0, 5017.799288028493, 5276.182191760283, 5314.5748340132695, 5319.122344813101, 5376.865578360533, 5154.252633368141, 5155.226715992593, 5184.144616138333, 5195.558377537914, 5249.711265880375, 5190.299309593194, 5197.0, 5200.323957885488, 5261.921071183935, 5331.466853314676, 5148.786997569998, 5212.8957420851375, 5219.608529360313, 5266.289050978107, 5298.337707786527, 5722.055860782966, 5875.236219291507, 5910.143029260733, 5931.139984702238, 5961.284645842483, 6166.784162554289, 6231.875362492725, 6233.750649973996, 6235.625862448268, 6279.717412716439, 5281.52466278033, 6297.590656607306, 6298.716557754912, 6302.086197501382, 6308.432241098278, 5760.395158508296, 5804.303483581997, 5916.674582897982, 5917.674527900964, 5998.340182579913, 6343.524235682342, 6375.3624637536805, 6388.1376014237485, 6396.776112836028, 6406.487481001509, 6183.103449999815, 6198.442140207403, 6213.00591905293, 6214.25428948529, 6220.066989951543, 6129.970128114947, 6197.25632924052, 6227.844303892439, 6324.3991820776955, 6328.208973878265, 6140.969295153495, 6189.566730328924, 6194.977828658311, 6222.12890195373, 6242.1261023456755, 6225.657588832658, 6241.625502469867, 6246.187995560548, 6250.437460628475, 6254.15568898202, 4607.838725644587, 4786.851155722601, 4976.975115124401, 4984.4267909190185, 5028.145215313405, 4390.4511936008, 4410.845620403271, 4443.488998765119, 4446.710963787344, 4475.6419486441655, 5849.61977471463, 5863.149843272701, 5867.973104706744, 5871.236739223874, 5897.616654917417, 6185.938140618537, 6243.843903902348, 6297.338779428185, 6305.432511074026, 6316.210473690789, 5767.682777447197, 5796.188533605298, 5808.738606762706, 5824.475797178189, 5831.737571809279, 4619.653525985565, 5408.080626293539, 5463.48096930791, 5471.206675032098, 5479.287692599936, 6317.684115794192, 6358.491320694426, 6382.170317858741, 6389.361063893573, 6391.328910464427, 5269.868253293698, 6231.2522497300615, 6232.0, 6272.310045895039, 6289.559730818799, 6215.9378406215355, 6302.590331628429, 6391.58454700443, 6393.041043843461, 6415.935840641534, 6216.409441103088, 6255.874882502233, 6258.749650013949, 6274.341194174728, 6283.96858015707, 6269.216347956505, 6282.591631543935, 6287.497000240061, 6298.0552917062805, 6301.0863424804065, 6031.638101713911, 6095.664738439428, 6143.662098584442, 6209.844753881189, 6242.3133455320785, 6113.020255720452, 6119.058514554021, 6140.631562106109, 6146.938530614815, 6164.938350616616, 6072.05883088122, 6075.817725468243, 6094.75620975156, 6096.817095487142, 6099.782863703368, 4699.389079419653, 5990.071538911476, 6094.329623741296, 6118.908216376669, 6217.906731399123, 6004.0693692477735, 6004.249468816398, 6064.666443345482, 6069.393060694072, 6098.908516372169], "value": 5725.833330388772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.6825329409238, 523.8585581892889, 531.1236459841261, 546.5299842135765, 567.4835899331608, 29372.0, 30510.0, 31426.371472570536, 31487.842560787165, 43057.0, 34773.30453390937, 44659.33011004837, 44758.0, 44806.551934480645, 44827.32759008618, 9783.461909594987, 10004.099631033205, 10004.999500049973, 10005.54975026122, 10010.499475026256, 8762.386632935697, 8983.595738191765, 9772.560234789451, 9914.801703965917, 12021.699457513589, 11825.586104486345, 12223.205491643059, 12245.326507042153, 12261.080418968613, 12261.141720079599, 12039.939800300986, 12157.69605759863, 12179.208351457128, 12187.573434929735, 12191.939040304831, 8686.956565217133, 11769.529218831236, 12046.397680115959, 12061.492313460818, 12104.39478026104, 41988.950276243035, 42327.15345693069, 42406.0, 42504.78747606273, 42514.57485425137, 3201.695838895301, 3590.1563132663805, 3623.8912832615065, 3625.9456108158397, 3689.114612493009, 32414.027579172664, 32965.681372745064, 33195.83402082974, 33973.15067123317, 34225.82887085574, 3118.5789918361183, 3187.0, 3227.8547465364113, 3273.705366517001, 3395.7283417326553, 508173.0, 510972.0, 512021.9999999963, 512116.0, 512176.0, 55717.0, 63945.0, 64294.0, 64341.678291608245, 64403.0, 68275.3172468279, 68340.0, 68391.31608683949, 68452.657736711, 68531.62936741237, 16493.505194844172, 17027.744583831252, 17046.0, 17097.230624621923, 17115.572110697332, 12975.610731678065, 13045.804312935314, 13049.0, 13050.021248406407, 13053.34733263333, 17293.481195564153, 17587.73618395725, 17599.82400175982, 17684.46946591604, 17749.911250443663, 6900.6204658744255, 7795.061470621869, 7845.568493732785, 7868.331191848757, 7884.0, 899.4423457456419, 997.875265591801, 1027.2039169643585, 1060.6499855047816, 1095.9397233152254, 25548.23355299344, 30938.381232375228, 31259.0, 31393.553609169554, 32505.0, 1075.2365820267541, 1077.7251800790748, 1078.2398409121552, 1117.6479408986143, 1173.9882601173879, 16237.0, 16251.59371015734, 16304.673906521803, 16443.56805459668, 16590.25343859505, 632251.0, 639666.0, 640850.0, 641060.0, 644869.0, 60572.697136514034, 61032.69483652553, 61282.693586532674, 61367.693161533905, 61451.385486144565, 1392.791081337787, 1436.490046033664, 1450.0647082631854, 1454.7672372420361, 1461.978070328946, 28781.424371512872, 30514.237144071576, 31047.379052419277, 31109.68890311068, 31371.05886823399, 52341.21488177604, 52442.213366798765, 52774.47225527695, 52797.7360113197, 52835.735821320646, 554861.0, 557567.0, 558068.0, 560151.0, 561409.0, 27201.72798272071, 27360.0, 27678.44643107167, 27732.44535109327, 27761.583576246776, 37660.721692243795, 40023.79988100041, 47298.527014729414, 50832.98334033225, 53171.46828531665, 40423.98940026523, 41276.38085428781, 41766.424592963405, 42190.0, 42387.57612423836, 33911.491327630596, 40833.79583102065, 40984.0, 41696.16607667891, 42483.78758106189, 38981.80509097436, 39533.2093358137, 39548.604513954495, 39707.40438893477, 40038.0, 35318.94043178709, 35534.46698299579, 36296.09259768527, 36356.45465318075, 36418.90743277706, 21417.78582214158, 25027.624585630867, 25448.491030179663, 26079.869600651877, 26579.33551661224], "value": 20788.6510500407, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.86116969703033, 329.3002369963827, 375.8834761224021, 389.25457748411776, 397.11047254150714, 21099.68350474744, 21145.471363215926, 21860.23489177879, 22158.88920555397, 22189.001494932727, 20085.096170672317, 21781.564368712618, 21834.672479912813, 22122.33632991009, 22142.0, 5958.838026584817, 5993.370696076903, 6230.532710046742, 6234.314225435199, 6239.34486878878, 4231.449911511515, 4477.0, 6098.268207815068, 6226.750929962796, 6587.407133357997, 5865.0, 6963.338482844147, 6967.198772141192, 6971.686274117652, 6994.685239164224, 6617.966910165443, 6932.792016239521, 6940.30596940307, 6945.409640180591, 6965.094537710116, 5952.880942381172, 6025.66858822769, 6031.366706495843, 6034.96982515089, 6037.45662890342, 27214.183574492796, 27243.182704518895, 27274.04540841061, 27410.0, 27486.725132748616, 2312.8727919964394, 2350.306659535441, 2459.4712136890653, 2474.2948259745885, 2549.6557964674716, 15085.0, 16234.918825405915, 16442.260098295606, 16858.9884606924, 16925.153742312836, 1806.331657286799, 1898.734177215191, 1928.469670840516, 1944.7277381166648, 1985.205917632944, 106786.0, 107649.0, 108092.0, 108955.0, 109792.0, 9333.906660933304, 10778.946105269424, 11165.776684466266, 11376.601818936297, 11392.316461012366, 13993.860061399459, 14086.0, 14214.360353784105, 14221.360038798279, 14232.644183895485, 8672.479651220947, 8856.64573417069, 8895.154960278764, 8927.642894284285, 8998.640054397882, 7373.631318434057, 8972.878390201226, 8975.910240897638, 9046.502442365732, 9150.908490915006, 6838.692258848364, 6898.793036208922, 6941.930580694229, 6959.304069593101, 6968.686409111602, 1703.948881533556, 1755.4294854172445, 1819.054091872219, 1835.7608614185372, 1841.2565277736078, 868.1362044765499, 925.2459245714721, 985.8718366612438, 1045.9592705258317, 1055.0978913029248, 21974.340769776933, 22298.665520017214, 22385.216517421813, 22413.775862241495, 22469.213577524708, 816.5713000674693, 828.556722153645, 984.9852252216223, 1067.4982758103679, 1120.8767035626074, 11196.440177991068, 11505.367204803817, 11572.18994670365, 11604.30374177552, 11629.24409913353, 443455.0, 570460.0, 579157.0, 582362.0, 590616.0, 121341.0, 123016.0, 124132.0, 125167.0, 135864.6413535852, 964.238251781099, 969.2294625772387, 1007.9949600251952, 1010.8079464901646, 1019.2712210769336, 18839.0, 19399.2240310386, 20282.087306070967, 20287.391378258675, 20455.79544204539, 38195.809020954715, 45685.62943111712, 54919.45080549143, 55402.61493462696, 55850.16224756713, 81679.5916020416, 81695.77456338279, 81700.0, 82614.0, 82615.586922065, 8120.350371970347, 8245.79385515367, 8305.294050005576, 8319.875201872097, 8487.702930397407, 10950.616728414467, 12957.028222883133, 13174.275414852274, 13232.404541795835, 13279.734405312032, 8315.0, 10983.560657573928, 11196.888031119584, 11227.989480946753, 11234.325940443272, 10802.919708029134, 10902.836457453303, 11078.446077696244, 11269.211155219056, 11321.377324247245, 9273.907260927574, 10993.780124397308, 11328.037116844831, 11513.597024104116, 11547.826782598437, 6502.544821862613, 7535.397168226638, 7561.757495757066, 7575.886361704469, 8456.788580285296, 9994.250431217833, 11140.665780026613, 11199.272047317225, 11355.318680879174, 11428.771424571629], "value": 9942.382676116858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.6565022869852, 1584.2316476508893, 1798.163853807979, 1893.0534732633682, 1948.8635795494322, 8642.178992995663, 8958.776030599238, 9103.59033843477, 9123.77190570236, 9160.35877488576, 7915.1689072647405, 8166.959165204165, 8444.704435344764, 8730.825383492327, 8866.645334186625, 2327.569399661064, 2363.444590521226, 2367.4554852383962, 2368.7749663782, 2375.6911601491784, 2347.248880358286, 2352.070931981866, 2387.7015373078366, 2387.713474383068, 2390.3187591536416, 1805.981940180601, 2085.259732794859, 2167.566486702658, 2395.0, 2395.35325462126, 2358.2453614843257, 2371.91698290559, 2384.3204686664217, 2389.187676190086, 2392.7248366437907, 2379.0, 2395.257470184231, 2395.6406539019113, 2402.531506356261, 2407.807375409963, 8772.517511536864, 8815.426997245158, 8829.779255518664, 8832.55837208137, 8851.46891186531, 5204.089284375219, 5316.149416093406, 5362.570994320445, 5366.70483123428, 5375.11310633745, 3493.0788066563287, 3543.8759643412614, 3659.9451008234896, 3662.688671462929, 3668.6147954464664, 1000.8398656214971, 1018.1447584029451, 1080.8432777247333, 1084.0839490630406, 1107.3134656512932, 9671.371360861522, 9938.552765125587, 11631.418429078512, 11643.592474263445, 11647.0, 3910.865848903843, 4568.360429539867, 4627.583517483443, 4757.476677565465, 4807.927881081787, 9962.0, 9968.252381071448, 9979.351342162881, 9996.650117245861, 10000.549975251131, 5326.97336513315, 5327.440618735054, 5335.359756829128, 5336.066188417011, 5336.092864213016, 4694.953050469451, 4717.386739723814, 4777.976110119427, 4785.0, 4943.5797957174045, 3433.3819912416006, 3838.692904567628, 3880.941785873214, 3926.2540117377607, 3956.8219430125714, 1198.9700257493632, 1230.1696354960366, 1257.9685507862193, 1263.7851565233748, 1274.1654216488214, 704.2886684448744, 921.741912264567, 980.9901900981041, 994.6319861651235, 1002.3361220374289, 6074.149619053248, 6075.696215189223, 6147.631142131397, 6202.596831205957, 6318.4313411793155, 923.5243849417556, 940.1820416237916, 946.4132238012339, 960.5293406231036, 998.5656239535825, 3833.5783063862955, 4230.576942305806, 4351.477822661301, 4427.180971520279, 4459.977700111479, 10134.746631334276, 10810.783784324269, 10817.296875703212, 10931.289466184673, 10974.231803773659, 9879.80240395188, 10343.534540945526, 10885.510152043176, 10916.672499825017, 10941.45292735376, 7197.712091516385, 7925.445218834741, 8285.088640249567, 8291.212334828182, 8404.07555168931, 6085.2393450818645, 6223.688815559113, 6242.843928901813, 6272.623642581277, 6305.423644088978, 9791.804163916824, 9797.118259356692, 10138.290319677551, 10145.64490242838, 10215.284930054824, 10194.235432342752, 10199.28604997643, 10321.48392580383, 10328.896711032794, 10446.112080473245, 7574.356179724785, 7777.0, 7781.727639532589, 7786.571738554434, 7787.688492460238, 8223.14979129715, 8291.875621865798, 8423.0, 8439.198276163756, 8439.620217090123, 7563.546187228784, 7590.392768578611, 7654.15804261542, 7670.616469176631, 7742.225777422213, 7368.631568421664, 7474.588897610466, 7529.698812047676, 7536.623168841646, 7582.507137036075, 7014.368706816411, 7058.505904586835, 7133.500654954311, 7137.714491420285, 7137.785866424016, 5169.250458683545, 5169.478102478797, 5185.455527169744, 5247.58019358458, 5288.81489147878, 4364.410804541473, 4928.802847886044, 5192.792288308426, 5211.687298762086, 5358.624896257381], "value": 4630.350647838078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.6749273321147, 293.79727987688494, 295.85207396301837, 297.9433907557564, 303.2812235003043, 5344.305240318758, 5388.892222155555, 5412.269343638613, 5446.972765136169, 5473.507384335409, 4351.456067991501, 4517.063908459503, 4628.328892310621, 5348.839534813962, 5391.2452256684, 3188.0595224408853, 3260.8206548639814, 3878.1661942682317, 4031.8790436286813, 4038.3134867072667, 3940.389239667856, 3990.8626041578154, 4015.7590544567274, 4032.346737837487, 4034.6570541504007, 4000.2599519089063, 4001.25976694311, 4007.7394969327047, 4025.5370632377358, 4033.616806403402, 3775.0, 3777.6033516480784, 3899.844006239747, 3921.803909804513, 4049.5219244975665, 3452.7755695879687, 3458.654134586546, 3471.427214509603, 3488.9127771805656, 3508.333416650854, 5196.376434827807, 5200.817971370984, 5237.764300606444, 5252.820079666972, 5347.59893008022, 3978.840846366171, 4381.802818873159, 4574.336721175444, 4590.977045114753, 4649.442066951953, 4768.356271903283, 5555.805546805843, 5571.0, 5596.804111856066, 5664.291963504562, 3846.8461261549505, 3856.4986551748375, 3856.804390638883, 3864.845406183749, 3866.6326698963553, 4634.3048542718525, 5544.1960915667405, 5915.733791979285, 5958.255218097738, 5971.223740913653, 3491.760425049071, 3741.28915506053, 3776.33914065043, 3973.145773658677, 4073.6130067643526, 3220.710136087763, 3988.900277493086, 3998.0, 4017.4375587417785, 4022.6580740636787, 3634.83643236055, 4623.514530974267, 4649.209634362167, 4670.95329046712, 4692.249240121632, 5356.196570514376, 5637.661740295595, 5644.5484361251, 5652.604317697804, 5694.259746233046, 1141.680329507739, 1292.9094963352663, 1335.3456806164909, 1339.6985678222322, 1347.4138749643937, 716.5879619218865, 792.4690457393444, 795.8368534450424, 808.2806302390877, 811.9404177548238, 5062.367204099488, 5110.105731497048, 5182.144946083929, 5204.643005261661, 5379.139337706027, 5489.011977844027, 5774.2782152230975, 5831.88336233273, 5845.064789633639, 5915.0, 4902.828401005948, 5265.473452654704, 5345.305110335631, 5359.410464848864, 5371.62398632092, 2670.6795184577977, 2721.3468767496056, 2867.7705783537267, 2891.7686585073143, 2984.4329577380227, 5284.339457567804, 5923.674197919156, 5934.8813023739285, 6018.8194354169445, 6021.217241758543, 5618.190904547726, 5904.291485021739, 5922.3485416604135, 6008.459238668541, 6012.969935150296, 5695.572832037531, 5938.673372964442, 5954.0, 5964.642121472725, 5990.820275391745, 5148.4851514848215, 5258.816766227721, 5688.975984322861, 5820.534357251495, 5823.718781867982, 4797.2564252540915, 5612.85967850807, 5669.31968163823, 5685.545156387562, 5695.519165017208, 4943.283223932582, 5734.139879018181, 5926.496247818984, 5938.376470470538, 5958.480587450345, 3203.19920019995, 3363.5963684358035, 3632.763870348419, 3664.4320130379833, 3700.410601716331, 5701.287339082614, 5721.284839395075, 5725.2843394575675, 5737.684427356536, 5769.423057694365, 5619.831405057855, 5624.690642014729, 5642.50164897766, 5644.717764111861, 5658.575606829587, 5231.267622532772, 5586.379949814508, 5589.301337332833, 5629.0, 5635.971820140873, 4843.491433399583, 5274.156135018378, 5490.203920431595, 5536.557075434036, 5560.777568897199, 4975.228839529878, 5006.349174607278, 5108.540231379194, 5301.693763213015, 5461.371942226536, 4596.448426188878, 5021.84934451967, 5402.379286214199, 5510.421405752499, 5523.1991361253195], "value": 4071.4451370248958, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.3541721827837, 767.1829501580812, 778.7897267737711, 817.1379194949328, 846.4075147396824, 13809.447622095116, 16442.177891105457, 16448.0, 16456.917715411422, 16484.42304519342, 15018.399264029425, 15025.924870375633, 15184.6963060739, 15209.4676686316, 15238.0, 711.8078118907891, 726.5967388099602, 898.586650140936, 921.4609453469728, 924.1128516624016, 891.5854127830557, 914.5518695839024, 918.2241006349624, 923.1230331185367, 925.9027802080785, 961.1781926452887, 971.0629242780715, 974.133021610767, 975.4147511493082, 976.067855198284, 741.847921176163, 762.5081822224689, 964.0407794244736, 964.5514835601444, 967.2697113679127, 571.4514066496168, 572.5905977226262, 643.4144928115393, 699.51034276007, 717.1465955512923, 15279.770803437958, 15316.463923762727, 15318.540443786704, 15335.0, 15354.001989870734, 13878.791818122636, 14214.0, 14293.71356577913, 14390.784138237936, 14397.424103035866, 13056.281904495248, 13077.607671769862, 13153.60539183826, 13307.20156790586, 13559.728805423836, 4009.2382447335203, 4599.885002874921, 4630.351750754897, 4750.904981900343, 4788.832390866303, 108884.0, 112000.4399978003, 114215.0, 115307.42346288299, 115599.0, 11128.833067503994, 11223.326600404002, 11426.657200284004, 11485.827712584318, 11768.529258829722, 22256.99843507046, 22259.332220033426, 22264.22075227359, 22276.331710048726, 22305.107795688316, 6856.24581296057, 7984.161663025415, 8047.315978141924, 8106.270435660819, 8191.0, 4369.453818272716, 4451.888702782391, 4475.619572336323, 4490.640748740093, 4629.8148074077335, 3500.4749287607065, 3615.746897717187, 3621.511096002059, 3622.909427264287, 3625.057485053905, 651.4788169464505, 651.664392837689, 660.4914216053708, 679.6397909108181, 681.7852376501386, 545.4164044472456, 576.4091805898987, 605.3008774865037, 656.2187131372623, 666.5534092158168, 8753.078463989972, 9179.127982841619, 9223.262139028862, 9251.953740231256, 9253.768655783524, 595.9493443057302, 611.5932904618379, 615.2217444932164, 631.3402494393279, 634.7587916591666, 3663.8900832975055, 4305.547917468683, 4354.651627869763, 4381.539938306496, 4475.753833539122, 139301.3034934819, 141558.2922085383, 146442.0, 149927.0, 154518.22740886224, 133947.0, 134716.55104063428, 138146.0, 139025.0, 141259.0, 73528.63235683787, 106135.46932265289, 109819.45090274498, 110597.0, 112104.0, 8605.35459840502, 8648.1784230498, 8721.839057497944, 8726.0, 8808.383413161273, 65567.67216163888, 66446.33553664401, 66531.0, 67461.32538674747, 68146.61486847936, 87145.0, 92284.0, 95973.52013239889, 96973.0, 98335.01664983545, 11542.711432214262, 11554.653360399201, 11680.415979200836, 12033.0, 12092.334921579046, 12028.879711202775, 12101.878981210075, 12123.333216672814, 12684.302363369734, 12720.87279127197, 10170.389776613427, 11563.537458501902, 11801.35092569917, 12220.755584888075, 12357.32034738062, 9091.54542272897, 14033.158010518993, 14150.4623844039, 14186.077904936146, 14681.339339729951, 12479.812802807783, 13938.30308484592, 13950.023498355424, 13994.670506301885, 14219.09326942289, 11439.970402663468, 11545.769084618429, 11598.956093951585, 11615.419229038684, 11722.531098755955, 10543.578256869947, 11432.0, 11484.598039068593, 11667.76664466689, 11696.298222106701], "value": 7858.3596465755745, "unit": "score"}], "name": "dromaeo_css", "value": 7481.40125754161, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 113.0, 106.0, 112.0, 112.0, 110.0, 110.0, 112.0, 112.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 107.0, 157.0, 106.0, 106.0, 125.0, 105.0, 138.0, 104.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 184.0, 180.0, 184.0, 182.0, 180.0, 179.0, 184.0, 184.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 56.0, 109.0, 56.0, 69.0, 82.0, 89.0, 97.0, 56.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 90.0, 93.0, 70.0, 70.0, 66.0, 96.0, 70.0, 67.0, 99.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 88.0, 85.0, 88.0, 86.0, 89.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 116.0, 150.0, 104.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 83.0, 84.0, 85.0, 85.0, 87.0, 83.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 55.0, 54.0, 59.0, 56.0, 53.0, 53.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 82.0, 72.0, 72.0, 68.0, 71.0, 71.0, 69.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 85.0, 81.0, 85.0, 84.0, 86.0, 86.0, 119.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 136.0, 134.0, 133.0, 132.0, 135.0, 134.0, 149.0, 137.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 167.0, 194.0, 165.0, 164.0, 164.0, 163.0, 162.0, 163.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1424.1000000000001, "alertThreshold": 2.0}]} 04:17:06 INFO - Return code: 0 04:17:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:06 INFO - # TBPL SUCCESS # 04:17:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:17:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:17:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:17:06 INFO - 2016-07-08 04:17:06.355 screenresolution[1670:9689] starting screenresolution argv=screenresolution get 04:17:06 INFO - 2016-07-08 04:17:06.357 screenresolution[1670:9689] Display 0: 1600x1200x32@60 04:17:06 INFO - 2016-07-08 04:17:06.363 screenresolution[1671:9692] starting screenresolution argv=screenresolution list 04:17:06 INFO - Available Modes on Display 0 04:17:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:17:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:17:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:17:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:17:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:17:06 INFO - Intel Iris: 04:17:06 INFO - Chipset Model: Intel Iris 04:17:06 INFO - Type: GPU 04:17:06 INFO - Bus: Built-In 04:17:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:17:06 INFO - Vendor: Intel (0x8086) 04:17:06 INFO - Device ID: 0x0a2e 04:17:06 INFO - Revision ID: 0x0009 04:17:06 INFO - Displays: 04:17:06 INFO - Display: 04:17:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:17:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:17:06 INFO - Display Serial Number: 1600x1200 60 04:17:06 INFO - Main Display: Yes 04:17:06 INFO - Mirror: Off 04:17:06 INFO - Online: Yes 04:17:06 INFO - Rotation: Supported 04:17:06 INFO - Return code: 0 04:17:06 INFO - Running post-action listener: _resource_record_post_action 04:17:06 INFO - ##### 04:17:06 INFO - ##### Finished run-tests step (success) 04:17:06 INFO - ##### 04:17:06 INFO - Running post-run listener: _resource_record_post_run 04:17:06 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 38028800; Write bytes: 704509440; Read time: 385; Write time: 1922 04:17:06 INFO - TinderboxPrint: CPU usage
53.5% 04:17:06 INFO - TinderboxPrint: I/O read bytes / time
38,028,800 / 385 04:17:06 INFO - TinderboxPrint: I/O write bytes / time
704,509,440 / 1,922 04:17:06 INFO - TinderboxPrint: CPU idle
2,253.5 (46.5%) 04:17:06 INFO - TinderboxPrint: CPU system
966.2 (20.0%) 04:17:06 INFO - TinderboxPrint: CPU user
1,621.9 (33.5%) 04:17:06 INFO - TinderboxPrint: Swap in / out
445,083,648 / 0 04:17:06 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390423040; Write bytes: 384493056; Read time: 29149; Write time: 724 04:17:06 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 37074432; Write bytes: 294887424; Read time: 371; Write time: 1085 04:17:07 INFO - Running post-run listener: _upload_blobber_files 04:17:07 INFO - Blob upload gear active. 04:17:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:07 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 04:17:07 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'] 04:17:07 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 04:17:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:17:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:17:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:08 INFO - (blobuploader) - INFO - Done attempting. 04:17:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:17:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:17:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:09 INFO - (blobuploader) - INFO - Done attempting. 04:17:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:17:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:11 INFO - (blobuploader) - INFO - Done attempting. 04:17:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:11 INFO - Return code: 0 04:17:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c079ebbc8dde17ca3fdcd91f8a04cf1c54d5fc4122f72fd3d303f5daff212cd050694fb379b6755e9a6078d45c2480a063e7fd9b9865ede48a4484c9ec0beb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0366f660e1dbfbb267304d284bada5a41ef8997a994f68e3f8e5ce27eb6965b2e4c35578bab4c4d93621b52882a0818cde777b1534dbc6b1504eacfdf381db0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34eb339825e309e4aae1afd7ce23ed3b6f89d2ca0022ad88f37391a83f91e077af299375eb64e7d24a426b384c2589639e470d9e031217361b4af66e3119eda3"} 04:17:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:11 INFO - Contents: 04:17:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c079ebbc8dde17ca3fdcd91f8a04cf1c54d5fc4122f72fd3d303f5daff212cd050694fb379b6755e9a6078d45c2480a063e7fd9b9865ede48a4484c9ec0beb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0366f660e1dbfbb267304d284bada5a41ef8997a994f68e3f8e5ce27eb6965b2e4c35578bab4c4d93621b52882a0818cde777b1534dbc6b1504eacfdf381db0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34eb339825e309e4aae1afd7ce23ed3b6f89d2ca0022ad88f37391a83f91e077af299375eb64e7d24a426b384c2589639e470d9e031217361b4af66e3119eda3"} 04:17:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:11 INFO - Copying logs to upload dir... 04:17:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.823203 ========= master_lag: 1400.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 44 mins, 24 secs) (at 2016-07-08 04:40:32.748716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-08 04:40:32.752488) ========= 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.dqC1uBUHpf/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.iqrg0cyH89/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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/c079ebbc8dde17ca3fdcd91f8a04cf1c54d5fc4122f72fd3d303f5daff212cd050694fb379b6755e9a6078d45c2480a063e7fd9b9865ede48a4484c9ec0beb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0366f660e1dbfbb267304d284bada5a41ef8997a994f68e3f8e5ce27eb6965b2e4c35578bab4c4d93621b52882a0818cde777b1534dbc6b1504eacfdf381db0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34eb339825e309e4aae1afd7ce23ed3b6f89d2ca0022ad88f37391a83f91e077af299375eb64e7d24a426b384c2589639e470d9e031217361b4af66e3119eda3"} build_url:https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/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/c079ebbc8dde17ca3fdcd91f8a04cf1c54d5fc4122f72fd3d303f5daff212cd050694fb379b6755e9a6078d45c2480a063e7fd9b9865ede48a4484c9ec0beb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0366f660e1dbfbb267304d284bada5a41ef8997a994f68e3f8e5ce27eb6965b2e4c35578bab4c4d93621b52882a0818cde777b1534dbc6b1504eacfdf381db0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34eb339825e309e4aae1afd7ce23ed3b6f89d2ca0022ad88f37391a83f91e077af299375eb64e7d24a426b384c2589639e470d9e031217361b4af66e3119eda3"}' ========= master_lag: 1.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-08 04:40:33.882653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 37 secs) (at 2016-07-08 04:40:33.882960) ========= 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.dqC1uBUHpf/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.iqrg0cyH89/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005003 ========= master_lag: 37.00 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 37 secs) (at 2016-07-08 04:41:10.886782) ========= ========= Started reboot skipped (results: 3, elapsed: 14 secs) (at 2016-07-08 04:41:10.887156) ========= ========= Finished reboot skipped (results: 3, elapsed: 14 secs) (at 2016-07-08 04:41:25.101449) ========= ========= Total master_lag: 1439.09 =========