builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0131 starttime: 1467731321.8 results: success (0) buildid: 20160705060223 builduid: 24736e0d5420490fbfa9a4cae16231ac revision: 050c0ad48c7895091b0d9b40ae1a442151248e9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:41.796384) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:41.796897) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:41.797202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:41.854562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:41.854883) ========= 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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-05 08:08:41-- 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% 159M=0s 2016-07-05 08:08:42 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.558190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:42.436128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:42.436461) ========= 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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.027760 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:42.486935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 08:08:42.487253) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 050c0ad48c7895091b0d9b40ae1a442151248e9a --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 050c0ad48c7895091b0d9b40ae1a442151248e9a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zHXfl6zZXY/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.RXJNfv6aNm/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-05 08:08:42,561 truncating revision to first 12 chars 2016-07-05 08:08:42,561 Setting DEBUG logging. 2016-07-05 08:08:42,561 attempt 1/10 2016-07-05 08:08:42,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/050c0ad48c78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 08:08:43,632 unpacking tar archive at: fx-team-050c0ad48c78/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 08:08:43.855493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:43.856902) ========= script_repo_revision: 050c0ad48c7895091b0d9b40ae1a442151248e9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:43.857364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:43.857670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:08:43.878998) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-05 08:08:43.879495) ========= /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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:08:44 INFO - MultiFileLogger online at 20160705 08:08:44 in /builds/slave/test 08:08:44 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 08:08:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:44 INFO - {'append_to_log': False, 08:08:44 INFO - 'base_work_dir': '/builds/slave/test', 08:08:44 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:44 INFO - 'branch': 'Fx-Team', 08:08:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:44 INFO - 'config_files': ('talos/mac_config.py',), 08:08:44 INFO - 'default_actions': ('clobber', 08:08:44 INFO - 'read-buildbot-config', 08:08:44 INFO - 'download-and-extract', 08:08:44 INFO - 'populate-webroot', 08:08:44 INFO - 'create-virtualenv', 08:08:44 INFO - 'install', 08:08:44 INFO - 'run-tests'), 08:08:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:44 INFO - 'download_minidump_stackwalk': True, 08:08:44 INFO - 'download_symbols': 'ondemand', 08:08:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:44 INFO - 'installer_path': 'installer.exe', 08:08:44 INFO - 'log_level': 'info', 08:08:44 INFO - 'log_name': 'talos', 08:08:44 INFO - 'log_to_console': True, 08:08:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:08:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:08:44 INFO - 'opt_config_files': (), 08:08:44 INFO - 'pip_index': False, 08:08:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:44 INFO - 'cmd': ('bash', 08:08:44 INFO - '-c', 08:08:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:44 INFO - 'enabled': True, 08:08:44 INFO - 'halt_on_failure': False, 08:08:44 INFO - 'name': 'check_screen_resolution'},), 08:08:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:44 INFO - 'cmd': ('bash', 08:08:44 INFO - '-c', 08:08:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:44 INFO - 'enabled': True, 08:08:44 INFO - 'halt_on_failure': False, 08:08:44 INFO - 'name': 'check_screen_resolution'},), 08:08:44 INFO - 'run_cmd_checks_enabled': True, 08:08:44 INFO - 'sps_profile': False, 08:08:44 INFO - 'sps_profile_interval': 0, 08:08:44 INFO - 'suite': 'dromaeojs', 08:08:44 INFO - 'system_bits': '32', 08:08:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:44 INFO - 'title': 't-yosemite-r7-0131', 08:08:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:44 INFO - 'use_talos_json': True, 08:08:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:44 INFO - 'work_dir': 'build'} 08:08:44 INFO - ##### 08:08:44 INFO - ##### Running clobber step. 08:08:44 INFO - ##### 08:08:44 INFO - Running pre-action listener: _resource_record_pre_action 08:08:44 INFO - Running main action method: clobber 08:08:44 INFO - rmtree: /builds/slave/test/build 08:08:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:46 INFO - Running post-action listener: _resource_record_post_action 08:08:46 INFO - ##### 08:08:46 INFO - ##### Finished clobber step (success) 08:08:46 INFO - ##### 08:08:46 INFO - ##### 08:08:46 INFO - ##### Running read-buildbot-config step. 08:08:46 INFO - ##### 08:08:46 INFO - Running pre-action listener: _resource_record_pre_action 08:08:46 INFO - Running main action method: read_buildbot_config 08:08:46 INFO - Using buildbot properties: 08:08:46 INFO - { 08:08:46 INFO - "project": "", 08:08:46 INFO - "product": "firefox", 08:08:46 INFO - "script_repo_revision": "production", 08:08:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:08:46 INFO - "repository": "", 08:08:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:08:46 INFO - "buildid": "20160705060223", 08:08:46 INFO - "pgo_build": "False", 08:08:46 INFO - "basedir": "/builds/slave/test", 08:08:46 INFO - "buildnumber": 89, 08:08:46 INFO - "slavename": "t-yosemite-r7-0131", 08:08:46 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:08:46 INFO - "platform": "yosemite_r7", 08:08:46 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:08:46 INFO - "branch": "fx-team", 08:08:46 INFO - "repo_path": "integration/fx-team", 08:08:46 INFO - "revision": "050c0ad48c7895091b0d9b40ae1a442151248e9a", 08:08:46 INFO - "stage_platform": "macosx64", 08:08:46 INFO - "builduid": "24736e0d5420490fbfa9a4cae16231ac", 08:08:46 INFO - "slavebuilddir": "test" 08:08:46 INFO - } 08:08:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 08:08:46 INFO - Running post-action listener: _resource_record_post_action 08:08:46 INFO - ##### 08:08:46 INFO - ##### Finished read-buildbot-config step (success) 08:08:46 INFO - ##### 08:08:46 INFO - ##### 08:08:46 INFO - ##### Running download-and-extract step. 08:08:46 INFO - ##### 08:08:46 INFO - Running pre-action listener: _resource_record_pre_action 08:08:46 INFO - Running main action method: download_and_extract 08:08:46 INFO - mkdir: /builds/slave/test/build/tests 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:08:46 INFO - https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:49 INFO - Downloaded 1199 bytes. 08:08:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 08:08:49 INFO - Using the following test package requirements: 08:08:49 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:08:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 08:08:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 08:08:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'jsshell-mac.zip'], 08:08:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 08:08:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:08:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 08:08:49 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 08:08:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 08:08:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:08:49 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 08:08:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:49 INFO - https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:50 INFO - Downloaded 18800236 bytes. 08:08:50 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'] 08:08:50 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 08:08:53 INFO - Return code: 0 08:08:53 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 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:08:53 INFO - https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:08:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:08:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:08:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:54 INFO - Downloaded 18800236 bytes. 08:08:54 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'] 08:08:54 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 08:08:58 INFO - Return code: 0 08:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:08:58 INFO - https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:08:59 INFO - Downloaded 14403333 bytes. 08:08:59 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'] 08:08:59 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 08:08:59 INFO - Return code: 0 08:08:59 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')]} 08:08:59 INFO - https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 08:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AANkf_tPSRCGas-vaSkIMg/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 08:09:02 INFO - Downloaded 112427423 bytes. 08:09:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:09:02 INFO - mkdir: /builds/slave/test/properties 08:09:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:02 INFO - Contents: 08:09:02 INFO - build_url:https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:09:03 INFO - Running post-action listener: _resource_record_post_action 08:09:03 INFO - Running post-action listener: set_extra_try_arguments 08:09:03 INFO - ##### 08:09:03 INFO - ##### Finished download-and-extract step (success) 08:09:03 INFO - ##### 08:09:03 INFO - ##### 08:09:03 INFO - ##### Running populate-webroot step. 08:09:03 INFO - ##### 08:09:03 INFO - Running pre-action listener: _resource_record_pre_action 08:09:03 INFO - Running main action method: populate_webroot 08:09:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:03 INFO - '--tppagecycles', 08:09:03 INFO - '7'], 08:09:03 INFO - 'tests': ['tsvgm']}}, 08:09:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['damp', 'tps']}, 08:09:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'tests': ['damp', 'tps']}, 08:09:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['dromaeo_dom']}, 08:09:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['basic_compositor_video']}, 08:09:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:09:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['a11yr', 08:09:03 INFO - 'ts_paint', 08:09:03 INFO - 'tpaint', 08:09:03 INFO - 'sessionrestore', 08:09:03 INFO - 'sessionrestore_no_auto_restore', 08:09:03 INFO - 'tabpaint']}, 08:09:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:03 INFO - 'ts_paint', 08:09:03 INFO - 'tpaint', 08:09:03 INFO - 'sessionrestore', 08:09:03 INFO - 'sessionrestore_no_auto_restore', 08:09:03 INFO - 'tabpaint']}, 08:09:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:03 INFO - 'ts_paint', 08:09:03 INFO - 'tpaint', 08:09:03 INFO - 'sessionrestore', 08:09:03 INFO - 'sessionrestore_no_auto_restore', 08:09:03 INFO - 'tabpaint']}, 08:09:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:03 INFO - 'ts_paint', 08:09:03 INFO - 'tpaint', 08:09:03 INFO - 'sessionrestore', 08:09:03 INFO - 'sessionrestore_no_auto_restore', 08:09:03 INFO - 'tabpaint']}, 08:09:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['a11yr', 08:09:03 INFO - 'ts_paint', 08:09:03 INFO - 'tpaint', 08:09:03 INFO - 'sessionrestore', 08:09:03 INFO - 'sessionrestore_no_auto_restore', 08:09:03 INFO - 'tabpaint']}, 08:09:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['a11yr', 08:09:03 INFO - 'ts_paint', 08:09:03 INFO - 'tpaint', 08:09:03 INFO - 'sessionrestore', 08:09:03 INFO - 'sessionrestore_no_auto_restore', 08:09:03 INFO - 'tabpaint']}, 08:09:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['tsvgx', 08:09:03 INFO - 'tsvgr_opacity', 08:09:03 INFO - 'tart', 08:09:03 INFO - 'tscrollx', 08:09:03 INFO - 'cart']}, 08:09:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:03 INFO - 'tsvgr_opacity', 08:09:03 INFO - 'tart', 08:09:03 INFO - 'tscrollx', 08:09:03 INFO - 'cart']}, 08:09:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'talos_options': ['--disable-e10s'], 08:09:03 INFO - 'tests': ['tp5o']}, 08:09:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'tests': ['tp5o']}, 08:09:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'talos_options': ['--disable-e10s', 08:09:03 INFO - '--xperf_path', 08:09:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:03 INFO - 'tests': ['tp5n']}, 08:09:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:03 INFO - 'talos_options': ['--xperf_path', 08:09:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:03 INFO - 'tests': ['tp5n']}}, 08:09:03 INFO - 'talos.zip': {'path': '', 08:09:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:03 INFO - Running post-action listener: _resource_record_post_action 08:09:03 INFO - ##### 08:09:03 INFO - ##### Finished populate-webroot step (success) 08:09:03 INFO - ##### 08:09:03 INFO - ##### 08:09:03 INFO - ##### Running create-virtualenv step. 08:09:03 INFO - ##### 08:09:03 INFO - Running pre-action listener: _resource_record_pre_action 08:09:03 INFO - Running main action method: create_virtualenv 08:09:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:09:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:03 INFO - Using real prefix '/tools/python27' 08:09:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:07 INFO - Installing pip.................done. 08:09:07 INFO - Return code: 0 08:09:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:07 INFO - 'HOME': '/Users/cltbld', 08:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:07 INFO - 'LOGNAME': 'cltbld', 08:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:07 INFO - 'MOZ_NO_REMOTE': '1', 08:09:07 INFO - 'NO_EM_RESTART': '1', 08:09:07 INFO - 'PAGER': '/bin/cat', 08:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:07 INFO - 'PWD': '/builds/slave/test', 08:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:07 INFO - 'SHELL': '/bin/bash', 08:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:07 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:07 INFO - 'USER': 'cltbld', 08:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:07 INFO - 'XPC_FLAGS': '0x0', 08:09:07 INFO - 'XPC_SERVICE_NAME': '0', 08:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:09:07 INFO - Cleaning up... 08:09:07 INFO - Return code: 0 08:09:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:07 INFO - 'HOME': '/Users/cltbld', 08:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:07 INFO - 'LOGNAME': 'cltbld', 08:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:07 INFO - 'MOZ_NO_REMOTE': '1', 08:09:07 INFO - 'NO_EM_RESTART': '1', 08:09:07 INFO - 'PAGER': '/bin/cat', 08:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:07 INFO - 'PWD': '/builds/slave/test', 08:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:07 INFO - 'SHELL': '/bin/bash', 08:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:07 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:07 INFO - 'USER': 'cltbld', 08:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:07 INFO - 'XPC_FLAGS': '0x0', 08:09:07 INFO - 'XPC_SERVICE_NAME': '0', 08:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:07 INFO - Downloading/unpacking psutil>=3.1.1 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:10 INFO - Installing collected packages: psutil 08:09:10 INFO - Running setup.py install for psutil 08:09:11 INFO - building 'psutil._psutil_osx' extension 08:09:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:09:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:09:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:09:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:09:11 INFO - building 'psutil._psutil_posix' extension 08:09:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:09:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:09:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:09:11 INFO - ^ 08:09:11 INFO - 1 warning generated. 08:09:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:09:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:12 INFO - Successfully installed psutil 08:09:12 INFO - Cleaning up... 08:09:12 INFO - Return code: 0 08:09:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:12 INFO - 'HOME': '/Users/cltbld', 08:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:12 INFO - 'LOGNAME': 'cltbld', 08:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:12 INFO - 'MOZ_NO_REMOTE': '1', 08:09:12 INFO - 'NO_EM_RESTART': '1', 08:09:12 INFO - 'PAGER': '/bin/cat', 08:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:12 INFO - 'PWD': '/builds/slave/test', 08:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:12 INFO - 'SHELL': '/bin/bash', 08:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:12 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:12 INFO - 'USER': 'cltbld', 08:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:12 INFO - 'XPC_FLAGS': '0x0', 08:09:12 INFO - 'XPC_SERVICE_NAME': '0', 08:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:09:15 INFO - Installing collected packages: mozsystemmonitor 08:09:15 INFO - Running setup.py install for mozsystemmonitor 08:09:15 INFO - Successfully installed mozsystemmonitor 08:09:15 INFO - Cleaning up... 08:09:15 INFO - Return code: 0 08:09:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:15 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 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:15 INFO - 'HOME': '/Users/cltbld', 08:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:15 INFO - 'LOGNAME': 'cltbld', 08:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:15 INFO - 'MOZ_NO_REMOTE': '1', 08:09:15 INFO - 'NO_EM_RESTART': '1', 08:09:15 INFO - 'PAGER': '/bin/cat', 08:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:15 INFO - 'PWD': '/builds/slave/test', 08:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:15 INFO - 'SHELL': '/bin/bash', 08:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:15 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:15 INFO - 'USER': 'cltbld', 08:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:15 INFO - 'XPC_FLAGS': '0x0', 08:09:15 INFO - 'XPC_SERVICE_NAME': '0', 08:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:18 INFO - warning: no files found matching '*.txt' 08:09:18 INFO - no previously-included directories found matching 'build' 08:09:18 INFO - no previously-included directories found matching 'dist' 08:09:18 INFO - no previously-included directories found matching '.git*' 08:09:18 INFO - Installing collected packages: jsonschema, functools32 08:09:18 INFO - Running setup.py install for functools32 08:09:18 INFO - warning: no files found matching '*.txt' 08:09:18 INFO - no previously-included directories found matching 'build' 08:09:18 INFO - no previously-included directories found matching 'dist' 08:09:18 INFO - no previously-included directories found matching '.git*' 08:09:18 INFO - Successfully installed jsonschema functools32 08:09:18 INFO - Cleaning up... 08:09:18 INFO - Return code: 0 08:09:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:18 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')]} 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:18 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')]} 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:18 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 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:18 INFO - 'HOME': '/Users/cltbld', 08:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:18 INFO - 'LOGNAME': 'cltbld', 08:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:18 INFO - 'MOZ_NO_REMOTE': '1', 08:09:18 INFO - 'NO_EM_RESTART': '1', 08:09:18 INFO - 'PAGER': '/bin/cat', 08:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:18 INFO - 'PWD': '/builds/slave/test', 08:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:18 INFO - 'SHELL': '/bin/bash', 08:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:18 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:18 INFO - 'USER': 'cltbld', 08:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:18 INFO - 'XPC_FLAGS': '0x0', 08:09:18 INFO - 'XPC_SERVICE_NAME': '0', 08:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:22 INFO - Downloading docopt-0.6.1.tar.gz 08:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:22 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:22 INFO - Running setup.py install for blobuploader 08:09:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:22 INFO - Running setup.py install for requests 08:09:23 INFO - Running setup.py install for docopt 08:09:23 INFO - Successfully installed blobuploader requests docopt 08:09:23 INFO - Cleaning up... 08:09:23 INFO - Return code: 0 08:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:23 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 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:23 INFO - 'HOME': '/Users/cltbld', 08:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:23 INFO - 'LOGNAME': 'cltbld', 08:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:23 INFO - 'MOZ_NO_REMOTE': '1', 08:09:23 INFO - 'NO_EM_RESTART': '1', 08:09:23 INFO - 'PAGER': '/bin/cat', 08:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:23 INFO - 'PWD': '/builds/slave/test', 08:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:23 INFO - 'SHELL': '/bin/bash', 08:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:23 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:23 INFO - 'USER': 'cltbld', 08:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:23 INFO - 'XPC_FLAGS': '0x0', 08:09:23 INFO - 'XPC_SERVICE_NAME': '0', 08:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-StPCgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-iKG98J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-XMUoYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-KyzqLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-YCQe8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-FEv3nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-WeCBs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-sGWNoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-s5SwdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-5qBTMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-VNY0kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-r2Te5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-KQqRhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-hSKt4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-jUikVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-cX794J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-4hUc1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:25 INFO - Running setup.py install for manifestparser 08:09:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:25 INFO - Running setup.py install for mozcrash 08:09:25 INFO - Running setup.py install for mozdebug 08:09:26 INFO - Running setup.py install for mozdevice 08:09:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozfile 08:09:26 INFO - Running setup.py install for mozhttpd 08:09:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozinfo 08:09:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozInstall 08:09:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:26 INFO - Running setup.py install for mozleak 08:09:26 INFO - Running setup.py install for mozlog 08:09:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Running setup.py install for moznetwork 08:09:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Running setup.py install for mozprocess 08:09:27 INFO - Running setup.py install for mozprofile 08:09:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Running setup.py install for mozrunner 08:09:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:27 INFO - Running setup.py install for mozscreenshot 08:09:27 INFO - Running setup.py install for moztest 08:09:28 INFO - Running setup.py install for mozversion 08:09:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:28 INFO - Cleaning up... 08:09:28 INFO - Return code: 0 08:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:28 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 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:28 INFO - 'HOME': '/Users/cltbld', 08:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:28 INFO - 'LOGNAME': 'cltbld', 08:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:28 INFO - 'MOZ_NO_REMOTE': '1', 08:09:28 INFO - 'NO_EM_RESTART': '1', 08:09:28 INFO - 'PAGER': '/bin/cat', 08:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:28 INFO - 'PWD': '/builds/slave/test', 08:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:28 INFO - 'SHELL': '/bin/bash', 08:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:28 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:28 INFO - 'USER': 'cltbld', 08:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:28 INFO - 'XPC_FLAGS': '0x0', 08:09:28 INFO - 'XPC_SERVICE_NAME': '0', 08:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ApYZJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ANtxGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-0ErUWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-R5CYak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:28 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)) 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ktSnwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-CuYwFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-1WNpCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-KY3afe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-j4YGRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-PUdzBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:29 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)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-YnYKuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-BvoW78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-yHfh2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-V1_ge8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:29 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-3ERiHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:30 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-XIpZMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:30 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-PGKOiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:30 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)) 08:09:30 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)) 08:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:30 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)) 08:09:30 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)) 08:09:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:32 INFO - Downloading blessings-1.6.tar.gz 08:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:32 INFO - Installing collected packages: blessings 08:09:32 INFO - Running setup.py install for blessings 08:09:32 INFO - Successfully installed blessings 08:09:32 INFO - Cleaning up... 08:09:33 INFO - Return code: 0 08:09:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:33 INFO - Reading from file tmpfile_stdout 08:09:33 INFO - Current package versions: 08:09:33 INFO - blessings == 1.6 08:09:33 INFO - blobuploader == 1.2.4 08:09:33 INFO - docopt == 0.6.1 08:09:33 INFO - functools32 == 3.2.3-2 08:09:33 INFO - jsonschema == 2.5.1 08:09:33 INFO - manifestparser == 1.1 08:09:33 INFO - mozInstall == 1.12 08:09:33 INFO - mozcrash == 0.17 08:09:33 INFO - mozdebug == 0.1 08:09:33 INFO - mozdevice == 0.48 08:09:33 INFO - mozfile == 1.2 08:09:33 INFO - mozhttpd == 0.7 08:09:33 INFO - mozinfo == 0.9 08:09:33 INFO - mozleak == 0.1 08:09:33 INFO - mozlog == 3.2 08:09:33 INFO - moznetwork == 0.27 08:09:33 INFO - mozprocess == 0.22 08:09:33 INFO - mozprofile == 0.28 08:09:33 INFO - mozrunner == 6.11 08:09:33 INFO - mozscreenshot == 0.1 08:09:33 INFO - mozsystemmonitor == 0.3 08:09:33 INFO - moztest == 0.7 08:09:33 INFO - mozversion == 1.4 08:09:33 INFO - psutil == 3.1.1 08:09:33 INFO - requests == 1.2.3 08:09:33 INFO - wsgiref == 0.1.2 08:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 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 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:33 INFO - 'HOME': '/Users/cltbld', 08:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:33 INFO - 'LOGNAME': 'cltbld', 08:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:33 INFO - 'MOZ_NO_REMOTE': '1', 08:09:33 INFO - 'NO_EM_RESTART': '1', 08:09:33 INFO - 'PAGER': '/bin/cat', 08:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:33 INFO - 'PWD': '/builds/slave/test', 08:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:33 INFO - 'SHELL': '/bin/bash', 08:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:33 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:33 INFO - 'USER': 'cltbld', 08:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:33 INFO - 'XPC_FLAGS': '0x0', 08:09:33 INFO - 'XPC_SERVICE_NAME': '0', 08:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:33 INFO - Cleaning up... 08:09:33 INFO - Return code: 0 08:09:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102894618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec01da4e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, '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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:09: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', 'jsonschema'] in /builds/slave/test/build 08:09: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 jsonschema 08:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:33 INFO - 'HOME': '/Users/cltbld', 08:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:33 INFO - 'LOGNAME': 'cltbld', 08:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:33 INFO - 'MOZ_NO_REMOTE': '1', 08:09:33 INFO - 'NO_EM_RESTART': '1', 08:09:33 INFO - 'PAGER': '/bin/cat', 08:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:33 INFO - 'PWD': '/builds/slave/test', 08:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:33 INFO - 'SHELL': '/bin/bash', 08:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:09:33 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:33 INFO - 'USER': 'cltbld', 08:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:33 INFO - 'XPC_FLAGS': '0x0', 08:09:33 INFO - 'XPC_SERVICE_NAME': '0', 08:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:33 INFO - Cleaning up... 08:09:33 INFO - Return code: 0 08:09:33 INFO - Running post-action listener: _resource_record_post_action 08:09:33 INFO - Running post-action listener: _start_resource_monitoring 08:09:33 INFO - Starting resource monitoring. 08:09:33 INFO - ##### 08:09:33 INFO - ##### Finished create-virtualenv step (success) 08:09:33 INFO - ##### 08:09:33 INFO - ##### 08:09:33 INFO - ##### Running install step. 08:09:33 INFO - ##### 08:09:33 INFO - Running pre-action listener: _resource_record_pre_action 08:09:33 INFO - Running main action method: install 08:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:34 INFO - Reading from file tmpfile_stdout 08:09:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:34 INFO - Reading from file tmpfile_stdout 08:09:34 INFO - Output received: 08:09:34 INFO - Usage: mozinstall [options] installer 08:09:34 INFO - Options: 08:09:34 INFO - -h, --help show this help message and exit 08:09:34 INFO - -d DEST, --destination=DEST 08:09:34 INFO - Directory to install application into. [default: 08:09:34 INFO - "/builds/slave/test"] 08:09:34 INFO - --app=APP Application being installed. [default: firefox] 08:09:34 INFO - mkdir: /builds/slave/test/build/application 08:09:34 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'] 08:09:34 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 08:10:08 INFO - Reading from file tmpfile_stdout 08:10:08 INFO - Output received: 08:10:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:10:08 INFO - Running post-action listener: _resource_record_post_action 08:10:08 INFO - ##### 08:10:08 INFO - ##### Finished install step (success) 08:10:08 INFO - ##### 08:10:08 INFO - ##### 08:10:08 INFO - ##### Running run-tests step. 08:10:08 INFO - ##### 08:10:08 INFO - Running pre-action listener: _resource_record_pre_action 08:10:08 INFO - Running main action method: run_tests 08:10:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:10:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:10:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:10:08 INFO - 2016-07-05 08:10:08.330 screenresolution[1650:7670] starting screenresolution argv=screenresolution get 08:10:08 INFO - 2016-07-05 08:10:08.333 screenresolution[1650:7670] Display 0: 1600x1200x32@60 08:10:08 INFO - 2016-07-05 08:10:08.338 screenresolution[1651:7672] starting screenresolution argv=screenresolution list 08:10:08 INFO - Available Modes on Display 0 08:10:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:10:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:10:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:10:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:10:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:10:08 INFO - Intel Iris: 08:10:08 INFO - Chipset Model: Intel Iris 08:10:08 INFO - Type: GPU 08:10:08 INFO - Bus: Built-In 08:10:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:10:08 INFO - Vendor: Intel (0x8086) 08:10:08 INFO - Device ID: 0x0a2e 08:10:08 INFO - Revision ID: 0x0009 08:10:08 INFO - Displays: 08:10:08 INFO - Display: 08:10:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:10:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:10:08 INFO - Display Serial Number: 1600x1200 60 08:10:08 INFO - Main Display: Yes 08:10:08 INFO - Mirror: Off 08:10:08 INFO - Online: Yes 08:10:08 INFO - Rotation: Supported 08:10:08 INFO - Return code: 0 08:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:08 INFO - Python 2.7.3 08:10:08 INFO - Return code: 0 08:10:08 INFO - grabbing minidump binary from tooltool 08:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:08 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 0x102763d30>, '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 0x1024c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10275bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:10:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:10:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:10:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:08 INFO - Return code: 0 08:10:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:10:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:10:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:08 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/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:10:08 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/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zHXfl6zZXY/Render', 08:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:08 INFO - 'HOME': '/Users/cltbld', 08:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:08 INFO - 'LOGNAME': 'cltbld', 08:10:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:08 INFO - 'MOZ_NO_REMOTE': '1', 08:10:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:08 INFO - 'NO_EM_RESTART': '1', 08:10:08 INFO - 'PAGER': '/bin/cat', 08:10:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:08 INFO - 'PWD': '/builds/slave/test', 08:10:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:08 INFO - 'SHELL': '/bin/bash', 08:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RXJNfv6aNm/Listeners', 08:10:08 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 08:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:08 INFO - 'USER': 'cltbld', 08:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:08 INFO - 'XPC_FLAGS': '0x0', 08:10:08 INFO - 'XPC_SERVICE_NAME': '0', 08:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:08 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/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:10:08 INFO - mozversion application_buildid: 20160705060223 08:10:08 INFO - mozversion application_changeset: 050c0ad48c7895091b0d9b40ae1a442151248e9a 08:10:08 INFO - mozversion application_display_name: Nightly 08:10:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:08 INFO - mozversion application_name: Firefox 08:10:08 INFO - mozversion application_remotingname: firefox 08:10:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:10:08 INFO - mozversion application_vendor: Mozilla 08:10:08 INFO - mozversion application_version: 50.0a1 08:10:08 INFO - mozversion platform_buildid: 20160705060223 08:10:08 INFO - mozversion platform_changeset: 050c0ad48c7895091b0d9b40ae1a442151248e9a 08:10:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:10:08 INFO - mozversion platform_version: 50.0a1 08:10:08 INFO - using testdate: 1467731408 08:10:08 INFO - actual date: 1467731408 08:10:08 INFO - starting webserver on 'localhost:49271' 08:10:08 INFO - SUITE-START | Running 2 tests 08:10:08 INFO - TEST-START | dromaeo_css 08:10:08 INFO - operating with platform_type : mac_ 08:10:08 INFO - Initialising browser for dromaeo_css test... 08:10:08 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpA4van2/profile http://localhost:49271/getInfo.html) 08:10:11 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 08:10:11 INFO - PROCESS | 1661 | colorDepth:24 08:10:11 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 08:10:11 INFO - PROCESS | 1661 | __metrics 08:10:11 INFO - PROCESS | 1661 | 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" 08:10:11 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:12 INFO - TEST-INFO | 1661: exit 0 08:10:12 INFO - Browser initialized. 08:10:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:12 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpA4van2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:24 INFO - PROCESS | 1663 | RSS: Main: 244973568 08:10:24 INFO - PROCESS | 1663 | 08:11:15 INFO - PROCESS | 1663 | 1467731475024 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:13:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 08:13:28 INFO - PROCESS | 1663 | RSS: Main: 384557056 08:13:28 INFO - PROCESS | 1663 | 08:16:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 08:16:31 INFO - PROCESS | 1663 | RSS: Main: 378568704 08:16:31 INFO - PROCESS | 1663 | 08:19:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 08:19:34 INFO - PROCESS | 1663 | RSS: Main: 372895744 08:19:34 INFO - PROCESS | 1663 | 08:22:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 08:22:37 INFO - PROCESS | 1663 | RSS: Main: 372928512 08:22:37 INFO - PROCESS | 1663 | 08:25:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 08:25:41 INFO - PROCESS | 1663 | RSS: Main: 341155840 08:25:41 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 08:28:44 INFO - PROCESS | 1663 | RSS: Main: 388481024 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | __start_tp_report 08:28:44 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 08:28:44 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 08:28:44 INFO - PROCESS | 1663 | |i|pagename|runs| 08:28:44 INFO - PROCESS | 1663 | |0;dojo.html;3353.7820041697287;3376.088456116847;3391.05050585836;3407.693307602315;3451.965480345197;5624.465675760796;5711.914321285174;5721.799737009205;5869.207656966309;5892.941070589292;5767.884642307162;5772.5670574706955;5782.739776710047;5782.884342313162;5830.475257226849;5174.922376164361;5220.138677118271;5226;5234.581233501311;5299.28459657947;5181.896362072756;5204.271402003723;5217.765200565984;5247.947520524784;5252.5010124038345;5236.240745091959;5239.21411788231;5240.423553409122;5260.658057226268;5272.894542109156;5294.999999999981;5317.361916569997;5320.414754377015;5329.893402131975;5370.677759334452;5141.691498510064;5142.768575414116;5177.922331165036;5245.711485868275;5248.527632513054;5712.971435142839;5736.684482353469;5772.30732312121;5787.73955172014;5799.594028418012;6274.466670333027;6301.306856245809;6308.873822523569;6311.147995020659;6313.621182729051;5455.481729235717;5513.669179849222;6233.532485063593;6280.214973128359;6288.9056664150075;5924.496417804535;5929.080992446177;5938.940610593925;5939.970300148558;5950.464458198783;5993.760249589967;6247.5939063960695;6255.74977000924;6261.405166509175;6273.215848018997;6065.733681046303;6086.087086936906;6100.3086879273915;6124.716609780976;6220.782272620437;6263.655498947602;6270.216222972129;6283.08895210192;6287;6289.245290565162;6206.131141640174;6249.78125765596;6250.749970001149;6251;6261.373862613702;6148.508119350441;6174.9073763893575;6210.875782484325;6250.312465628777;6259.186305780219;4954.281629163751;4959.008198360342;4971.726555039508;4980.77586508608;5016.272640467112;4476.239039363316;4476.37330773692;4479.238529450001;4485.663575231871;4534.818607255739;5690.7439165237665;5826.475617194473;5859.941400586024;5871.941280587225;5877.177195192677;6209.5032397408095;6245.156903818017;6277.058441233851;6294.842628934313;6303.9684801575695;5771.94228057714;5815.76736930518;5823.767049317979;5834.445727655866;5879.088741245114;5457.154141108134;5463;5473.31583552056;5482.972585137129;5487.75305111271;6130.3369889931655;6184.845378865564;6232.844178895564;6238.500919926304;6307.526935479766;6282.308946016026;6282.842928926813;6283.71723272463;6285.371462853678;6291.433770960635;6143.665407145256;6241.8140553294725;6284.842878928063;6297.4647154992335;6317.778877739257;6168.660723660242;6174.38256174379;6231.283402408781;6258.9374106260175;6271.498280137669;6254.906176407449;6270.2475702915945;6272.686365681789;6277.686115694289;6289.088082228142;6059.666718330534;6126.387361263838;6191.4118158774845;6194.938050619436;6210.627362358273;6032.638041717511;6102.822530595962;6174.6107125896315;6201.410865967726;6228.0969259456215;6046.885704923865;6059.394060593905;6067.979243737191;6079.260106409498;6122.693865306628;5926.881462370815;6071.817845464643;6088.939110608837;6189.288231853215;6211.409916057967;5993.0710739835395;6055.939440605537;6079.848003799941;6086.786962456293;6102.993006154113 08:28:44 INFO - PROCESS | 1663 | |1;ext.html;472.6195412692781;478.41872125367695;523.471293993067;539.0136051026617;563.4224919457554;24448.75551244489;30935.226619334528;32151.19622009451;41469.17061658765;42532;44352;44625.107497850026;44762.77618611902;44829.77585112078;44850.878728031734;9659.903400966006;9812.165965892907;9816.803663926752;9821.803563928717;9836.852447213298;8787.604557794883;8989.146031127066;9664.081912218364;11693.356865372401;11900.464479098462;11972.401379931012;12044.156909016372;12044.277343359427;12064.396780161002;12069.215500992408;8847.513386763725;11840.58557950472;11916.880831191664;11919;11925.105617078667;11564.653060408116;11849.289042657469;11870.762584748343;12014.038876889828;12045.638630841002;41841.79079104615;42197.57802421967;42200;42203.15593688109;42323;3506.211102501942;3557.3063252665743;3686.207465394926;3975.4434379186937;4119.258533463975;31176.908808191605;32333.676663233302;32656.510152347735;32668.673313267038;32838.507422388684;3016.3213277012715;3252.96747032529;3354.077628652116;3369.646187150363;3431.8627254909775;481285.5935720334;547416;548492;548733;551764;54432.45567544274;63421.682891585246;63625;63787.6810615944;63807;65594.67202664052;65612.67193664;65751.67124164444;65842.01236981449;65896.67051664711;15129.319180636898;17038.06290654026;17048.48854534366;17054;17067.573310667085;11312.151588630886;12065.638030859089;12080.275183489019;13067;13126.540571079966;14904.403823846924;15015.849841501446;15037.624059398602;15051.623709407133;16715.916420418063;6419.486441084702;6644.940068578756;6983.546069505466;7281.708731650675;7402.185759566443;911.8085202107632;959.467495539982;962.6245764151986;989.6536212325773;1110.4225802582612;30892.22769430782;30974.22564435907;30978.53532197019;31723.52414713781;31797.04608861738;1144.730988217768;1151.7005578549638;1182.7457096724245;1184.3683285975133;1217.8721234270274;15754.527364179094;15807.958434291526;16126.919365403333;16207.027578345336;16407.42574009904;558000;977515;981571;983921;1001147;50650;51269.230961535606;61429.69285153546;61946.070808937904;61959.69020154871;1421.104704036471;1434.5911415246605;1459.5037687186407;1460.4304321314482;1463.0928824129107;30420.087397378113;31057;31793;32379.51430728494;33010.17474563059;53232.73383633057;53565;53590;53918.73040634772;53920.65198369915;576365;578019;579778;580743;581302;26645.600315995664;26913;27020.72979270261;28003.719962800926;41563.96090097772;48967.26549101695;49598.75200623974;49717.00565988732;50302.49697502978;50754.49245507498;32521.837390812896;39973.60026399699;40865.59134408737;41547.37678934758;42122.57877421186;40392.79803600963;40753.59246407498;40954.77135685934;41713.16573668449;42995.71012869619;39350.40974385444;39840.402393964694;40104.79685609436;40123.79938100291;40242.59757402389;33820.492692609136;35533.82233088818;36062.639373605925;36298.63701362952;36616.26767464689;22460.550788984456;23822.88088559546;24754.381140471633;25750.613740794277;25999.74000259973 08:28:44 INFO - PROCESS | 1663 | |2;jquery.html;360.8466401779243;385.6895199364511;396.90077480629844;397.16000658607055;416.31308341236956;15613.98509096908;15755.921220393897;20645.17419303226;20891.791082089174;20894.477638059056;17819.64360712785;20974.265900693477;21057.05243264053;21414.678779818314;21945;5513.889722205554;5552.361478429992;5965.582409231356;6081.812068108486;6220.688965551727;6133;6160.691965401712;6211.254649442073;6224.782132625359;6251.781187658433;5871.970640146793;6111.51107911366;6114.755409783604;6118.204633397652;6174.783882564111;5839.386864379221;6106.3893610639025;6118.510519158479;6130.1111338855835;6139.10982907476;5302.708351040691;5312.203169524563;5323;5324.1215199492035;5328.387235467893;22453.550928981327;24857;26605.467890642078;26875.790589423523;27221.45557088867;2126.223928266187;2230.018791731633;2232.821374290053;2261.807746341563;2878.409925965193;10298.536565854554;10533.525991330409;10538.683839484827;10573.73565660857;13701.040927135104;1767.54043948573;1870.4762666453414;1877.9342723004766;1878.4646375782836;1908.761404824397;105110.47444762728;119272.40363798126;119419.99999999913;119975.99999999913;121416;11493.367864767351;11528.365939873387;11598.826017609743;11636.67266546694;11779.293242405312;12481;14726;14843.257837108102;14864.479743208936;14864.70270594582;8586.65653373858;8751.606177722018;8753.343499237582;8829.69096081634;8853.955730221436;7132.714691412285;7629.427792915553;8351.8329633407;8868;8872.689455869013;4522.909541809146;4580.1755683976535;4592.265237561974;4643.326717625925;4644.767761611974;1659.751037344408;1858.3774435563967;1910.961780764377;1911.445680752594;1919.2227148005081;718.5509554140107;825.8637324841454;937.9624815007323;945.0596656326861;953.3374304858057;20900.895495522425;21968.89015554944;21975.560488790135;22078.33764987053;22158.002889869993;947.3699989507038;1010.4644538394663;1021.5096753558333;1052.5263631365915;1070.8340207267886;10939;11404.657860264206;11408.88591114095;11417.429128543707;11440.656780296438;609868;613201.6699582457;621331.8933405305;621667;623715.0513979481;63778.68110659417;105714;124069;135642.94070008124;139288;973.7468258252906;993.7167907146429;1017.2878984710732;1018.1040684197859;1021.0504231065181;19656.90171549133;19925.302614408425;19989.900050499655;20062.495312851304;20074.598508029467;47627.76186119047;58008.709956449944;58655;60685.69657151686;61474.692626536584;78181.60909195417;85445.29109417902;86302.13697862941;86814;89937;8207.138250483613;8275.710350137717;8327.791805204675;8361.916380836357;8393.958030210055;12924.612261632166;13467.932660336635;13911.165330080228;13918.791218131939;13987.090839095426;11554.711132221762;11610.361430121424;11839;11880.405979700807;12035.75928481408;11599.884001160219;11619.128565357463;11670.533178673099;11685.883141168479;11815.468303926173;11146.892739990635;11613.825792613286;11903.880961190624;12081.516739330329;12082;7218.458615603956;8385.874211886949;8460.407771456184;8494.447860889022;8594.183552562497;8441.95779021101;11046.061084807881;11147.331160130418;11419.37193454368;11641.6507504775 08:28:44 INFO - PROCESS | 1663 | |3;mootools.html;1557.042418912369;1581.5966928433247;1796.9281228750851;1908.3320837706797;1931.6716158253096;8580.74257772267;8839.91160088399;9018.413803102794;9029.277657787377;9064.90935090648;7807.648655810488;8071.273585377315;8545.359098067638;8796.47221166729;8832.558372081403;2355.1168311883002;2381.9642705359433;2384.3681424422543;2384.5350156719446;2390.426297688551;2125.3305208859238;2353.95292094158;2400.0879665726998;2401.9759802402014;2406.242033759369;1809.8190180981928;2185.9344219673435;2301.5166814968875;2368.834181607288;2374.1453076892303;2353.2469609724894;2359.091749676378;2378.001239479423;2380.9047638094457;2383.1182462488905;2363.066588697472;2378.3459548624096;2379.119725701484;2384.141708984764;2385.0579021286494;8837.116288371111;8884.2892568595;8895.688650897253;8898.73303800887;8902.020777714446;5248.21276808478;5397.298351214356;5401.081816091235;5410.3507579090365;5421.322334708161;3522.894313170609;3625.655562721537;3681.1717363593243;3704.0369503928905;3709.1283548366114;1039.8232300508855;1061.0556604621893;1064.5635289531256;1064.8243039898407;1079.5897558927636;10350.792984140351;11691.94154029233;11709.765804683944;11758;11766.294022358687;4538.818447262072;4591.701539399928;4732;4768.904621907543;4785.641076919245;9969.202463802878;9991.250656200815;9997.100260976547;10002.699919002442;10004.449755263386;5391.191321301758;5400.648957817808;5405.729713514309;5413.431589683105;5424.430434804368;4762.285657151455;4927.359443272351;4944.60443164546;4946.332245146931;4951.876203094879;3797.373433383516;3800;3853.344931361675;3875.6511913927884;3910.7458015228917;1109.6670998700358;1119.658504156224;1170.7716995186026;1180.3626041937257;1185.2769810415639;805.1948051948052;903.1961554216753;904.5206040798388;913.7898283394857;1011.9038691324313;5982.46157845796;6087.960533221332;6118.204633397719;6203.286622038523;6217.658028808459;994.3487016004528;1012.8328825743818;1077.7144056824948;1120.8710998235144;1124.173732306754;3865.2462769759627;4074.7351422157467;4142.937855932163;4147.6267135957905;4174.08170202555;10618.575256989789;10663.306885052447;10729.83905241422;10882.727931801768;10989.560417583367;9843.75390615226;10280.228982826318;10627.202959778047;10828.729281768019;10831.241813073168;8049.51702897828;8092.109867914407;8277.751667449986;8287.50274983503;8297.626606802709;5439.9456005441025;5991.7902873399225;6036.763751460273;6061.302950160788;6206.596571222856;9836.60653573849;9905.257105716955;9956.651517196864;10133.847992279974;10146.086852183338;10218.540165692413;10285.382877027403;10306.278560500694;10358.015988481082;10390.688279351632;7081.221065682874;7207.747728829466;7221.819454513469;7261.709531618676;7491.513051651626;8369.539675317672;8371.33029357662;8461.365397595328;8461.450005749606;8462.407631465738;7451.925480745123;7562.395008399205;7569.583672898044;7683.807904802201;7713.652885620048;7415.1101867776215;7432.405407567489;7487.438442116754;7513.624318784148;7604.8479030417975;7097.7160913562875;7105.573665580082;7151.964240178974;7153.996880873364;7164;4931.16170251051;5129.051125541787;5130.307408499804;5141.588672906084;5179.974100129475;5026.673266237683;5150.1459474589865;5255.343082114736;5300.893982120413;5318.361796584435 08:28:44 INFO - PROCESS | 1663 | |4;prototype.html;279.92022273652015;307.0894796927111;311.5280350269342;317.61885737115466;320.42003972809204;4380.299152135659;5072.568831649305;5299.947000529994;5371.361734670923;5387.245785590011;5304.602154838393;5314.202869569566;5329.521772375844;5360.115580929152;5373.382061062979;3178.9350567559895;3448.9480708383935;3823.674987626055;3951.170254246612;4103.38449232616;3732.9253414931686;3966.583508731585;4038.818253178599;4062.3906414037833;4078.3270760324513;3982.561918188997;4011.0546385003395;4016.4577781999346;4019.2668985090127;4030.2141082488924;3721.8511259549587;3783.39465685489;3935.4490371348033;3960.8415663373576;4017.517897852247;2958.9260268493244;3526.2771131917893;3529.694013215101;3530.5233793437815;3541.1585975292705;4763.5471181289695;5272.894542109137;5275.129603615399;5284.550813180885;5308.601854860863;4399.868003959887;4580.01529671119;4656.231721765905;4683.531646835323;4704.647151463654;5301.9926214019215;5529.225908372831;5622.662640241599;5647.011772939719;5657.623798004848;3466;3798.791066491342;3918.3142949983926;3924.156306394139;3935.567087620388;5599.356074051496;5751.511121554631;5922.3485416604135;5940.554458415593;5967;3331.5002749587757;3578.7673801202836;3795.1840354323954;3968.40473928913;3970.7021973352116;4030.8186131624147;4033.495813023372;4037.555868854424;4039.8990025249605;4041.8585349512628;3984.4820173377857;4084.8366065357054;4640;4673.953260467351;4704.15325241453;4859.635527335464;5301.708406037628;5635.633683810539;5669.6314739541795;5677.261955945701;1185.3184418959133;1329.7433924940838;1356.620146359021;1367.4188469900253;1375.8692924172187;825.0017478850538;843.6667516331015;852.577973902922;852.7612268564811;891.2068259249273;4545.727256364563;4552.453705555355;5280.260763493114;5294.364676238799;5323.015242180131;5156.241410845179;5164.321595481409;5772.826815195551;5842.883142337129;5844.795432159854;4383.540499997605;5152;5166.560842328444;5259.948620038188;5282.550983166474;2886.220720405479;2978.74680652147;3043.1174959261566;3049.557814116941;3067.6318841739135;5061.822836200715;5860.531157507389;5909.970450147722;5970.283565972111;5992.790252341147;5337.893242135136;5349.170878513836;5447.972760136253;5976.625376163507;6014.9699251504335;5916.290045194604;5916.704164791743;5954.464098231093;5961.926853166472;5962.612430192197;4708.482066972561;5026.416678746184;5194.662346947436;5207.479252074762;5800.055961945749;5737.414116177389;5768;5769.68266745333;5782.537397008314;5788.971055144697;5697.7436015380235;5962.284525856925;5962.612430192024;5964.5526585505395;5969.4777831652655;3182.220356012792;3473.496343030196;3813.9237215256094;3928.351821949461;3946.7567716169315;5811.418858114154;5855.882882342244;5875.3243377010485;5881.411858814085;5884.735186916513;5632.6338787980285;5661.820199223246;5672.347680016685;5672.829815105553;5680.517156041783;4700.952990470051;4937.35814344133;5291.365036195682;5678.5457163426;5688;4987.40151181846;5270.683758974474;5280.498352656491;5556.583256255716;5567;5091.71995540234;5462.8907421850545;5566.582506311962;5582.134769110794;5586.385497595343;5513.436252142613;5596.664200148004;5603.635763675348;5628.802991895264;5628.859278517906 08:28:44 INFO - PROCESS | 1663 | |5;yui.html;738.3281214095174;751.8834580640001;763.7403282883819;778.1129512355918;861.8879545659063;14911.478098266563;16197.757033644504;16248;16251.674966500663;16308.021518708856;12321.568745093924;14758.557243282692;14963.775543366859;14970.25148742564;14986.100833949971;713.9750108746182;728.406348825708;881.7707396077002;911.6945823149252;918.9724308270762;913.1142791492242;914.2457472585111;914.8719179314901;918.8346097702411;929.1173385283973;952.8380175370204;966.0387914025555;967.4340510801154;969.781799095205;969.962140509655;750.9249075092501;960.990390096097;962.93259471837;963.7638778499243;963.9132478077007;706.9505134640577;709.3792931185213;710.8969199466101;729.6351824087956;730.7661548304544;15022.774658380133;15030.549083527512;15091.24543772807;15110.697786044218;15118.09291442506;13915.860841391557;14171.362288697033;14270.429182832675;14279.643008924757;14353.138811671333;12792.872071279262;12862.035347348987;12950.287734174617;13020.414081366267;13355.332233388292;4562.087582483483;4615.769211539409;4682.41469816273;4746.264329029006;4800.495947925452;107748.461257694;108553;109514.45242773814;109678.45160774224;110024.34963475475;11158.721031974103;11165.609203677832;11217.04655104309;11271.38007409584;11310.151738619636;22191.890405479662;22239.221627243292;22243.443913902283;22250.777492225196;22267.443313916956;7984.600769961478;8056.154103819014;8083.83832323362;8116.188381161836;8190.8771368429525;4434.977825110918;4527.886802829956;4544.727316361029;4713.8350157745;4801.639877009238;3549.6627820357025;3691.5201023866725;3699.5375578052744;3701.7038636908983;3706.7961262130843;679.8402375441767;680.7685386968355;689.1179290508157;695.4540685561809;696.9686364113627;588.8822235552907;626.8526896179394;664.3721683009607;694.7394726977384;710.8018082322143;9117.498537580364;9378.202852757591;9416.62333506652;9485.649275478085;9620.230381569458;601.4797200421691;639.8560323927172;684.4387602166175;688.9345512176335;698.5983059740568;4514.593686568224;4577.656675749332;4581.587657110876;4675.976620116946;4728.692634978715;92013.07986920179;92173;92296.61555076679;119569;141774;76024.61987690027;77773.61113194398;78555;85089.14910850812;115040.42479787547;101699;105618;108874.45562772136;109239;111173.44413277882;9711;9927.751806204902;9934.950325248617;9961.452120133463;10036.698899033041;60501;61781.52873885174;61917.380826192966;62183;62916;92296;93886;94343;94776;95582.52208738912;13315.334233288491;13432.798508022583;13559.322033898068;13584.32078396096;13913.930430347784;14928.402863885323;15061.016374140598;15107.622309442351;15152.393904243707;15418.229088545751;13908;13982.65043373883;14468.710625787637;14535;14559.41762329495;13442.327883605976;13561.186328820302;13612.65968350799;13986.860131398556;14039;13622.86377136216;13824.239666818421;13845.446182152602;14436.566902992927;14581.854181458473;11160;11364.43177841088;11486.827697584376;11504;11774.882251177378;11144.2199046066;11313.321200727984;11446.198766086294;11623.941880290544;11634.185607007428 08:28:44 INFO - PROCESS | 1663 | __end_tp_report 08:28:44 INFO - PROCESS | 1663 | __start_cc_report 08:28:44 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1508 08:28:44 INFO - PROCESS | 1663 | __end_cc_report 08:28:44 INFO - PROCESS | 1663 | __startTimestamp1467732524774__endTimestamp 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | ------- Summary: start ------- 08:28:44 INFO - PROCESS | 1663 | Number of tests: 6 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5782.76 Median:6055.94 stddev:627.75 (10.4%) stddev-sans-first:600.06 08:28:44 INFO - PROCESS | 1663 | Values: 3353.8 3376.1 3391.1 3407.7 3452.0 5624.5 5711.9 5721.8 5869.2 5892.9 5767.9 5772.6 5782.7 5782.9 5830.5 5174.9 5220.1 5226.0 5234.6 5299.3 5181.9 5204.3 5217.8 5247.9 5252.5 5236.2 5239.2 5240.4 5260.7 5272.9 5295.0 5317.4 5320.4 5329.9 5370.7 5141.7 5142.8 5177.9 5245.7 5248.5 5713.0 5736.7 5772.3 5787.7 5799.6 6274.5 6301.3 6308.9 6311.1 6313.6 5455.5 5513.7 6233.5 6280.2 6288.9 5924.5 5929.1 5938.9 5940.0 5950.5 5993.8 6247.6 6255.7 6261.4 6273.2 6065.7 6086.1 6100.3 6124.7 6220.8 6263.7 6270.2 6283.1 6287.0 6289.2 6206.1 6249.8 6250.7 6251.0 6261.4 6148.5 6174.9 6210.9 6250.3 6259.2 4954.3 4959.0 4971.7 4980.8 5016.3 4476.2 4476.4 4479.2 4485.7 4534.8 5690.7 5826.5 5859.9 5871.9 5877.2 6209.5 6245.2 6277.1 6294.8 6304.0 5771.9 5815.8 5823.8 5834.4 5879.1 5457.2 5463.0 5473.3 5483.0 5487.8 6130.3 6184.8 6232.8 6238.5 6307.5 6282.3 6282.8 6283.7 6285.4 6291.4 6143.7 6241.8 6284.8 6297.5 6317.8 6168.7 6174.4 6231.3 6258.9 6271.5 6254.9 6270.2 6272.7 6277.7 6289.1 6059.7 6126.4 6191.4 6194.9 6210.6 6032.6 6102.8 6174.6 6201.4 6228.1 6046.9 6059.4 6068.0 6079.3 6122.7 5926.9 6071.8 6088.9 6189.3 6211.4 5993.1 6055.9 6079.8 6086.8 6103.0 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:79580.32 Median:21907.92 stddev:188304.16 (859.5%) stddev-sans-first:188738.73 08:28:44 INFO - PROCESS | 1663 | Values: 472.6 478.4 523.5 539.0 563.4 24448.8 30935.2 32151.2 41469.2 42532.0 44352.0 44625.1 44762.8 44829.8 44850.9 9659.9 9812.2 9816.8 9821.8 9836.9 8787.6 8989.1 9664.1 11693.4 11900.5 11972.4 12044.2 12044.3 12064.4 12069.2 8847.5 11840.6 11916.9 11919.0 11925.1 11564.7 11849.3 11870.8 12014.0 12045.6 41841.8 42197.6 42200.0 42203.2 42323.0 3506.2 3557.3 3686.2 3975.4 4119.3 31176.9 32333.7 32656.5 32668.7 32838.5 3016.3 3253.0 3354.1 3369.6 3431.9 481285.6 547416.0 548492.0 548733.0 551764.0 54432.5 63421.7 63625.0 63787.7 63807.0 65594.7 65612.7 65751.7 65842.0 65896.7 15129.3 17038.1 17048.5 17054.0 17067.6 11312.2 12065.6 12080.3 13067.0 13126.5 14904.4 15015.8 15037.6 15051.6 16715.9 6419.5 6644.9 6983.5 7281.7 7402.2 911.8 959.5 962.6 989.7 1110.4 30892.2 30974.2 30978.5 31723.5 31797.0 1144.7 1151.7 1182.7 1184.4 1217.9 15754.5 15808.0 16126.9 16207.0 16407.4 558000.0 977515.0 981571.0 983921.0 1001147.0 50650.0 51269.2 61429.7 61946.1 61959.7 1421.1 1434.6 1459.5 1460.4 1463.1 30420.1 31057.0 31793.0 32379.5 33010.2 53232.7 53565.0 53590.0 53918.7 53920.7 576365.0 578019.0 579778.0 580743.0 581302.0 26645.6 26913.0 27020.7 28003.7 41564.0 48967.3 49598.8 49717.0 50302.5 50754.5 32521.8 39973.6 40865.6 41547.4 42122.6 40392.8 40753.6 40954.8 41713.2 42995.7 39350.4 39840.4 40104.8 40123.8 40242.6 33820.5 35533.8 36062.6 36298.6 36616.3 22460.6 23822.9 24754.4 25750.6 25999.7 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35640.32 Median:12194.01 stddev:102798.99 (843.0%) stddev-sans-first:103053.24 08:28:44 INFO - PROCESS | 1663 | Values: 360.8 385.7 396.9 397.2 416.3 15614.0 15755.9 20645.2 20891.8 20894.5 17819.6 20974.3 21057.1 21414.7 21945.0 5513.9 5552.4 5965.6 6081.8 6220.7 6133.0 6160.7 6211.3 6224.8 6251.8 5872.0 6111.5 6114.8 6118.2 6174.8 5839.4 6106.4 6118.5 6130.1 6139.1 5302.7 5312.2 5323.0 5324.1 5328.4 22453.6 24857.0 26605.5 26875.8 27221.5 2126.2 2230.0 2232.8 2261.8 2878.4 10298.5 10533.5 10538.7 10573.7 13701.0 1767.5 1870.5 1877.9 1878.5 1908.8 105110.5 119272.4 119420.0 119976.0 121416.0 11493.4 11528.4 11598.8 11636.7 11779.3 12481.0 14726.0 14843.3 14864.5 14864.7 8586.7 8751.6 8753.3 8829.7 8854.0 7132.7 7629.4 8351.8 8868.0 8872.7 4522.9 4580.2 4592.3 4643.3 4644.8 1659.8 1858.4 1911.0 1911.4 1919.2 718.6 825.9 938.0 945.1 953.3 20900.9 21968.9 21975.6 22078.3 22158.0 947.4 1010.5 1021.5 1052.5 1070.8 10939.0 11404.7 11408.9 11417.4 11440.7 609868.0 613201.7 621331.9 621667.0 623715.1 63778.7 105714.0 124069.0 135642.9 139288.0 973.7 993.7 1017.3 1018.1 1021.1 19656.9 19925.3 19989.9 20062.5 20074.6 47627.8 58008.7 58655.0 60685.7 61474.7 78181.6 85445.3 86302.1 86814.0 89937.0 8207.1 8275.7 8327.8 8361.9 8394.0 12924.6 13467.9 13911.2 13918.8 13987.1 11554.7 11610.4 11839.0 11880.4 12035.8 11599.9 11619.1 11670.5 11685.9 11815.5 11146.9 11613.8 11903.9 12081.5 12082.0 7218.5 8385.9 8460.4 8494.4 8594.2 8442.0 11046.1 11147.3 11419.4 11641.7 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5757.37 Median:4937.88 stddev:3194.18 (64.7%) stddev-sans-first:3187.54 08:28:44 INFO - PROCESS | 1663 | Values: 1557.0 1581.6 1796.9 1908.3 1931.7 8580.7 8839.9 9018.4 9029.3 9064.9 7807.6 8071.3 8545.4 8796.5 8832.6 2355.1 2382.0 2384.4 2384.5 2390.4 2125.3 2354.0 2400.1 2402.0 2406.2 1809.8 2185.9 2301.5 2368.8 2374.1 2353.2 2359.1 2378.0 2380.9 2383.1 2363.1 2378.3 2379.1 2384.1 2385.1 8837.1 8884.3 8895.7 8898.7 8902.0 5248.2 5397.3 5401.1 5410.4 5421.3 3522.9 3625.7 3681.2 3704.0 3709.1 1039.8 1061.1 1064.6 1064.8 1079.6 10350.8 11691.9 11709.8 11758.0 11766.3 4538.8 4591.7 4732.0 4768.9 4785.6 9969.2 9991.3 9997.1 10002.7 10004.4 5391.2 5400.6 5405.7 5413.4 5424.4 4762.3 4927.4 4944.6 4946.3 4951.9 3797.4 3800.0 3853.3 3875.7 3910.7 1109.7 1119.7 1170.8 1180.4 1185.3 805.2 903.2 904.5 913.8 1011.9 5982.5 6088.0 6118.2 6203.3 6217.7 994.3 1012.8 1077.7 1120.9 1124.2 3865.2 4074.7 4142.9 4147.6 4174.1 10618.6 10663.3 10729.8 10882.7 10989.6 9843.8 10280.2 10627.2 10828.7 10831.2 8049.5 8092.1 8277.8 8287.5 8297.6 5439.9 5991.8 6036.8 6061.3 6206.6 9836.6 9905.3 9956.7 10133.8 10146.1 10218.5 10285.4 10306.3 10358.0 10390.7 7081.2 7207.7 7221.8 7261.7 7491.5 8369.5 8371.3 8461.4 8461.5 8462.4 7451.9 7562.4 7569.6 7683.8 7713.7 7415.1 7432.4 7487.4 7513.6 7604.8 7097.7 7105.6 7152.0 7154.0 7164.0 4931.2 5129.1 5130.3 5141.6 5180.0 5026.7 5150.1 5255.3 5300.9 5318.4 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4559.70 Median:5265.32 stddev:1419.12 (27.0%) stddev-sans-first:1386.26 08:28:44 INFO - PROCESS | 1663 | Values: 279.9 307.1 311.5 317.6 320.4 4380.3 5072.6 5299.9 5371.4 5387.2 5304.6 5314.2 5329.5 5360.1 5373.4 3178.9 3448.9 3823.7 3951.2 4103.4 3732.9 3966.6 4038.8 4062.4 4078.3 3982.6 4011.1 4016.5 4019.3 4030.2 3721.9 3783.4 3935.4 3960.8 4017.5 2958.9 3526.3 3529.7 3530.5 3541.2 4763.5 5272.9 5275.1 5284.6 5308.6 4399.9 4580.0 4656.2 4683.5 4704.6 5302.0 5529.2 5622.7 5647.0 5657.6 3466.0 3798.8 3918.3 3924.2 3935.6 5599.4 5751.5 5922.3 5940.6 5967.0 3331.5 3578.8 3795.2 3968.4 3970.7 4030.8 4033.5 4037.6 4039.9 4041.9 3984.5 4084.8 4640.0 4674.0 4704.2 4859.6 5301.7 5635.6 5669.6 5677.3 1185.3 1329.7 1356.6 1367.4 1375.9 825.0 843.7 852.6 852.8 891.2 4545.7 4552.5 5280.3 5294.4 5323.0 5156.2 5164.3 5772.8 5842.9 5844.8 4383.5 5152.0 5166.6 5259.9 5282.6 2886.2 2978.7 3043.1 3049.6 3067.6 5061.8 5860.5 5910.0 5970.3 5992.8 5337.9 5349.2 5448.0 5976.6 6015.0 5916.3 5916.7 5954.5 5961.9 5962.6 4708.5 5026.4 5194.7 5207.5 5800.1 5737.4 5768.0 5769.7 5782.5 5789.0 5697.7 5962.3 5962.6 5964.6 5969.5 3182.2 3473.5 3813.9 3928.4 3946.8 5811.4 5855.9 5875.3 5881.4 5884.7 5632.6 5661.8 5672.3 5672.8 5680.5 4701.0 4937.4 5291.4 5678.5 5688.0 4987.4 5270.7 5280.5 5556.6 5567.0 5091.7 5462.9 5566.6 5582.1 5586.4 5513.4 5596.7 5603.6 5628.8 5628.9 08:28:44 INFO - PROCESS | 1663 | 08:28:44 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:22733.88 Median:4521.24 stddev:33626.06 (743.7%) stddev-sans-first:33679.83 08:28:44 INFO - PROCESS | 1663 | Values: 738.3 751.9 763.7 778.1 861.9 14911.5 16197.8 16248.0 16251.7 16308.0 12321.6 14758.6 14963.8 14970.3 14986.1 714.0 728.4 881.8 911.7 919.0 913.1 914.2 914.9 918.8 929.1 952.8 966.0 967.4 969.8 970.0 750.9 961.0 962.9 963.8 963.9 707.0 709.4 710.9 729.6 730.8 15022.8 15030.5 15091.2 15110.7 15118.1 13915.9 14171.4 14270.4 14279.6 14353.1 12792.9 12862.0 12950.3 13020.4 13355.3 4562.1 4615.8 4682.4 4746.3 4800.5 107748.5 108553.0 109514.5 109678.5 110024.3 11158.7 11165.6 11217.0 11271.4 11310.2 22191.9 22239.2 22243.4 22250.8 22267.4 7984.6 8056.2 8083.8 8116.2 8190.9 4435.0 4527.9 4544.7 4713.8 4801.6 3549.7 3691.5 3699.5 3701.7 3706.8 679.8 680.8 689.1 695.5 697.0 588.9 626.9 664.4 694.7 710.8 9117.5 9378.2 9416.6 9485.6 9620.2 601.5 639.9 684.4 688.9 698.6 4514.6 4577.7 4581.6 4676.0 4728.7 92013.1 92173.0 92296.6 119569.0 141774.0 76024.6 77773.6 78555.0 85089.1 115040.4 101699.0 105618.0 108874.5 109239.0 111173.4 9711.0 9927.8 9935.0 9961.5 10036.7 60501.0 61781.5 61917.4 62183.0 62916.0 92296.0 93886.0 94343.0 94776.0 95582.5 13315.3 13432.8 13559.3 13584.3 13913.9 14928.4 15061.0 15107.6 15152.4 15418.2 13908.0 13982.7 14468.7 14535.0 14559.4 13442.3 13561.2 13612.7 13986.9 14039.0 13622.9 13824.2 13845.4 14436.6 14581.9 11160.0 11364.4 11486.8 11504.0 11774.9 11144.2 11313.3 11446.2 11623.9 11634.2 08:28:44 INFO - PROCESS | 1663 | -------- Summary: end -------- 08:28:44 INFO - PROCESS | 1663 | 08:28:45 INFO - TEST-INFO | 1663: exit 0 08:28:45 INFO - TEST-OK | dromaeo_css | took 1116432ms 08:28:45 INFO - TEST-START | kraken 08:28:45 INFO - operating with platform_type : mac_ 08:28:45 INFO - Initialising browser for kraken test... 08:28:45 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpfIUM9t/profile http://localhost:49271/getInfo.html) 08:28:47 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 08:28:47 INFO - PROCESS | 1670 | colorDepth:24 08:28:47 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 08:28:47 INFO - PROCESS | 1670 | __metrics 08:28:47 INFO - PROCESS | 1670 | 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" 08:28:47 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:48 INFO - TEST-INFO | 1670: exit 0 08:28:48 INFO - Browser initialized. 08:28:48 INFO - Running cycle 1/1 for kraken test... 08:28:48 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpfIUM9t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:00 INFO - PROCESS | 1671 | RSS: Main: 244027392 08:29:00 INFO - PROCESS | 1671 | 08:29:03 INFO - PROCESS | 1671 | 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) 08:29:04 INFO - PROCESS | 1671 | RSS: Main: 294555648 08:29:04 INFO - PROCESS | 1671 | 08:29:07 INFO - PROCESS | 1671 | 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) 08:29:07 INFO - PROCESS | 1671 | RSS: Main: 304549888 08:29:07 INFO - PROCESS | 1671 | 08:29:11 INFO - PROCESS | 1671 | 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) 08:29:11 INFO - PROCESS | 1671 | RSS: Main: 390246400 08:29:11 INFO - PROCESS | 1671 | 08:29:13 INFO - PROCESS | 1671 | 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) 08:29:14 INFO - PROCESS | 1671 | RSS: Main: 290283520 08:29:14 INFO - PROCESS | 1671 | 08:29:16 INFO - PROCESS | 1671 | 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) 08:29:17 INFO - PROCESS | 1671 | RSS: Main: 294195200 08:29:17 INFO - PROCESS | 1671 | 08:29:19 INFO - PROCESS | 1671 | 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) 08:29:20 INFO - PROCESS | 1671 | RSS: Main: 331841536 08:29:20 INFO - PROCESS | 1671 | 08:29:23 INFO - PROCESS | 1671 | 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) 08:29:24 INFO - PROCESS | 1671 | RSS: Main: 333049856 08:29:24 INFO - PROCESS | 1671 | 08:29:26 INFO - PROCESS | 1671 | 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) 08:29:27 INFO - PROCESS | 1671 | RSS: Main: 332091392 08:29:27 INFO - PROCESS | 1671 | 08:29:28 INFO - PROCESS | 1671 | 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) 08:29:29 INFO - PROCESS | 1671 | RSS: Main: 311894016 08:29:29 INFO - PROCESS | 1671 | 08:29:31 INFO - PROCESS | 1671 | 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) 08:29:32 INFO - PROCESS | 1671 | RSS: Main: 318533632 08:29:32 INFO - PROCESS | 1671 | 08:29:34 INFO - PROCESS | 1671 | 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) 08:29:35 INFO - PROCESS | 1671 | RSS: Main: 315838464 08:29:35 INFO - PROCESS | 1671 | 08:29:37 INFO - PROCESS | 1671 | 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) 08:29:38 INFO - PROCESS | 1671 | RSS: Main: 324689920 08:29:38 INFO - PROCESS | 1671 | 08:29:41 INFO - PROCESS | 1671 | 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) 08:29:42 INFO - PROCESS | 1671 | RSS: Main: 327180288 08:29:42 INFO - PROCESS | 1671 | 08:29:43 INFO - PROCESS | 1671 | 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) 08:29:43 INFO - PROCESS | 1671 | RSS: Main: 370900992 08:29:43 INFO - PROCESS | 1671 | 08:29:43 INFO - PROCESS | 1671 | __start_tp_report 08:29:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 08:29:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 08:29:43 INFO - PROCESS | 1671 | |i|pagename|runs| 08:29:43 INFO - PROCESS | 1671 | |0;ai-astar;102;113;113;112;112;112;113;113;118;156 08:29:43 INFO - PROCESS | 1671 | |1;audio-beat-detection;142;95;131;191;125;108;126;105;160;129 08:29:43 INFO - PROCESS | 1671 | |2;audio-dft;186;184;185;185;185;173;184;185;182;183 08:29:43 INFO - PROCESS | 1671 | |3;audio-fft;78;74;58;87;58;56;60;66;95;57 08:29:43 INFO - PROCESS | 1671 | |4;audio-oscillator;82;92;93;73;70;68;96;69;67;102 08:29:43 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;84;86;83;87;84;88;84;87;83 08:29:44 INFO - PROCESS | 1671 | |6;imaging-darkroom;93;93;94;94;94;92;94;94;106;132 08:29:44 INFO - PROCESS | 1671 | |7;imaging-desaturate;85;87;82;85;84;86;86;88;86;86 08:29:44 INFO - PROCESS | 1671 | |8;json-parse-financial;54;54;54;54;56;55;54;56;54;55 08:29:44 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;66;70;77;76;72;71;71;70;75;70 08:29:44 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;84;83;86;96;91;92;78;84;84;79 08:29:44 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;137;138;136;137;135;136;136;134;226;135 08:29:44 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;162;165;163;163;163;160;156;204;207;164 08:29:44 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;58;83;86;66;66;65;64;67;65;66 08:29:44 INFO - PROCESS | 1671 | __end_tp_report 08:29:44 INFO - PROCESS | 1671 | __start_cc_report 08:29:44 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2024 08:29:44 INFO - PROCESS | 1671 | __end_cc_report 08:29:44 INFO - PROCESS | 1671 | __startTimestamp1467732583996__endTimestamp 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | ------- Summary: start ------- 08:29:44 INFO - PROCESS | 1671 | Number of tests: 14 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:116.40 Median:113.00 stddev:14.46 (12.8%) stddev-sans-first:14.37 08:29:44 INFO - PROCESS | 1671 | Values: 102.0 113.0 113.0 112.0 112.0 112.0 113.0 113.0 118.0 156.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:136.50 stddev:28.14 (20.6%) stddev-sans-first:29.58 08:29:44 INFO - PROCESS | 1671 | Values: 142.0 95.0 131.0 191.0 125.0 108.0 126.0 105.0 160.0 129.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.20 Median:185.00 stddev:3.77 (2.0%) stddev-sans-first:3.86 08:29:44 INFO - PROCESS | 1671 | Values: 186.0 184.0 185.0 185.0 185.0 173.0 184.0 185.0 182.0 183.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:68.90 Median:70.00 stddev:13.95 (19.9%) stddev-sans-first:14.40 08:29:44 INFO - PROCESS | 1671 | Values: 78.0 74.0 58.0 87.0 58.0 56.0 60.0 66.0 95.0 57.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:77.50 stddev:13.44 (17.3%) stddev-sans-first:14.25 08:29:44 INFO - PROCESS | 1671 | Values: 82.0 92.0 93.0 73.0 70.0 68.0 96.0 69.0 67.0 102.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:2.01 (2.3%) stddev-sans-first:1.90 08:29:44 INFO - PROCESS | 1671 | Values: 88.0 84.0 86.0 83.0 87.0 84.0 88.0 84.0 87.0 83.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:98.60 Median:94.00 stddev:12.39 (13.2%) stddev-sans-first:12.98 08:29:44 INFO - PROCESS | 1671 | Values: 93.0 93.0 94.0 94.0 94.0 92.0 94.0 94.0 106.0 132.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.65 (1.9%) stddev-sans-first:1.74 08:29:44 INFO - PROCESS | 1671 | Values: 85.0 87.0 82.0 85.0 84.0 86.0 86.0 88.0 86.0 86.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 08:29:44 INFO - PROCESS | 1671 | Values: 54.0 54.0 54.0 54.0 56.0 55.0 54.0 56.0 54.0 55.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.50 stddev:3.33 (4.7%) stddev-sans-first:2.79 08:29:44 INFO - PROCESS | 1671 | Values: 66.0 70.0 77.0 76.0 72.0 71.0 71.0 70.0 75.0 70.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:5.72 (6.7%) stddev-sans-first:6.03 08:29:44 INFO - PROCESS | 1671 | Values: 84.0 83.0 86.0 96.0 91.0 92.0 78.0 84.0 84.0 79.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:136.50 stddev:28.48 (20.9%) stddev-sans-first:30.06 08:29:44 INFO - PROCESS | 1671 | Values: 137.0 138.0 136.0 137.0 135.0 136.0 136.0 134.0 226.0 135.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:163.50 stddev:18.52 (11.3%) stddev-sans-first:19.38 08:29:44 INFO - PROCESS | 1671 | Values: 162.0 165.0 163.0 163.0 163.0 160.0 156.0 204.0 207.0 164.0 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:66.00 stddev:8.77 (13.3%) stddev-sans-first:8.42 08:29:44 INFO - PROCESS | 1671 | Values: 58.0 83.0 86.0 66.0 66.0 65.0 64.0 67.0 65.0 66.0 08:29:44 INFO - PROCESS | 1671 | -------- Summary: end -------- 08:29:44 INFO - PROCESS | 1671 | 08:29:44 INFO - TEST-INFO | 1671: exit 0 08:29:44 INFO - TEST-OK | kraken | took 59427ms 08:29:44 INFO - SUITE-END | took 1175s 08:29:45 INFO - Completed test suite (00:19:36) 08:29:45 INFO - javascript benchmark 08:29:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.7820041697287, 3376.088456116847, 3391.05050585836, 3407.693307602315, 3451.965480345197, 5624.465675760796, 5711.914321285174, 5721.799737009205, 5869.207656966309, 5892.941070589292, 5767.884642307162, 5772.5670574706955, 5782.739776710047, 5782.884342313162, 5830.475257226849, 5174.922376164361, 5220.138677118271, 5226.0, 5234.581233501311, 5299.28459657947, 5181.896362072756, 5204.271402003723, 5217.765200565984, 5247.947520524784, 5252.5010124038345, 5236.240745091959, 5239.21411788231, 5240.423553409122, 5260.658057226268, 5272.894542109156, 5294.999999999981, 5317.361916569997, 5320.414754377015, 5329.893402131975, 5370.677759334452, 5141.691498510064, 5142.768575414116, 5177.922331165036, 5245.711485868275, 5248.527632513054, 5712.971435142839, 5736.684482353469, 5772.30732312121, 5787.73955172014, 5799.594028418012, 6274.466670333027, 6301.306856245809, 6308.873822523569, 6311.147995020659, 6313.621182729051, 5455.481729235717, 5513.669179849222, 6233.532485063593, 6280.214973128359, 6288.9056664150075, 5924.496417804535, 5929.080992446177, 5938.940610593925, 5939.970300148558, 5950.464458198783, 5993.760249589967, 6247.5939063960695, 6255.74977000924, 6261.405166509175, 6273.215848018997, 6065.733681046303, 6086.087086936906, 6100.3086879273915, 6124.716609780976, 6220.782272620437, 6263.655498947602, 6270.216222972129, 6283.08895210192, 6287.0, 6289.245290565162, 6206.131141640174, 6249.78125765596, 6250.749970001149, 6251.0, 6261.373862613702, 6148.508119350441, 6174.9073763893575, 6210.875782484325, 6250.312465628777, 6259.186305780219, 4954.281629163751, 4959.008198360342, 4971.726555039508, 4980.77586508608, 5016.272640467112, 4476.239039363316, 4476.37330773692, 4479.238529450001, 4485.663575231871, 4534.818607255739, 5690.7439165237665, 5826.475617194473, 5859.941400586024, 5871.941280587225, 5877.177195192677, 6209.5032397408095, 6245.156903818017, 6277.058441233851, 6294.842628934313, 6303.9684801575695, 5771.94228057714, 5815.76736930518, 5823.767049317979, 5834.445727655866, 5879.088741245114, 5457.154141108134, 5463.0, 5473.31583552056, 5482.972585137129, 5487.75305111271, 6130.3369889931655, 6184.845378865564, 6232.844178895564, 6238.500919926304, 6307.526935479766, 6282.308946016026, 6282.842928926813, 6283.71723272463, 6285.371462853678, 6291.433770960635, 6143.665407145256, 6241.8140553294725, 6284.842878928063, 6297.4647154992335, 6317.778877739257, 6168.660723660242, 6174.38256174379, 6231.283402408781, 6258.9374106260175, 6271.498280137669, 6254.906176407449, 6270.2475702915945, 6272.686365681789, 6277.686115694289, 6289.088082228142, 6059.666718330534, 6126.387361263838, 6191.4118158774845, 6194.938050619436, 6210.627362358273, 6032.638041717511, 6102.822530595962, 6174.6107125896315, 6201.410865967726, 6228.0969259456215, 6046.885704923865, 6059.394060593905, 6067.979243737191, 6079.260106409498, 6122.693865306628, 5926.881462370815, 6071.817845464643, 6088.939110608837, 6189.288231853215, 6211.409916057967, 5993.0710739835395, 6055.939440605537, 6079.848003799941, 6086.786962456293, 6102.993006154113], "value": 5742.762275325418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.6195412692781, 478.41872125367695, 523.471293993067, 539.0136051026617, 563.4224919457554, 24448.75551244489, 30935.226619334528, 32151.19622009451, 41469.17061658765, 42532.0, 44352.0, 44625.107497850026, 44762.77618611902, 44829.77585112078, 44850.878728031734, 9659.903400966006, 9812.165965892907, 9816.803663926752, 9821.803563928717, 9836.852447213298, 8787.604557794883, 8989.146031127066, 9664.081912218364, 11693.356865372401, 11900.464479098462, 11972.401379931012, 12044.156909016372, 12044.277343359427, 12064.396780161002, 12069.215500992408, 8847.513386763725, 11840.58557950472, 11916.880831191664, 11919.0, 11925.105617078667, 11564.653060408116, 11849.289042657469, 11870.762584748343, 12014.038876889828, 12045.638630841002, 41841.79079104615, 42197.57802421967, 42200.0, 42203.15593688109, 42323.0, 3506.211102501942, 3557.3063252665743, 3686.207465394926, 3975.4434379186937, 4119.258533463975, 31176.908808191605, 32333.676663233302, 32656.510152347735, 32668.673313267038, 32838.507422388684, 3016.3213277012715, 3252.96747032529, 3354.077628652116, 3369.646187150363, 3431.8627254909775, 481285.5935720334, 547416.0, 548492.0, 548733.0, 551764.0, 54432.45567544274, 63421.682891585246, 63625.0, 63787.6810615944, 63807.0, 65594.67202664052, 65612.67193664, 65751.67124164444, 65842.01236981449, 65896.67051664711, 15129.319180636898, 17038.06290654026, 17048.48854534366, 17054.0, 17067.573310667085, 11312.151588630886, 12065.638030859089, 12080.275183489019, 13067.0, 13126.540571079966, 14904.403823846924, 15015.849841501446, 15037.624059398602, 15051.623709407133, 16715.916420418063, 6419.486441084702, 6644.940068578756, 6983.546069505466, 7281.708731650675, 7402.185759566443, 911.8085202107632, 959.467495539982, 962.6245764151986, 989.6536212325773, 1110.4225802582612, 30892.22769430782, 30974.22564435907, 30978.53532197019, 31723.52414713781, 31797.04608861738, 1144.730988217768, 1151.7005578549638, 1182.7457096724245, 1184.3683285975133, 1217.8721234270274, 15754.527364179094, 15807.958434291526, 16126.919365403333, 16207.027578345336, 16407.42574009904, 558000.0, 977515.0, 981571.0, 983921.0, 1001147.0, 50650.0, 51269.230961535606, 61429.69285153546, 61946.070808937904, 61959.69020154871, 1421.104704036471, 1434.5911415246605, 1459.5037687186407, 1460.4304321314482, 1463.0928824129107, 30420.087397378113, 31057.0, 31793.0, 32379.51430728494, 33010.17474563059, 53232.73383633057, 53565.0, 53590.0, 53918.73040634772, 53920.65198369915, 576365.0, 578019.0, 579778.0, 580743.0, 581302.0, 26645.600315995664, 26913.0, 27020.72979270261, 28003.719962800926, 41563.96090097772, 48967.26549101695, 49598.75200623974, 49717.00565988732, 50302.49697502978, 50754.49245507498, 32521.837390812896, 39973.60026399699, 40865.59134408737, 41547.37678934758, 42122.57877421186, 40392.79803600963, 40753.59246407498, 40954.77135685934, 41713.16573668449, 42995.71012869619, 39350.40974385444, 39840.402393964694, 40104.79685609436, 40123.79938100291, 40242.59757402389, 33820.492692609136, 35533.82233088818, 36062.639373605925, 36298.63701362952, 36616.26767464689, 22460.550788984456, 23822.88088559546, 24754.381140471633, 25750.613740794277, 25999.74000259973], "value": 20970.43928331403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.8466401779243, 385.6895199364511, 396.90077480629844, 397.16000658607055, 416.31308341236956, 15613.98509096908, 15755.921220393897, 20645.17419303226, 20891.791082089174, 20894.477638059056, 17819.64360712785, 20974.265900693477, 21057.05243264053, 21414.678779818314, 21945.0, 5513.889722205554, 5552.361478429992, 5965.582409231356, 6081.812068108486, 6220.688965551727, 6133.0, 6160.691965401712, 6211.254649442073, 6224.782132625359, 6251.781187658433, 5871.970640146793, 6111.51107911366, 6114.755409783604, 6118.204633397652, 6174.783882564111, 5839.386864379221, 6106.3893610639025, 6118.510519158479, 6130.1111338855835, 6139.10982907476, 5302.708351040691, 5312.203169524563, 5323.0, 5324.1215199492035, 5328.387235467893, 22453.550928981327, 24857.0, 26605.467890642078, 26875.790589423523, 27221.45557088867, 2126.223928266187, 2230.018791731633, 2232.821374290053, 2261.807746341563, 2878.409925965193, 10298.536565854554, 10533.525991330409, 10538.683839484827, 10573.73565660857, 13701.040927135104, 1767.54043948573, 1870.4762666453414, 1877.9342723004766, 1878.4646375782836, 1908.761404824397, 105110.47444762728, 119272.40363798126, 119419.99999999913, 119975.99999999913, 121416.0, 11493.367864767351, 11528.365939873387, 11598.826017609743, 11636.67266546694, 11779.293242405312, 12481.0, 14726.0, 14843.257837108102, 14864.479743208936, 14864.70270594582, 8586.65653373858, 8751.606177722018, 8753.343499237582, 8829.69096081634, 8853.955730221436, 7132.714691412285, 7629.427792915553, 8351.8329633407, 8868.0, 8872.689455869013, 4522.909541809146, 4580.1755683976535, 4592.265237561974, 4643.326717625925, 4644.767761611974, 1659.751037344408, 1858.3774435563967, 1910.961780764377, 1911.445680752594, 1919.2227148005081, 718.5509554140107, 825.8637324841454, 937.9624815007323, 945.0596656326861, 953.3374304858057, 20900.895495522425, 21968.89015554944, 21975.560488790135, 22078.33764987053, 22158.002889869993, 947.3699989507038, 1010.4644538394663, 1021.5096753558333, 1052.5263631365915, 1070.8340207267886, 10939.0, 11404.657860264206, 11408.88591114095, 11417.429128543707, 11440.656780296438, 609868.0, 613201.6699582457, 621331.8933405305, 621667.0, 623715.0513979481, 63778.68110659417, 105714.0, 124069.0, 135642.94070008124, 139288.0, 973.7468258252906, 993.7167907146429, 1017.2878984710732, 1018.1040684197859, 1021.0504231065181, 19656.90171549133, 19925.302614408425, 19989.900050499655, 20062.495312851304, 20074.598508029467, 47627.76186119047, 58008.709956449944, 58655.0, 60685.69657151686, 61474.692626536584, 78181.60909195417, 85445.29109417902, 86302.13697862941, 86814.0, 89937.0, 8207.138250483613, 8275.710350137717, 8327.791805204675, 8361.916380836357, 8393.958030210055, 12924.612261632166, 13467.932660336635, 13911.165330080228, 13918.791218131939, 13987.090839095426, 11554.711132221762, 11610.361430121424, 11839.0, 11880.405979700807, 12035.75928481408, 11599.884001160219, 11619.128565357463, 11670.533178673099, 11685.883141168479, 11815.468303926173, 11146.892739990635, 11613.825792613286, 11903.880961190624, 12081.516739330329, 12082.0, 7218.458615603956, 8385.874211886949, 8460.407771456184, 8494.447860889022, 8594.183552562497, 8441.95779021101, 11046.061084807881, 11147.331160130418, 11419.37193454368, 11641.6507504775], "value": 9746.084153167742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.042418912369, 1581.5966928433247, 1796.9281228750851, 1908.3320837706797, 1931.6716158253096, 8580.74257772267, 8839.91160088399, 9018.413803102794, 9029.277657787377, 9064.90935090648, 7807.648655810488, 8071.273585377315, 8545.359098067638, 8796.47221166729, 8832.558372081403, 2355.1168311883002, 2381.9642705359433, 2384.3681424422543, 2384.5350156719446, 2390.426297688551, 2125.3305208859238, 2353.95292094158, 2400.0879665726998, 2401.9759802402014, 2406.242033759369, 1809.8190180981928, 2185.9344219673435, 2301.5166814968875, 2368.834181607288, 2374.1453076892303, 2353.2469609724894, 2359.091749676378, 2378.001239479423, 2380.9047638094457, 2383.1182462488905, 2363.066588697472, 2378.3459548624096, 2379.119725701484, 2384.141708984764, 2385.0579021286494, 8837.116288371111, 8884.2892568595, 8895.688650897253, 8898.73303800887, 8902.020777714446, 5248.21276808478, 5397.298351214356, 5401.081816091235, 5410.3507579090365, 5421.322334708161, 3522.894313170609, 3625.655562721537, 3681.1717363593243, 3704.0369503928905, 3709.1283548366114, 1039.8232300508855, 1061.0556604621893, 1064.5635289531256, 1064.8243039898407, 1079.5897558927636, 10350.792984140351, 11691.94154029233, 11709.765804683944, 11758.0, 11766.294022358687, 4538.818447262072, 4591.701539399928, 4732.0, 4768.904621907543, 4785.641076919245, 9969.202463802878, 9991.250656200815, 9997.100260976547, 10002.699919002442, 10004.449755263386, 5391.191321301758, 5400.648957817808, 5405.729713514309, 5413.431589683105, 5424.430434804368, 4762.285657151455, 4927.359443272351, 4944.60443164546, 4946.332245146931, 4951.876203094879, 3797.373433383516, 3800.0, 3853.344931361675, 3875.6511913927884, 3910.7458015228917, 1109.6670998700358, 1119.658504156224, 1170.7716995186026, 1180.3626041937257, 1185.2769810415639, 805.1948051948052, 903.1961554216753, 904.5206040798388, 913.7898283394857, 1011.9038691324313, 5982.46157845796, 6087.960533221332, 6118.204633397719, 6203.286622038523, 6217.658028808459, 994.3487016004528, 1012.8328825743818, 1077.7144056824948, 1120.8710998235144, 1124.173732306754, 3865.2462769759627, 4074.7351422157467, 4142.937855932163, 4147.6267135957905, 4174.08170202555, 10618.575256989789, 10663.306885052447, 10729.83905241422, 10882.727931801768, 10989.560417583367, 9843.75390615226, 10280.228982826318, 10627.202959778047, 10828.729281768019, 10831.241813073168, 8049.51702897828, 8092.109867914407, 8277.751667449986, 8287.50274983503, 8297.626606802709, 5439.9456005441025, 5991.7902873399225, 6036.763751460273, 6061.302950160788, 6206.596571222856, 9836.60653573849, 9905.257105716955, 9956.651517196864, 10133.847992279974, 10146.086852183338, 10218.540165692413, 10285.382877027403, 10306.278560500694, 10358.015988481082, 10390.688279351632, 7081.221065682874, 7207.747728829466, 7221.819454513469, 7261.709531618676, 7491.513051651626, 8369.539675317672, 8371.33029357662, 8461.365397595328, 8461.450005749606, 8462.407631465738, 7451.925480745123, 7562.395008399205, 7569.583672898044, 7683.807904802201, 7713.652885620048, 7415.1101867776215, 7432.405407567489, 7487.438442116754, 7513.624318784148, 7604.8479030417975, 7097.7160913562875, 7105.573665580082, 7151.964240178974, 7153.996880873364, 7164.0, 4931.16170251051, 5129.051125541787, 5130.307408499804, 5141.588672906084, 5179.974100129475, 5026.673266237683, 5150.1459474589865, 5255.343082114736, 5300.893982120413, 5318.361796584435], "value": 4636.997558516693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.92022273652015, 307.0894796927111, 311.5280350269342, 317.61885737115466, 320.42003972809204, 4380.299152135659, 5072.568831649305, 5299.947000529994, 5371.361734670923, 5387.245785590011, 5304.602154838393, 5314.202869569566, 5329.521772375844, 5360.115580929152, 5373.382061062979, 3178.9350567559895, 3448.9480708383935, 3823.674987626055, 3951.170254246612, 4103.38449232616, 3732.9253414931686, 3966.583508731585, 4038.818253178599, 4062.3906414037833, 4078.3270760324513, 3982.561918188997, 4011.0546385003395, 4016.4577781999346, 4019.2668985090127, 4030.2141082488924, 3721.8511259549587, 3783.39465685489, 3935.4490371348033, 3960.8415663373576, 4017.517897852247, 2958.9260268493244, 3526.2771131917893, 3529.694013215101, 3530.5233793437815, 3541.1585975292705, 4763.5471181289695, 5272.894542109137, 5275.129603615399, 5284.550813180885, 5308.601854860863, 4399.868003959887, 4580.01529671119, 4656.231721765905, 4683.531646835323, 4704.647151463654, 5301.9926214019215, 5529.225908372831, 5622.662640241599, 5647.011772939719, 5657.623798004848, 3466.0, 3798.791066491342, 3918.3142949983926, 3924.156306394139, 3935.567087620388, 5599.356074051496, 5751.511121554631, 5922.3485416604135, 5940.554458415593, 5967.0, 3331.5002749587757, 3578.7673801202836, 3795.1840354323954, 3968.40473928913, 3970.7021973352116, 4030.8186131624147, 4033.495813023372, 4037.555868854424, 4039.8990025249605, 4041.8585349512628, 3984.4820173377857, 4084.8366065357054, 4640.0, 4673.953260467351, 4704.15325241453, 4859.635527335464, 5301.708406037628, 5635.633683810539, 5669.6314739541795, 5677.261955945701, 1185.3184418959133, 1329.7433924940838, 1356.620146359021, 1367.4188469900253, 1375.8692924172187, 825.0017478850538, 843.6667516331015, 852.577973902922, 852.7612268564811, 891.2068259249273, 4545.727256364563, 4552.453705555355, 5280.260763493114, 5294.364676238799, 5323.015242180131, 5156.241410845179, 5164.321595481409, 5772.826815195551, 5842.883142337129, 5844.795432159854, 4383.540499997605, 5152.0, 5166.560842328444, 5259.948620038188, 5282.550983166474, 2886.220720405479, 2978.74680652147, 3043.1174959261566, 3049.557814116941, 3067.6318841739135, 5061.822836200715, 5860.531157507389, 5909.970450147722, 5970.283565972111, 5992.790252341147, 5337.893242135136, 5349.170878513836, 5447.972760136253, 5976.625376163507, 6014.9699251504335, 5916.290045194604, 5916.704164791743, 5954.464098231093, 5961.926853166472, 5962.612430192197, 4708.482066972561, 5026.416678746184, 5194.662346947436, 5207.479252074762, 5800.055961945749, 5737.414116177389, 5768.0, 5769.68266745333, 5782.537397008314, 5788.971055144697, 5697.7436015380235, 5962.284525856925, 5962.612430192024, 5964.5526585505395, 5969.4777831652655, 3182.220356012792, 3473.496343030196, 3813.9237215256094, 3928.351821949461, 3946.7567716169315, 5811.418858114154, 5855.882882342244, 5875.3243377010485, 5881.411858814085, 5884.735186916513, 5632.6338787980285, 5661.820199223246, 5672.347680016685, 5672.829815105553, 5680.517156041783, 4700.952990470051, 4937.35814344133, 5291.365036195682, 5678.5457163426, 5688.0, 4987.40151181846, 5270.683758974474, 5280.498352656491, 5556.583256255716, 5567.0, 5091.71995540234, 5462.8907421850545, 5566.582506311962, 5582.134769110794, 5586.385497595343, 5513.436252142613, 5596.664200148004, 5603.635763675348, 5628.802991895264, 5628.859278517906], "value": 4103.183491318504, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.3281214095174, 751.8834580640001, 763.7403282883819, 778.1129512355918, 861.8879545659063, 14911.478098266563, 16197.757033644504, 16248.0, 16251.674966500663, 16308.021518708856, 12321.568745093924, 14758.557243282692, 14963.775543366859, 14970.25148742564, 14986.100833949971, 713.9750108746182, 728.406348825708, 881.7707396077002, 911.6945823149252, 918.9724308270762, 913.1142791492242, 914.2457472585111, 914.8719179314901, 918.8346097702411, 929.1173385283973, 952.8380175370204, 966.0387914025555, 967.4340510801154, 969.781799095205, 969.962140509655, 750.9249075092501, 960.990390096097, 962.93259471837, 963.7638778499243, 963.9132478077007, 706.9505134640577, 709.3792931185213, 710.8969199466101, 729.6351824087956, 730.7661548304544, 15022.774658380133, 15030.549083527512, 15091.24543772807, 15110.697786044218, 15118.09291442506, 13915.860841391557, 14171.362288697033, 14270.429182832675, 14279.643008924757, 14353.138811671333, 12792.872071279262, 12862.035347348987, 12950.287734174617, 13020.414081366267, 13355.332233388292, 4562.087582483483, 4615.769211539409, 4682.41469816273, 4746.264329029006, 4800.495947925452, 107748.461257694, 108553.0, 109514.45242773814, 109678.45160774224, 110024.34963475475, 11158.721031974103, 11165.609203677832, 11217.04655104309, 11271.38007409584, 11310.151738619636, 22191.890405479662, 22239.221627243292, 22243.443913902283, 22250.777492225196, 22267.443313916956, 7984.600769961478, 8056.154103819014, 8083.83832323362, 8116.188381161836, 8190.8771368429525, 4434.977825110918, 4527.886802829956, 4544.727316361029, 4713.8350157745, 4801.639877009238, 3549.6627820357025, 3691.5201023866725, 3699.5375578052744, 3701.7038636908983, 3706.7961262130843, 679.8402375441767, 680.7685386968355, 689.1179290508157, 695.4540685561809, 696.9686364113627, 588.8822235552907, 626.8526896179394, 664.3721683009607, 694.7394726977384, 710.8018082322143, 9117.498537580364, 9378.202852757591, 9416.62333506652, 9485.649275478085, 9620.230381569458, 601.4797200421691, 639.8560323927172, 684.4387602166175, 688.9345512176335, 698.5983059740568, 4514.593686568224, 4577.656675749332, 4581.587657110876, 4675.976620116946, 4728.692634978715, 92013.07986920179, 92173.0, 92296.61555076679, 119569.0, 141774.0, 76024.61987690027, 77773.61113194398, 78555.0, 85089.14910850812, 115040.42479787547, 101699.0, 105618.0, 108874.45562772136, 109239.0, 111173.44413277882, 9711.0, 9927.751806204902, 9934.950325248617, 9961.452120133463, 10036.698899033041, 60501.0, 61781.52873885174, 61917.380826192966, 62183.0, 62916.0, 92296.0, 93886.0, 94343.0, 94776.0, 95582.52208738912, 13315.334233288491, 13432.798508022583, 13559.322033898068, 13584.32078396096, 13913.930430347784, 14928.402863885323, 15061.016374140598, 15107.622309442351, 15152.393904243707, 15418.229088545751, 13908.0, 13982.65043373883, 14468.710625787637, 14535.0, 14559.41762329495, 13442.327883605976, 13561.186328820302, 13612.65968350799, 13986.860131398556, 14039.0, 13622.86377136216, 13824.239666818421, 13845.446182152602, 14436.566902992927, 14581.854181458473, 11160.0, 11364.43177841088, 11486.827697584376, 11504.0, 11774.882251177378, 11144.2199046066, 11313.321200727984, 11446.198766086294, 11623.941880290544, 11634.185607007428], "value": 7930.764391055774, "unit": "score"}], "name": "dromaeo_css", "value": 7493.990441637796, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 113.0, 118.0, 156.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 95.0, 131.0, 191.0, 125.0, 108.0, 126.0, 105.0, 160.0, 129.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 185.0, 185.0, 173.0, 184.0, 185.0, 182.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 58.0, 87.0, 58.0, 56.0, 60.0, 66.0, 95.0, 57.0], "value": 68.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 92.0, 93.0, 73.0, 70.0, 68.0, 96.0, 69.0, 67.0, 102.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 86.0, 83.0, 87.0, 84.0, 88.0, 84.0, 87.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 92.0, 94.0, 94.0, 106.0, 132.0], "value": 98.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 82.0, 85.0, 84.0, 86.0, 86.0, 88.0, 86.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 56.0, 55.0, 54.0, 56.0, 54.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 77.0, 76.0, 72.0, 71.0, 71.0, 70.0, 75.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 86.0, 96.0, 91.0, 92.0, 78.0, 84.0, 84.0, 79.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 136.0, 137.0, 135.0, 136.0, 136.0, 134.0, 226.0, 135.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 163.0, 163.0, 160.0, 156.0, 204.0, 207.0, 164.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 83.0, 86.0, 66.0, 66.0, 65.0, 64.0, 67.0, 65.0, 66.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1446.8, "alertThreshold": 2.0}]} 08:29:45 INFO - Return code: 0 08:29:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:45 INFO - # TBPL SUCCESS # 08:29:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:29:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:29:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:29:45 INFO - 2016-07-05 08:29:45.291 screenresolution[1675:9777] starting screenresolution argv=screenresolution get 08:29:45 INFO - 2016-07-05 08:29:45.293 screenresolution[1675:9777] Display 0: 1600x1200x32@60 08:29:45 INFO - 2016-07-05 08:29:45.299 screenresolution[1676:9780] starting screenresolution argv=screenresolution list 08:29:45 INFO - Available Modes on Display 0 08:29:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:29:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:29:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:29:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:29:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:29:45 INFO - Intel Iris: 08:29:45 INFO - Chipset Model: Intel Iris 08:29:45 INFO - Type: GPU 08:29:45 INFO - Bus: Built-In 08:29:45 INFO - VRAM (Dynamic, Max): 1536 MB 08:29:45 INFO - Vendor: Intel (0x8086) 08:29:45 INFO - Device ID: 0x0a2e 08:29:45 INFO - Revision ID: 0x0009 08:29:45 INFO - Displays: 08:29:45 INFO - Display: 08:29:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:29:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:29:45 INFO - Display Serial Number: 1600x1200 60 08:29:45 INFO - Main Display: Yes 08:29:45 INFO - Mirror: Off 08:29:45 INFO - Online: Yes 08:29:45 INFO - Rotation: Supported 08:29:45 INFO - Return code: 0 08:29:45 INFO - Running post-action listener: _resource_record_post_action 08:29:45 INFO - ##### 08:29:45 INFO - ##### Finished run-tests step (success) 08:29:45 INFO - ##### 08:29:45 INFO - Running post-run listener: _resource_record_post_run 08:29:45 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32763392; Write bytes: 702575616; Read time: 322; Write time: 1813 08:29:45 INFO - TinderboxPrint: CPU usage
53.7% 08:29:45 INFO - TinderboxPrint: I/O read bytes / time
32,763,392 / 322 08:29:45 INFO - TinderboxPrint: I/O write bytes / time
702,575,616 / 1,813 08:29:45 INFO - TinderboxPrint: CPU idle
2,242.9 (46.3%) 08:29:45 INFO - TinderboxPrint: CPU system
967.0 (20.0%) 08:29:45 INFO - TinderboxPrint: CPU user
1,635.7 (33.8%) 08:29:45 INFO - TinderboxPrint: Swap in / out
435,568,640 / 0 08:29:45 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 400695808; Write bytes: 391894528; Read time: 29526; Write time: 695 08:29:45 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30793216; Write bytes: 292847104; Read time: 300; Write time: 1077 08:29:46 INFO - Running post-run listener: _upload_blobber_files 08:29:46 INFO - Blob upload gear active. 08:29:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:46 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 08:29:46 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'] 08:29:46 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 08:29:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:47 INFO - (blobuploader) - INFO - Done attempting. 08:29:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:48 INFO - (blobuploader) - INFO - Done attempting. 08:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:51 INFO - (blobuploader) - INFO - Done attempting. 08:29:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:51 INFO - Return code: 0 08:29:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/972149e42feb3e1e09a6e204ceff8f3679524f87fa4d978786bbbfbea96c59c8ea19a220bbad7e707197644a1dcd0434b7516c1029d42f5c76a19ff8381b8775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5ed7c6b11efe306c368d997c80736df79d29f279110b176f1e746b374589210eddd640b20945a5040c81d2fd99da22e73ccf6d618835a67fa50f897965714b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309239976eb57cb2cce1be3bd2763408ca074fa90c1584814c35f5deffb8ce33d409ab402830df483d59404f1ae6360701de28f21dc934d9cb94affe65f2f092"} 08:29:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:51 INFO - Contents: 08:29:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/972149e42feb3e1e09a6e204ceff8f3679524f87fa4d978786bbbfbea96c59c8ea19a220bbad7e707197644a1dcd0434b7516c1029d42f5c76a19ff8381b8775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5ed7c6b11efe306c368d997c80736df79d29f279110b176f1e746b374589210eddd640b20945a5040c81d2fd99da22e73ccf6d618835a67fa50f897965714b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309239976eb57cb2cce1be3bd2763408ca074fa90c1584814c35f5deffb8ce33d409ab402830df483d59404f1ae6360701de28f21dc934d9cb94affe65f2f092"} 08:29:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:51 INFO - Copying logs to upload dir... 08:29:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.872652 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-05 08:29:52.071730) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:29:52.075079) ========= 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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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/972149e42feb3e1e09a6e204ceff8f3679524f87fa4d978786bbbfbea96c59c8ea19a220bbad7e707197644a1dcd0434b7516c1029d42f5c76a19ff8381b8775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5ed7c6b11efe306c368d997c80736df79d29f279110b176f1e746b374589210eddd640b20945a5040c81d2fd99da22e73ccf6d618835a67fa50f897965714b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309239976eb57cb2cce1be3bd2763408ca074fa90c1584814c35f5deffb8ce33d409ab402830df483d59404f1ae6360701de28f21dc934d9cb94affe65f2f092"} build_url:https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010928 build_url: 'https://queue.taskcluster.net/v1/task/AANkf_tPSRCGas-vaSkIMg/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/972149e42feb3e1e09a6e204ceff8f3679524f87fa4d978786bbbfbea96c59c8ea19a220bbad7e707197644a1dcd0434b7516c1029d42f5c76a19ff8381b8775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5ed7c6b11efe306c368d997c80736df79d29f279110b176f1e746b374589210eddd640b20945a5040c81d2fd99da22e73ccf6d618835a67fa50f897965714b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309239976eb57cb2cce1be3bd2763408ca074fa90c1584814c35f5deffb8ce33d409ab402830df483d59404f1ae6360701de28f21dc934d9cb94affe65f2f092"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:29:52.107219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:29:52.107526) ========= 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.zHXfl6zZXY/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.RXJNfv6aNm/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005052 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:29:52.156634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:29:52.157011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:29:52.157352) ========= ========= Total master_lag: 0.45 =========