builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0115 starttime: 1461410956.52 results: success (0) buildid: 20160423024847 builduid: 0b56103f51b843b3a3ea6e70d15b86ed revision: ad71189f79aa732acb0ad2518d33d46387386045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:16.524848) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:16.525278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:16.525569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:16.628204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:16.628560) ========= 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.N3Uovh4q97/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.8lsmCQThTr/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-04-23 04:29:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.38M=0.001s 2016-04-23 04:29:17 (9.38 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.461325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:17.108647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:17.108956) ========= 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.N3Uovh4q97/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.8lsmCQThTr/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.027610 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:17.162825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 04:29:17.163173) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad71189f79aa732acb0ad2518d33d46387386045 --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 ad71189f79aa732acb0ad2518d33d46387386045 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N3Uovh4q97/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.8lsmCQThTr/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-04-23 04:29:17,243 truncating revision to first 12 chars 2016-04-23 04:29:17,243 Setting DEBUG logging. 2016-04-23 04:29:17,243 attempt 1/10 2016-04-23 04:29:17,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad71189f79aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 04:29:18,369 unpacking tar archive at: fx-team-ad71189f79aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 04:29:18.553004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:18.553330) ========= script_repo_revision: ad71189f79aa732acb0ad2518d33d46387386045 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:18.553724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:18.553984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 04:29:18.574169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-23 04:29:18.574547) ========= /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.N3Uovh4q97/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.8lsmCQThTr/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:29:18 INFO - MultiFileLogger online at 20160423 04:29:18 in /builds/slave/test 04:29:18 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 04:29:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:18 INFO - {'append_to_log': False, 04:29:18 INFO - 'base_work_dir': '/builds/slave/test', 04:29:18 INFO - 'blob_upload_branch': 'Fx-Team', 04:29:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:18 INFO - 'branch': 'Fx-Team', 04:29:18 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:18 INFO - 'config_files': ('talos/mac_config.py',), 04:29:18 INFO - 'default_actions': ('clobber', 04:29:18 INFO - 'read-buildbot-config', 04:29:18 INFO - 'download-and-extract', 04:29:18 INFO - 'populate-webroot', 04:29:18 INFO - 'create-virtualenv', 04:29:18 INFO - 'install', 04:29:18 INFO - 'run-tests'), 04:29:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:18 INFO - 'download_minidump_stackwalk': True, 04:29:18 INFO - 'download_symbols': 'ondemand', 04:29:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:18 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:18 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:18 INFO - 'installer_path': 'installer.exe', 04:29:18 INFO - 'log_level': 'info', 04:29:18 INFO - 'log_name': 'talos', 04:29:18 INFO - 'log_to_console': True, 04:29:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:29:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:29:18 INFO - 'opt_config_files': (), 04:29:18 INFO - 'pip_index': False, 04:29:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:18 INFO - 'cmd': ('bash', 04:29:18 INFO - '-c', 04:29:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:18 INFO - 'enabled': True, 04:29:18 INFO - 'halt_on_failure': False, 04:29:18 INFO - 'name': 'check_screen_resolution'},), 04:29:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:18 INFO - 'cmd': ('bash', 04:29:18 INFO - '-c', 04:29:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:18 INFO - 'enabled': True, 04:29:18 INFO - 'halt_on_failure': False, 04:29:18 INFO - 'name': 'check_screen_resolution'},), 04:29:18 INFO - 'run_cmd_checks_enabled': True, 04:29:18 INFO - 'sps_profile': False, 04:29:18 INFO - 'sps_profile_interval': 0, 04:29:18 INFO - 'suite': 'dromaeojs', 04:29:18 INFO - 'system_bits': '32', 04:29:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:18 INFO - 'title': 't-yosemite-r7-0115', 04:29:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:18 INFO - 'use_talos_json': True, 04:29:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:18 INFO - 'work_dir': 'build'} 04:29:18 INFO - ##### 04:29:18 INFO - ##### Running clobber step. 04:29:18 INFO - ##### 04:29:18 INFO - Running pre-action listener: _resource_record_pre_action 04:29:18 INFO - Running main action method: clobber 04:29:18 INFO - rmtree: /builds/slave/test/build 04:29:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:21 INFO - Running post-action listener: _resource_record_post_action 04:29:21 INFO - ##### 04:29:21 INFO - ##### Running read-buildbot-config step. 04:29:21 INFO - ##### 04:29:21 INFO - Running pre-action listener: _resource_record_pre_action 04:29:21 INFO - Running main action method: read_buildbot_config 04:29:21 INFO - Using buildbot properties: 04:29:21 INFO - { 04:29:21 INFO - "project": "", 04:29:21 INFO - "product": "firefox", 04:29:21 INFO - "script_repo_revision": "production", 04:29:21 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:29:21 INFO - "repository": "", 04:29:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:29:21 INFO - "buildid": "20160423024847", 04:29:21 INFO - "pgo_build": "False", 04:29:21 INFO - "basedir": "/builds/slave/test", 04:29:21 INFO - "buildnumber": 708, 04:29:21 INFO - "slavename": "t-yosemite-r7-0115", 04:29:21 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:29:21 INFO - "platform": "yosemite_r7", 04:29:21 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:29:21 INFO - "branch": "fx-team", 04:29:21 INFO - "repo_path": "integration/fx-team", 04:29:21 INFO - "revision": "ad71189f79aa732acb0ad2518d33d46387386045", 04:29:21 INFO - "stage_platform": "macosx64", 04:29:21 INFO - "builduid": "0b56103f51b843b3a3ea6e70d15b86ed", 04:29:21 INFO - "slavebuilddir": "test" 04:29:21 INFO - } 04:29:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:29:21 INFO - Running post-action listener: _resource_record_post_action 04:29:21 INFO - ##### 04:29:21 INFO - ##### Running download-and-extract step. 04:29:21 INFO - ##### 04:29:21 INFO - Running pre-action listener: _resource_record_pre_action 04:29:21 INFO - Running main action method: download_and_extract 04:29:21 INFO - mkdir: /builds/slave/test/build/tests 04:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:21 INFO - https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:29:25 INFO - Downloaded 1199 bytes. 04:29:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:29:25 INFO - Using the following test package requirements: 04:29:25 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:29:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:29:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:29:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'jsshell-mac.zip'], 04:29:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:29:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:29:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:29:25 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:29:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:29:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:29:25 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:29:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:29:25 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')]} 04:29:25 INFO - https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:29:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:29:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:29:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:29:26 INFO - Downloaded 18109576 bytes. 04:29:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:29:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:29:29 INFO - Return code: 0 04:29:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:29 INFO - https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:29:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:29:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:29:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:29:42 INFO - Downloaded 18109576 bytes. 04:29:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:29:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:29:46 INFO - Return code: 0 04:29: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')]} 04:29:46 INFO - https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:29:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:29:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:29:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:29:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:29:47 INFO - Downloaded 10840145 bytes. 04:29:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:29:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:29:47 INFO - Return code: 0 04:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:47 INFO - https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:29:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:29:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:29:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:30:02 INFO - Downloaded 110127687 bytes. 04:30:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:30:02 INFO - mkdir: /builds/slave/test/properties 04:30:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:02 INFO - Contents: 04:30:02 INFO - build_url:https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:30:03 INFO - Running post-action listener: _resource_record_post_action 04:30:03 INFO - Running post-action listener: set_extra_try_arguments 04:30:03 INFO - ##### 04:30:03 INFO - ##### Running populate-webroot step. 04:30:03 INFO - ##### 04:30:03 INFO - Running pre-action listener: _resource_record_pre_action 04:30:03 INFO - Running main action method: populate_webroot 04:30:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:03 INFO - '--tppagecycles', 04:30:03 INFO - '7'], 04:30:03 INFO - 'tests': ['tsvgm']}}, 04:30:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['damp', 'tps']}, 04:30:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'tests': ['damp', 'tps']}, 04:30:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['dromaeo_dom']}, 04:30:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['a11yr', 04:30:03 INFO - 'ts_paint', 04:30:03 INFO - 'tpaint', 04:30:03 INFO - 'sessionrestore', 04:30:03 INFO - 'sessionrestore_no_auto_restore', 04:30:03 INFO - 'tabpaint']}, 04:30:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:03 INFO - 'ts_paint', 04:30:03 INFO - 'tpaint', 04:30:03 INFO - 'sessionrestore', 04:30:03 INFO - 'sessionrestore_no_auto_restore', 04:30:03 INFO - 'tabpaint']}, 04:30:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:03 INFO - 'ts_paint', 04:30:03 INFO - 'tpaint', 04:30:03 INFO - 'sessionrestore', 04:30:03 INFO - 'sessionrestore_no_auto_restore', 04:30:03 INFO - 'tabpaint']}, 04:30:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:03 INFO - 'ts_paint', 04:30:03 INFO - 'tpaint', 04:30:03 INFO - 'sessionrestore', 04:30:03 INFO - 'sessionrestore_no_auto_restore', 04:30:03 INFO - 'tabpaint']}, 04:30:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['a11yr', 04:30:03 INFO - 'ts_paint', 04:30:03 INFO - 'tpaint', 04:30:03 INFO - 'sessionrestore', 04:30:03 INFO - 'sessionrestore_no_auto_restore', 04:30:03 INFO - 'tabpaint']}, 04:30:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['a11yr', 04:30:03 INFO - 'ts_paint', 04:30:03 INFO - 'tpaint', 04:30:03 INFO - 'sessionrestore', 04:30:03 INFO - 'sessionrestore_no_auto_restore', 04:30:03 INFO - 'tabpaint']}, 04:30:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['tsvgx', 04:30:03 INFO - 'tsvgr_opacity', 04:30:03 INFO - 'tart', 04:30:03 INFO - 'tscrollx', 04:30:03 INFO - 'cart']}, 04:30:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:03 INFO - 'tsvgr_opacity', 04:30:03 INFO - 'tart', 04:30:03 INFO - 'tscrollx', 04:30:03 INFO - 'cart']}, 04:30:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'talos_options': ['--disable-e10s'], 04:30:03 INFO - 'tests': ['tp5o']}, 04:30:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'tests': ['tp5o']}, 04:30:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'talos_options': ['--disable-e10s', 04:30:03 INFO - '--xperf_path', 04:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:03 INFO - 'tests': ['tp5n']}, 04:30:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:03 INFO - 'talos_options': ['--xperf_path', 04:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:03 INFO - 'tests': ['tp5n']}}, 04:30:03 INFO - 'talos.zip': {'path': '', 04:30:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:03 INFO - Running post-action listener: _resource_record_post_action 04:30:03 INFO - ##### 04:30:03 INFO - ##### Running create-virtualenv step. 04:30:03 INFO - ##### 04:30:03 INFO - Running pre-action listener: _resource_record_pre_action 04:30:03 INFO - Running main action method: create_virtualenv 04:30:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30: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 04:30:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:03 INFO - Using real prefix '/tools/python27' 04:30:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:04 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:07 INFO - Installing pip.................done. 04:30:07 INFO - Return code: 0 04:30:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30: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 04:30: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 04:30:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:07 INFO - 'HOME': '/Users/cltbld', 04:30:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:07 INFO - 'LOGNAME': 'cltbld', 04:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:07 INFO - 'MOZ_NO_REMOTE': '1', 04:30:07 INFO - 'NO_EM_RESTART': '1', 04:30:07 INFO - 'PAGER': '/bin/cat', 04:30:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:07 INFO - 'PWD': '/builds/slave/test', 04:30:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:07 INFO - 'SHELL': '/bin/bash', 04:30:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:07 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:07 INFO - 'USER': 'cltbld', 04:30:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:07 INFO - 'XPC_FLAGS': '0x0', 04:30:07 INFO - 'XPC_SERVICE_NAME': '0', 04:30:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30: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 04:30:07 INFO - Cleaning up... 04:30:07 INFO - Return code: 0 04:30:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30: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>=0.7.1'] in /builds/slave/test/build 04:30: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>=0.7.1 04:30:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:07 INFO - 'HOME': '/Users/cltbld', 04:30:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:07 INFO - 'LOGNAME': 'cltbld', 04:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:07 INFO - 'MOZ_NO_REMOTE': '1', 04:30:07 INFO - 'NO_EM_RESTART': '1', 04:30:07 INFO - 'PAGER': '/bin/cat', 04:30:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:07 INFO - 'PWD': '/builds/slave/test', 04:30:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:07 INFO - 'SHELL': '/bin/bash', 04:30:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:07 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:07 INFO - 'USER': 'cltbld', 04:30:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:07 INFO - 'XPC_FLAGS': '0x0', 04:30:07 INFO - 'XPC_SERVICE_NAME': '0', 04:30:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:07 INFO - Downloading/unpacking psutil>=0.7.1 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:10 INFO - Installing collected packages: psutil 04:30:10 INFO - Running setup.py install for psutil 04:30:11 INFO - building 'psutil._psutil_osx' extension 04:30: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 04:30: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 04:30: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 04:30: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 04:30:11 INFO - building 'psutil._psutil_posix' extension 04:30: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 04:30:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:30:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:30:11 INFO - ^ 04:30:11 INFO - 1 warning generated. 04:30: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 04:30:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:12 INFO - Successfully installed psutil 04:30:12 INFO - Cleaning up... 04:30:12 INFO - Return code: 0 04:30:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30: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.0.0'] in /builds/slave/test/build 04:30: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.0.0 04:30:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:12 INFO - 'HOME': '/Users/cltbld', 04:30:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:12 INFO - 'LOGNAME': 'cltbld', 04:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:12 INFO - 'MOZ_NO_REMOTE': '1', 04:30:12 INFO - 'NO_EM_RESTART': '1', 04:30:12 INFO - 'PAGER': '/bin/cat', 04:30:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:12 INFO - 'PWD': '/builds/slave/test', 04:30:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:12 INFO - 'SHELL': '/bin/bash', 04:30:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:12 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:12 INFO - 'USER': 'cltbld', 04:30:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:12 INFO - 'XPC_FLAGS': '0x0', 04:30:12 INFO - 'XPC_SERVICE_NAME': '0', 04:30:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:30:14 INFO - Installing collected packages: mozsystemmonitor 04:30:14 INFO - Running setup.py install for mozsystemmonitor 04:30:15 INFO - Successfully installed mozsystemmonitor 04:30:15 INFO - Cleaning up... 04:30:15 INFO - Return code: 0 04:30:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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', '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 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:30: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 blobuploader==1.2.4 04:30:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:15 INFO - 'HOME': '/Users/cltbld', 04:30:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:15 INFO - 'LOGNAME': 'cltbld', 04:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:15 INFO - 'MOZ_NO_REMOTE': '1', 04:30:15 INFO - 'NO_EM_RESTART': '1', 04:30:15 INFO - 'PAGER': '/bin/cat', 04:30:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:15 INFO - 'PWD': '/builds/slave/test', 04:30:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:15 INFO - 'SHELL': '/bin/bash', 04:30:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:15 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:15 INFO - 'USER': 'cltbld', 04:30:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:15 INFO - 'XPC_FLAGS': '0x0', 04:30:15 INFO - 'XPC_SERVICE_NAME': '0', 04:30:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:18 INFO - Downloading docopt-0.6.1.tar.gz 04:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:19 INFO - Running setup.py install for blobuploader 04:30:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:19 INFO - Running setup.py install for requests 04:30:19 INFO - Running setup.py install for docopt 04:30:19 INFO - Successfully installed blobuploader requests docopt 04:30:19 INFO - Cleaning up... 04:30:19 INFO - Return code: 0 04:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:19 INFO - 'HOME': '/Users/cltbld', 04:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:19 INFO - 'LOGNAME': 'cltbld', 04:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:19 INFO - 'MOZ_NO_REMOTE': '1', 04:30:19 INFO - 'NO_EM_RESTART': '1', 04:30:19 INFO - 'PAGER': '/bin/cat', 04:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:19 INFO - 'PWD': '/builds/slave/test', 04:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:19 INFO - 'SHELL': '/bin/bash', 04:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:19 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:19 INFO - 'USER': 'cltbld', 04:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:19 INFO - 'XPC_FLAGS': '0x0', 04:30:19 INFO - 'XPC_SERVICE_NAME': '0', 04:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-xl8RJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-eGX72O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-1ppt4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-juDvZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-aqjO7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-mOFkhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-plwYAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:20 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-FEWG5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-eaVmJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-E1X2KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-lthN1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-g9b1OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-PquG01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-mAnqXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-BViUi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-twWWvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:21 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-W8So7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:21 INFO - Running setup.py install for manifestparser 04:30:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:22 INFO - Running setup.py install for mozcrash 04:30:22 INFO - Running setup.py install for mozdebug 04:30:22 INFO - Running setup.py install for mozdevice 04:30:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:22 INFO - Running setup.py install for mozfile 04:30:22 INFO - Running setup.py install for mozhttpd 04:30:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:22 INFO - Running setup.py install for mozinfo 04:30:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:22 INFO - Running setup.py install for mozInstall 04:30:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Running setup.py install for mozleak 04:30:23 INFO - Running setup.py install for mozlog 04:30:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Running setup.py install for moznetwork 04:30:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Running setup.py install for mozprocess 04:30:23 INFO - Running setup.py install for mozprofile 04:30:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:23 INFO - Running setup.py install for mozrunner 04:30:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:24 INFO - Running setup.py install for mozscreenshot 04:30:24 INFO - Running setup.py install for moztest 04:30:24 INFO - Running setup.py install for mozversion 04:30:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:24 INFO - Cleaning up... 04:30:24 INFO - Return code: 0 04:30:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:24 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')]} 04:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:24 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')]} 04:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:24 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 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30:24 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 04:30:24 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 04:30:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:24 INFO - 'HOME': '/Users/cltbld', 04:30:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:24 INFO - 'LOGNAME': 'cltbld', 04:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:24 INFO - 'MOZ_NO_REMOTE': '1', 04:30:24 INFO - 'NO_EM_RESTART': '1', 04:30:24 INFO - 'PAGER': '/bin/cat', 04:30:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:24 INFO - 'PWD': '/builds/slave/test', 04:30:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:24 INFO - 'SHELL': '/bin/bash', 04:30:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:24 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:24 INFO - 'USER': 'cltbld', 04:30:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:24 INFO - 'XPC_FLAGS': '0x0', 04:30:24 INFO - 'XPC_SERVICE_NAME': '0', 04:30:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:24 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-0ZUJzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:24 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-ozFqzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:24 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-b60d5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:25 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)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-SVOvea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:25 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)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-3chF9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:25 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)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-kZwUF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:25 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)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-TaNleo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:25 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)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-kZjyiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:25 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)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-KyI61M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-aFJ3aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-fIu1wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:25 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-rO0lMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:26 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)) 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:26 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-nIqsUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:26 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)) 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:26 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-okSW6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:26 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)) 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:26 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-6f_22R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:26 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)) 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:26 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-XPcR14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:26 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)) 04:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:26 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-rOuxL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:26 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)) 04:30:26 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)) 04:30:26 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)) 04:30:26 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)) 04:30:26 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)) 04:30:26 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)) 04:30:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:26 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 04:30:26 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 04:30:26 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 04:30:26 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 04:30:26 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 04:30:26 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 04:30:28 INFO - Downloading blessings-1.6.tar.gz 04:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:30:29 INFO - Installing collected packages: blessings 04:30:29 INFO - Running setup.py install for blessings 04:30:29 INFO - Successfully installed blessings 04:30:29 INFO - Cleaning up... 04:30:29 INFO - Return code: 0 04:30:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:30:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:29 INFO - Reading from file tmpfile_stdout 04:30:29 INFO - Current package versions: 04:30:29 INFO - blessings == 1.6 04:30:29 INFO - blobuploader == 1.2.4 04:30:29 INFO - docopt == 0.6.1 04:30:29 INFO - manifestparser == 1.1 04:30:29 INFO - mozInstall == 1.12 04:30:29 INFO - mozcrash == 0.17 04:30:29 INFO - mozdebug == 0.1 04:30:29 INFO - mozdevice == 0.48 04:30:29 INFO - mozfile == 1.2 04:30:29 INFO - mozhttpd == 0.7 04:30:29 INFO - mozinfo == 0.9 04:30:29 INFO - mozleak == 0.1 04:30:29 INFO - mozlog == 3.1 04:30:29 INFO - moznetwork == 0.27 04:30:29 INFO - mozprocess == 0.22 04:30:29 INFO - mozprofile == 0.28 04:30:29 INFO - mozrunner == 6.11 04:30:29 INFO - mozscreenshot == 0.1 04:30:29 INFO - mozsystemmonitor == 0.0 04:30:29 INFO - moztest == 0.7 04:30:29 INFO - mozversion == 1.4 04:30:29 INFO - psutil == 3.1.1 04:30:29 INFO - requests == 1.2.3 04:30:29 INFO - wsgiref == 0.1.2 04:30:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:30:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:29 INFO - 'HOME': '/Users/cltbld', 04:30:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:29 INFO - 'LOGNAME': 'cltbld', 04:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:29 INFO - 'MOZ_NO_REMOTE': '1', 04:30:29 INFO - 'NO_EM_RESTART': '1', 04:30:29 INFO - 'PAGER': '/bin/cat', 04:30:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:29 INFO - 'PWD': '/builds/slave/test', 04:30:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:29 INFO - 'SHELL': '/bin/bash', 04:30:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:29 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:29 INFO - 'USER': 'cltbld', 04:30:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:29 INFO - 'XPC_FLAGS': '0x0', 04:30:29 INFO - 'XPC_SERVICE_NAME': '0', 04:30:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:30:29 INFO - Cleaning up... 04:30:29 INFO - Return code: 0 04:30:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:30:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:29 INFO - 'HOME': '/Users/cltbld', 04:30:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:29 INFO - 'LOGNAME': 'cltbld', 04:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:29 INFO - 'MOZ_NO_REMOTE': '1', 04:30:29 INFO - 'NO_EM_RESTART': '1', 04:30:29 INFO - 'PAGER': '/bin/cat', 04:30:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:29 INFO - 'PWD': '/builds/slave/test', 04:30:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:29 INFO - 'SHELL': '/bin/bash', 04:30:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:29 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:29 INFO - 'USER': 'cltbld', 04:30:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:29 INFO - 'XPC_FLAGS': '0x0', 04:30:29 INFO - 'XPC_SERVICE_NAME': '0', 04:30:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:30 INFO - Downloading/unpacking jsonschema 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:30:32 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 04:30:32 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 04:30:32 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 04:30:32 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 04:30:32 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 04:30:32 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 04:30:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:33 INFO - warning: no files found matching '*.txt' 04:30:33 INFO - no previously-included directories found matching 'build' 04:30:33 INFO - no previously-included directories found matching 'dist' 04:30:33 INFO - no previously-included directories found matching '.git*' 04:30:33 INFO - Installing collected packages: jsonschema, functools32 04:30:33 INFO - Running setup.py install for functools32 04:30:33 INFO - warning: no files found matching '*.txt' 04:30:33 INFO - no previously-included directories found matching 'build' 04:30:33 INFO - no previously-included directories found matching 'dist' 04:30:33 INFO - no previously-included directories found matching '.git*' 04:30:33 INFO - Successfully installed jsonschema functools32 04:30:33 INFO - Cleaning up... 04:30:33 INFO - Return code: 0 04:30:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff649d65900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, '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.N3Uovh4q97/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.8lsmCQThTr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:30: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', 'flake8'] in /builds/slave/test/build 04:30: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 flake8 04:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:33 INFO - 'HOME': '/Users/cltbld', 04:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:33 INFO - 'LOGNAME': 'cltbld', 04:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:33 INFO - 'MOZ_NO_REMOTE': '1', 04:30:33 INFO - 'NO_EM_RESTART': '1', 04:30:33 INFO - 'PAGER': '/bin/cat', 04:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:33 INFO - 'PWD': '/builds/slave/test', 04:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:33 INFO - 'SHELL': '/bin/bash', 04:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:30:33 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:33 INFO - 'USER': 'cltbld', 04:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:33 INFO - 'XPC_FLAGS': '0x0', 04:30:33 INFO - 'XPC_SERVICE_NAME': '0', 04:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:33 INFO - Downloading/unpacking flake8 04:30:33 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 04:30:33 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 04:30:33 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 04:30:33 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 04:30:33 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 04:30:33 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 04:30:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:30:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:30:36 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 04:30:36 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 04:30:36 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 04:30:36 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 04:30:36 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 04:30:36 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 04:30:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:30:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:30:36 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 04:30:36 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 04:30:36 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 04:30:36 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 04:30:36 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 04:30:36 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 04:30:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:30:37 INFO - no previously-included directories found matching 'docs/_build' 04:30:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:30:37 INFO - Running setup.py install for pep8 04:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:30:37 INFO - no previously-included directories found matching 'docs/_build' 04:30:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:30:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:30:37 INFO - Cleaning up... 04:30:37 INFO - Return code: 0 04:30:37 INFO - Running post-action listener: _resource_record_post_action 04:30:37 INFO - Running post-action listener: _start_resource_monitoring 04:30:38 INFO - Starting resource monitoring. 04:30:38 INFO - ##### 04:30:38 INFO - ##### Running install step. 04:30:38 INFO - ##### 04:30:38 INFO - Running pre-action listener: _resource_record_pre_action 04:30:38 INFO - Running main action method: install 04:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:38 INFO - Reading from file tmpfile_stdout 04:30:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:30:38 INFO - Reading from file tmpfile_stdout 04:30:38 INFO - Output received: 04:30:38 INFO - Usage: mozinstall [options] installer 04:30:38 INFO - Options: 04:30:38 INFO - -h, --help show this help message and exit 04:30:38 INFO - -d DEST, --destination=DEST 04:30:38 INFO - Directory to install application into. [default: 04:30:38 INFO - "/builds/slave/test"] 04:30:38 INFO - --app=APP Application being installed. [default: firefox] 04:30:38 INFO - mkdir: /builds/slave/test/build/application 04:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:31:13 INFO - Reading from file tmpfile_stdout 04:31:13 INFO - Output received: 04:31:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:31:13 INFO - Running post-action listener: _resource_record_post_action 04:31:13 INFO - ##### 04:31:13 INFO - ##### Running run-tests step. 04:31:13 INFO - ##### 04:31:13 INFO - Running pre-action listener: _resource_record_pre_action 04:31:13 INFO - Running main action method: run_tests 04:31:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:13 INFO - 2016-04-23 04:31:13.610 screenresolution[1651:8070] starting screenresolution argv=screenresolution get 04:31:13 INFO - 2016-04-23 04:31:13.613 screenresolution[1651:8070] Display 0: 1600x1200x32@60 04:31:13 INFO - 2016-04-23 04:31:13.618 screenresolution[1652:8072] starting screenresolution argv=screenresolution list 04:31:13 INFO - Available Modes on Display 0 04:31:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:13 INFO - Intel Iris: 04:31:13 INFO - Chipset Model: Intel Iris 04:31:13 INFO - Type: GPU 04:31:13 INFO - Bus: Built-In 04:31:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:13 INFO - Vendor: Intel (0x8086) 04:31:13 INFO - Device ID: 0x0a2e 04:31:13 INFO - Revision ID: 0x0009 04:31:13 INFO - Displays: 04:31:13 INFO - Display: 04:31:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:13 INFO - Display Serial Number: 1600x1200 60 04:31:13 INFO - Main Display: Yes 04:31:13 INFO - Mirror: Off 04:31:13 INFO - Online: Yes 04:31:13 INFO - Rotation: Supported 04:31:13 INFO - Return code: 0 04:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:13 INFO - Python 2.7.3 04:31:13 INFO - Return code: 0 04:31:13 INFO - grabbing minidump binary from tooltool 04:31:13 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')]} 04:31:13 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d9e00>, '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 0x10e402db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5d4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:13 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 04:31:13 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 04:31:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:13 INFO - Return code: 0 04:31:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:31:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:31:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:31:15 INFO - Return code: 0 04:31:15 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/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 04:31:15 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/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0115 --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 04:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N3Uovh4q97/Render', 04:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:15 INFO - 'HOME': '/Users/cltbld', 04:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:15 INFO - 'LOGNAME': 'cltbld', 04:31:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:15 INFO - 'MOZ_NO_REMOTE': '1', 04:31:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:15 INFO - 'NO_EM_RESTART': '1', 04:31:15 INFO - 'PAGER': '/bin/cat', 04:31:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:15 INFO - 'PWD': '/builds/slave/test', 04:31:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:15 INFO - 'SHELL': '/bin/bash', 04:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8lsmCQThTr/Listeners', 04:31:15 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:15 INFO - 'USER': 'cltbld', 04:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:15 INFO - 'XPC_FLAGS': '0x0', 04:31:15 INFO - 'XPC_SERVICE_NAME': '0', 04:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:15 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/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 04:31:15 INFO - mozversion application_buildid: 20160423024847 04:31:15 INFO - mozversion application_changeset: ad71189f79aa732acb0ad2518d33d46387386045 04:31:15 INFO - mozversion application_display_name: Nightly 04:31:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:15 INFO - mozversion application_name: Firefox 04:31:15 INFO - mozversion application_remotingname: firefox 04:31:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:31:15 INFO - mozversion application_vendor: Mozilla 04:31:15 INFO - mozversion application_version: 48.0a1 04:31:15 INFO - mozversion platform_buildid: 20160423024847 04:31:15 INFO - mozversion platform_changeset: ad71189f79aa732acb0ad2518d33d46387386045 04:31:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:31:15 INFO - mozversion platform_version: 48.0a1 04:31:15 INFO - using testdate: 1461411075 04:31:15 INFO - actual date: 1461411075 04:31:15 INFO - starting webserver on 'localhost:49288' 04:31:15 INFO - SUITE-START | Running 2 tests 04:31:15 INFO - TEST-START | dromaeo_css 04:31:15 INFO - operating with platform_type : mac_ 04:31:15 INFO - Initialising browser for dromaeo_css test... 04:31:15 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmp2fvkfL/profile http://localhost:49288/getInfo.html) 04:31:17 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 04:31:17 INFO - PROCESS | 1670 | colorDepth:24 04:31:17 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 04:31:17 INFO - PROCESS | 1670 | __metrics 04:31:17 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" 04:31:17 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:31:18 INFO - TEST-INFO | 1670: exit 0 04:31:18 INFO - Browser initialized. 04:31:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:18 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmp2fvkfL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:30 INFO - PROCESS | 1673 | RSS: Main: 239063040 04:31:30 INFO - PROCESS | 1673 | 04:32:21 INFO - PROCESS | 1673 | 1461411141521 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:34:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 04:34:33 INFO - PROCESS | 1673 | RSS: Main: 443502592 04:34:33 INFO - PROCESS | 1673 | 04:37:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 04:37:37 INFO - PROCESS | 1673 | RSS: Main: 378974208 04:37:37 INFO - PROCESS | 1673 | 04:40:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 04:40:40 INFO - PROCESS | 1673 | RSS: Main: 377405440 04:40:40 INFO - PROCESS | 1673 | 04:43:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 04:43:43 INFO - PROCESS | 1673 | RSS: Main: 376520704 04:43:43 INFO - PROCESS | 1673 | 04:46:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 04:46:47 INFO - PROCESS | 1673 | RSS: Main: 342102016 04:46:47 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 04:49:50 INFO - PROCESS | 1673 | RSS: Main: 383684608 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | __start_tp_report 04:49:50 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 04:49:50 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 04:49:50 INFO - PROCESS | 1673 | |i|pagename|runs| 04:49:50 INFO - PROCESS | 1673 | |0;dojo.html;2918.387138700871;3408.5398471206386;3491.5460990071297;3497.825108744562;3538.203904121571;5633.605647604659;5691.459311365424;5764.991126552853;5765.452282033205;5790.36306006339;5741.569382296334;5748.2527271454655;5883.794067207648;5906;5921.703914804264;5160.174372100465;5194.324737784083;5201.479852014806;5248.501392367719;5336.092864213074;5270.367555893298;5338.119210330291;5350.5452036576935;5358.115910874701;5406.972965135169;5133.409657889353;5188.974055129738;5243.9213411798855;5254.133068043769;5278.076336641092;5182.222666600002;5215.713135777531;5219.42586315505;5264.394594621629;5324.148136298212;5152.458991805844;5209.218617207449;5235.136202526579;5236.6857988520815;5295.338082739658;5515.145152501369;5669.177969194444;5683.261176047129;5716.57125715573;5725.169850371714;6113.932424433829;6181.81454556364;6216.067589861512;6220.937790622126;6225.844353891143;6126.785562505335;6149.723262453201;6168.599041062316;6174.722137503778;6186.84532886677;5658.91511627326;5855.945929732647;5861.384554621746;5863.70681465925;5886.146508756249;6155.630662160284;6176.197094377792;6227.9377206227355;6231.3145553989025;6239;6173.074038894202;6189.81430557075;6198.845028874314;6201.720922558496;6205.410486003822;6091.5735898487565;6110.29731580865;6157.907631385533;6158.784442544579;6168.506519478431;6080.969595151996;6092.939070609237;6116.153172518083;6138.051223665364;6158.938410615926;4772.3557319762085;6127.479164270998;6189.566730328834;6199.597026193283;6205.937940620536;4905.264210368402;4938.654294199371;4944.554990050912;4952.182889823211;4997.925031124536;4385.736855788663;4404.031113155101;4422.668299877458;4433.467983841895;4458.598726114666;5567.721613919288;5631.436856314418;5650.067738823131;5663.773449062074;5737.397573254748;6150.231221097363;6157.230346206724;6158.784442544489;6160.969195153995;6162.784302549389;5651.2935883014625;5681.886362272731;5689.6586204827845;5689.943100569024;5749.1663708762835;5377.731113444391;5390.51485366319;5394.352677678625;5398.325209348832;5450.264214331094;6223.377662233831;6274.6548939808745;6301.747930082745;6312.147860038928;6318.8420289492215;5833.737481813413;6152.169457123231;6155.076738489262;6160.16837726919;6164.815055548341;6265.216847894013;6305.464035557029;6305.8108256752375;6318.273398559225;6346.555741098079;6088.299845517645;6136.94800169746;6154.292256390393;6157.014877619559;6177.81466556004;6096.817095487142;6136.488442913377;6155.507559395327;6168.845778855564;6179.196704428396;6149.96925015372;6158.815235542941;6170.598911070766;6174.44430001302;6179.258488981351;5898.439648233411;6055.848603784941;6155.692215389123;6165.260168779775;6192.535559832941;4989.750512474289;5937.168796368598;5961.314448838439;5968.492678122235;5982.7307771149535;4922.581580565692;4973.626977976739;6052.969735151472;6057.121717351048;6057.606255593372;4946;6012.518998480198;6019.699015049143;6031.36670649593;6075.513958883367 04:49:50 INFO - PROCESS | 1673 | |1;ext.html;506.85807973767356;529.4863981937519;531.0202676062664;582.2925145947672;583.5156819839532;38550;39864.402033969476;40111.39832902509;40127.799361003155;40144;42327.57672423275;42362;42517;42530.36204456936;42723.35914961278;8675.305975521975;8889.977652569973;9585.281103917217;9851.65519206828;9853.113219810215;11725.530978760838;12037.578684746035;12076.698082547919;12085.335306558136;12088.758224835541;11678.6496405108;11779.469923853447;11790.35153066581;11791;11798.174127811057;8776.85900832891;11630.069594432467;11861.52553897843;12115.757684846341;12133.514659413613;11654.76690466186;11748.706282342924;11792.23350482216;11807.81921807821;11863.703407414798;39287.41068883969;39605.20789584221;39655;39817;39835.605753798474;3347.598288205407;3362.0586235854;3367.2087059540986;3386.762926595139;3739.7943113128767;28905.56641650377;29384.265393365124;29784.80860765567;29907.401851963055;30012.099637010706;2677.598360245959;2678.102835550093;2698.743619356158;2808.129479861229;2895.7143427727083;379868;380319;380445.09777451213;381611;383282;62406.687966559875;62853.37146628475;63138.68430657909;63269;63308.05037924435;66433;66871.66564167148;69727.65136174388;72340.63829680924;72463;17012.404565840385;17219.3973210937;17294.827051729575;17306.48080557585;17310.874793138657;11927;12173.634790956285;12911.35443227835;13160.539381121614;13162.934185329204;18342.99113548741;19304;19544.74842280353;19961.900190498956;19991.800081999285;8119.228673276029;8245.464044837187;8249.958750206211;8267.8346433071;8306.293965012921;964.1274646444979;986.6250824686573;1001.8046480936293;1020.8315627921459;1048.7954848804563;29144.979925702497;29464.125694485607;29654.110376688735;29751.702482975325;29866.701332986828;1048.4548035021746;1084.208527774729;1084.7938891610568;1131.615250814727;1146.9541218351173;15105.54683359501;15183.772243416357;15265.397133301065;15461.845381546265;15481.766767287732;646298;656885;658323;658874;659024;59136;61771.38228617746;61901;62171;62245.37754622396;1327.6017194841702;1377.1461693749939;1495.155237290927;1508.8038554987781;1555.5566663500847;28820.711792881804;28913.855430722713;28966.13101606955;29357.559636605896;29646.258843529085;48517.27224091571;48526.75736621294;48953.2657010138;49022;49029;443835;450646.68209837493;452171;452211;452948;23649.408764780328;24342.391440214138;24908.50548967068;26421;27593.44813103767;43066.13867722565;43905;45220.77389613163;45505.77247113876;46288.8427789308;35916.64083359238;37164;37741;38015.80992095022;38097.85706428812;35812.104697382776;36148.638513614525;36163.45754813627;36767;37040.444393333586;37483.625163748016;37634.43548346722;37841.81079094697;38143.42784858285;38767.03082422962;30377.69622303749;31583.052508424786;31691.683083168875;31733.682663173997;31820;24183.032678692656;24557.38606534851;24730.25809225726;24799.13203037885;25621.615675764504 04:49:50 INFO - PROCESS | 1673 | |2;jquery.html;340.6899721253659;394.50686641697877;396.47269132054373;405.03399392449;412.09133859839056;19813.3065342713;20801.16795328185;21047.57904841904;21057.57884842302;21384.57230855382;21283.57432851342;21315.040823162955;22277;22295.665565016538;22350.88245587718;5792.275965504312;6162.568620196588;6171.382861713815;6172.259328880541;6174.197354343929;4274.487061552618;4561.042181141964;5844.386339434362;6393.360663933593;6764.526483146182;6632.867342653144;6728.192616885956;6730.663466826663;6731;6752.324767523233;6515.641639709814;6658.1344425224415;6673.5662181958505;6692.23039350476;6694.230163531183;5646.774129034834;5852.268466441695;5854;6015.969920150371;6029.728662210211;13733.176009439465;13964.93017534916;14007.879369650404;20732.067056982472;26564.601530977052;2246.4945387287894;2294.8623082615095;2410.8794560271917;2469.086438017945;2768.920121152752;9473.810523789554;9889.80220395588;9946.20430365569;10279.383237005728;10319.226058045677;1593.55380493462;1683.770847281479;1719.5099396672013;1754.3771960953804;1755.4558086993072;75927;111703.44148279288;126394;126995;130049.0492642611;11717.765644687059;11813.763724725457;11822;11828.88171118295;11834.822477662841;15217.467388641344;15252.771208431883;15257.08457492554;15264.618384540254;15295.235238238043;8743.071071191222;8821.470711757314;8840;8861.689840855539;8969.820603588023;8685.956570217108;8690.522021288889;8710.864088927981;8769.38614297006;8817.735467935972;4709.105269998689;4714.882127946828;4731.219348807477;4735.266033764772;4750.477447480844;1460.8247010358825;1792.1530133245337;1809.556658618647;1974.2991238110264;1985.6723640599428;865.16079402979;900.5542256583034;909.0909090909091;919.9328778616773;1106.9225154239125;19357.322493712934;19871.900640496995;20157;20904.163833446797;21365.46586335354;992.9404235745734;997.8553109799038;1005.4570531912832;1007.3401921741271;1023.1150055202345;9521.857172142423;10786.514606842555;10803.32548454975;10974.012338889539;11036.448177591088;576039;576799;583344;588775;592167.2741454028;125784;127961;127982.36008819897;131410;133371;1028.6245520385005;1048.2976405808126;1076.8815430302661;1094.0372472224392;1099.3898386395467;17898.642027159643;18238.544036399195;18293.634127317644;18453.446396608124;18454.666640138457;45512;46018.849528762046;49284;50083.74958125186;51017.74491127521;70344.59310813653;70854;72675.90986135318;73874.63062684653;75590;7757.93561543176;8130;8275.089740128702;8360;8456.900602921582;7129.857402851811;9029.909700902906;12008.039356851255;12807.29559874216;13224.338783061;11188.88811111911;11195.2723073;11384.316940983568;11502.424878756196;11733.823992640288;11102.666919992413;11103.666889993314;11188.1608879336;11196.776064478829;11260;11399;11682.532698691957;11691.240069395462;11717.00405465545;11813.350265735467;8180.345572354317;8194.877076843972;8386.538740369095;8557.395159966001;8643.870341945001;10679.51942162589;11333.150013749168;11442.970132687766;11657.009154221985;11756.764864702829 04:49:50 INFO - PROCESS | 1673 | |3;mootools.html;1433.59859239413;1605.1974012993503;1606.3333716507645;1911.8088191180884;2048.7131801547785;7998.800029999245;8716.084811094832;8933.463992160476;8945.10548945105;8951;8525.97688277406;8748.518831464267;8769.473831570094;8794.076621954682;8799.428037177579;2156.5147841735643;2382.9642555361684;2424.696912885889;2461.495393444349;2474.826762126652;2458.176510868861;2484.714257860351;2484.776370126688;2491.1281051631872;2496.87515624219;2406.4946361264156;2458.373114855718;2462.2367066209445;2462.938426539342;2463.618139188429;2024.979750202494;2124.2458927080897;2431.7598025007374;2433.111914151331;2437.7805997460314;2429.4290841652196;2454.5949918263464;2462.5321188974217;2467.9881248687952;2469.4814089041324;8791.384603077788;8895.866562001574;8898.021217666052;8901;8922.509261990588;5254.343207099113;5481.945180548223;5487.972560137174;5500.4499550045075;5533.3083364579425;3537.8949525032563;3551.289742051574;3567.126054116732;3612.801295928723;3619.986403806938;973.9415635061919;1012.4735137728413;1014.8883622801486;1024.774549599087;1025.4976459486888;10075.848862267072;11714.297142171497;11737.06103511717;11742.706432339175;11832.230904991235;4749.62003039756;4783.521647835259;4809.709095800591;4860.392450943632;4923.729194894244;10005.749856253651;10026.448545330077;10028.047335503261;10040.949795250977;10041.146502547219;5388.811391601275;5421.539169170585;5423.05096608092;5448.210009548593;5451.209574611738;4450.643948484114;4631.652626053059;4893.241547560134;5004.174311238678;5038.168702164176;3940.7438516496336;3990.3016972029777;4070.3894415837863;4104.958950410517;4115.36211887158;1348.8044233586074;1358.6535433464403;1359.2931675528669;1373.7458570164551;1377.8484366719654;916.9266458683289;925.9074092590822;939.8966113727485;973.7030205787162;992.6277645882794;5371.6239863209985;5915.881682366415;6077.696115194222;6099.512039036867;6146.293176284695;440.19224722633686;442.40275627902076;450.9008018235983;465.47866389643815;465.66704806063825;3970.841166353371;3995.2808494471274;4076.898077548026;4078.7552746835286;4082.2039702258367;10467.424291664032;10792.730181745363;10923.235373523778;10925.781484370267;10929.071028962468;10755.462226888625;10872.61945831892;10873.456327183609;10885.346879187275;10888.564457421773;8186.631601577943;8367.665293388318;8369.204925532065;8371.497710137412;8394.160583941557;5689.943100569107;5939.287285525592;5945.983530837402;6065.60573562717;6199.256089269316;9629.614815407585;10135.898641013495;10152.289339746147;10218.335808172445;10235.181185505291;8530.829383412172;10293.330933489298;10304.227182961158;10316.381017138996;10322.019408156213;6405.135306733718;7483.812904677427;7509.51188172767;8198.795030124294;8389.286910612665;8413.242808147295;8529.658813647384;8530.445521041112;8530.530820804915;8536.615852286537;7442;7442.4418168636485;7526.962365188139;7661.808454788675;7672.002639656809;7366.263373662591;7388.113426388652;7431.591262480615;7434.7769566913075;7493.962530187314;7056.54132481387;7060.82347941285;7138.785836424916;7151.42788576923;7167.820804479929;4737.549932756383;4928.359313289249;4963.801447942042;5031.622628302819;5090.872728181825;4833.9274910875665;4911.435184953776;4918.631102667243;5047.394312682502;5193.584513238856 04:49:50 INFO - PROCESS | 1673 | |4;prototype.html;305.7019406079072;311.12108294069253;320.81232478999783;324.2105473172823;326.13736666517065;5739.196512488255;5867.069063727313;5871.2367392239;5877.911831322528;5981.671008094553;5189.896202075956;5266.736663166846;5858.88282234355;5875.9118613220835;5907.5864689471755;4240.745555266679;4343.326784348431;4437.201303765313;4480.507144214133;4498.932516012246;3628.444124757739;4341.544137865526;4451.532589078132;4486.955130448687;4506.039872655389;4365.716228445141;4397.692161548693;4410.691251612388;4415.315626077963;4419.337099435094;4394.231009573312;4408.691391602573;4430.4240448741775;4432.15789000089;4452.821887124511;2906;3757.2354855538824;3816.2367526494536;3821.751586146919;3834.1373191032076;5453.863653408657;5629.155626655994;5651.660900345952;5661.8584535386535;5676.801311954062;4226.387173859773;4250.532441431471;4696.976515117437;4703.988642441891;5102.183650615883;5181.357507671115;6003.699815009276;6213.260287119614;6217.502599792051;6236.7235958875135;4182.707210495267;4226.1336426032585;4229.6404805591565;4239.427677263561;4240.936385954213;5789.263221033673;6167.779599344232;6239.37606239377;6533.934660653427;6584.209894812653;4168.333066709312;4349.847755328548;4357.586029327209;4358.215521206213;4358.455193100863;4364.585364390377;4404.361367601744;4406.845760398371;4408.184485870061;4419.226635338803;4507.3689683444345;4845.370101886732;5147.536721695065;5189.636725429184;5195.3246078009615;6239.909630273818;6301.550643351963;6306.905396419057;6327.873442531123;6336.936630633727;1494.2080697230485;1527.747921592947;1532.578540901261;1535.3474773221337;1538.230884557721;900.9414388064755;974.2498276327331;1009.8689467796115;1023.3808545829814;1027.9023492768174;4817.9036419271415;5330.440303768126;5717.599768016282;5847.947369473451;5871.911921321183;4995.650304478724;5409.540189083972;6487.124238227873;6492.837679058061;6634.800955971328;5667.773289068391;5810.709464526842;5818.5054270386645;5822.970885145547;5843.2403787507355;2837.929051773681;3390.660933906639;3416.350893330259;3436.9312613748084;3441.1245871000365;6032.728527216286;6418.550701450947;6567.9671601641685;6807.523473356818;6990.161180658353;5294.841154765363;6803.897941530881;6811.284815094443;6837.307853759014;6841.144856892888;6501.8699626008165;6918.377346038881;6944.826379340456;6957.234704182536;6992.16094068715;6568.540202185801;6575.210974683068;6592.934285557239;6594.472442204708;6623.4038936495945;6370;6462.644554549545;6477.676116194078;6483.805485835433;6535.150430444012;4917.926231106465;6885.621290829053;6894.449053850108;6900.413464855343;7005.194402643558;4071.6742660587674;4208.211510108253;4268.886900984033;4286.1641979814885;4307.8276868924895;6423.64669943139;6594.637294948632;6611.867762644816;6618.113837556273;6621.172353455818;5268.341457317835;5519.668819870821;6398.232212134573;6399.55203135776;6411.4870810336;5263.73681315925;5578.358488773681;6143.447089761764;6403.8399040022505;6418.422341989243;5571.832845014656;5628.352739434854;6091.543134264859;6217.129601855653;6227.19046523949;4833.564979151894;5645.588602849288;5750.48245657876;5787.189793429007;6409.070684750778;5905.291365036223;6213.689315534296;6250.093736408105;6262.279837818709;6263.843403914939 04:49:50 INFO - PROCESS | 1673 | |5;yui.html;644.4554351572922;646.0438550944602;714.5819695478145;747.8766003609405;750.9962450187749;12320.507179712811;15403;15408.460703875367;15414.768778468318;15481.225938703063;13967.580972570813;14016.579502614912;14038.508652197175;14060.296985150753;14086.366113524891;700.4011570107562;726.5858460677416;876.701921346742;918.9954050229773;924.3899026642417;908.6728777640044;910.7495438754362;923.2521657457447;923.445932440537;924.4453328003178;966.4201479112546;980.2794945714929;981.9116279534841;982.670805280232;985.5220218194206;742.6175519607407;943.3019565521499;973.5083782689696;977.291463688827;978.6525783346881;723.6924307169485;723.8660847743184;724.8151721311085;725.6263024542365;726.4478995963053;15129.243537823175;15540.300686469023;15579.532614021597;15585.610359741097;15600.92199538995;13063.477460901648;13109.541166059238;13126.409311581001;13293.13594616347;13371.86628133716;8355.707550235773;10279.17766578672;10318.403556492633;10340.534675939525;10531.947340263327;3505.4040813061843;3513.4905438711244;3525.6474352564796;3629.5644522657185;3648.872289469882;60084.69957650184;70879.58240835206;76440;77100.84348734774;79597.40805183863;9785.706428807147;9820.224607285505;9846.60613575449;10032.69901902944;10652.573897044187;22546.985385657685;22643.88678056632;22692.65961010586;22710;22712.772872271395;7638.656260468292;7916.683332666744;8068.193180681885;8155.143709910492;8155.714549990722;4121.175764846983;4123.9175216495505;4135.813888375031;4146.813393397304;4166.0626359068965;3682.429223470366;3745.194783121642;3750.9437358439645;3754.0614846288427;3759.661630453272;659.5350278054057;669.4109183918121;676.5162908520432;677.6984242012257;679.4530403025514;545.5226676657925;598.9011813050798;599.9370066142992;601.7472661482101;609.2384519350811;7502.437317201232;7836.764897053097;7930.9603451982375;7992.68029278834;8275.917240827635;554.8196836028307;578.6094386289238;594.1266338482424;598.0729868703493;599.3467120838308;3651.6713495785507;3838.05967537955;3894.5131858517684;3944.4872166618156;4090.5909409058854;73412.63293683605;75896.48207035939;76194;93639;94040.05959940313;57123.85818779924;57402.13896791552;59376;72264.27735722576;74030;61918.69040654768;64551;66828;67647.32352676509;68850.96723549251;7938.04743430792;7993.760187194393;8004.279614834692;8181.2636862680265;8373.37199710012;42206.577934220266;42531.78734106434;44100;44239.778801105786;46020;61317.080243797274;64078.67960660167;64174.18693597906;64402.03396948956;64451;10931.398773067558;10998.780024399308;11096.112311014938;11212.215144939775;11292.943535282271;11631.709207269885;11794.233374830952;11900;12026.879731202576;12271.386430678609;11431.828522572334;11653.825192621947;11704.180707350404;11759.47082381312;11795.469203885674;11361.695966288402;11703.590374336858;11751.647450576496;12043;12336.50653973831;9948.452835093849;11311.547538098714;11343.432828358715;11465.828012579985;11576;7400.40796736249;9312.48781317034;9471.337006409485;9505.572249248939;9607.711768646952;9261.16649501548;9374.5781439834;9427.434353938786;9453.763655908657;9471.573779179816 04:49:50 INFO - PROCESS | 1673 | __end_tp_report 04:49:50 INFO - PROCESS | 1673 | __start_cc_report 04:49:50 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,2113 04:49:50 INFO - PROCESS | 1673 | __end_cc_report 04:49:50 INFO - PROCESS | 1673 | __startTimestamp1461412190422__endTimestamp 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | ------- Summary: start ------- 04:49:50 INFO - PROCESS | 1673 | Number of tests: 6 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5706.08 Median:5937.17 stddev:631.69 (10.6%) stddev-sans-first:594.57 04:49:50 INFO - PROCESS | 1673 | Values: 2918.4 3408.5 3491.5 3497.8 3538.2 5633.6 5691.5 5765.0 5765.5 5790.4 5741.6 5748.3 5883.8 5906.0 5921.7 5160.2 5194.3 5201.5 5248.5 5336.1 5270.4 5338.1 5350.5 5358.1 5407.0 5133.4 5189.0 5243.9 5254.1 5278.1 5182.2 5215.7 5219.4 5264.4 5324.1 5152.5 5209.2 5235.1 5236.7 5295.3 5515.1 5669.2 5683.3 5716.6 5725.2 6113.9 6181.8 6216.1 6220.9 6225.8 6126.8 6149.7 6168.6 6174.7 6186.8 5658.9 5855.9 5861.4 5863.7 5886.1 6155.6 6176.2 6227.9 6231.3 6239.0 6173.1 6189.8 6198.8 6201.7 6205.4 6091.6 6110.3 6157.9 6158.8 6168.5 6081.0 6092.9 6116.2 6138.1 6158.9 4772.4 6127.5 6189.6 6199.6 6205.9 4905.3 4938.7 4944.6 4952.2 4997.9 4385.7 4404.0 4422.7 4433.5 4458.6 5567.7 5631.4 5650.1 5663.8 5737.4 6150.2 6157.2 6158.8 6161.0 6162.8 5651.3 5681.9 5689.7 5689.9 5749.2 5377.7 5390.5 5394.4 5398.3 5450.3 6223.4 6274.7 6301.7 6312.1 6318.8 5833.7 6152.2 6155.1 6160.2 6164.8 6265.2 6305.5 6305.8 6318.3 6346.6 6088.3 6136.9 6154.3 6157.0 6177.8 6096.8 6136.5 6155.5 6168.8 6179.2 6150.0 6158.8 6170.6 6174.4 6179.3 5898.4 6055.8 6155.7 6165.3 6192.5 4989.8 5937.2 5961.3 5968.5 5982.7 4922.6 4973.6 6053.0 6057.1 6057.6 4946.0 6012.5 6019.7 6031.4 6075.5 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:64386.01 Median:19599.43 stddev:135963.16 (693.7%) stddev-sans-first:136259.98 04:49:50 INFO - PROCESS | 1673 | Values: 506.9 529.5 531.0 582.3 583.5 38550.0 39864.4 40111.4 40127.8 40144.0 42327.6 42362.0 42517.0 42530.4 42723.4 8675.3 8890.0 9585.3 9851.7 9853.1 11725.5 12037.6 12076.7 12085.3 12088.8 11678.6 11779.5 11790.4 11791.0 11798.2 8776.9 11630.1 11861.5 12115.8 12133.5 11654.8 11748.7 11792.2 11807.8 11863.7 39287.4 39605.2 39655.0 39817.0 39835.6 3347.6 3362.1 3367.2 3386.8 3739.8 28905.6 29384.3 29784.8 29907.4 30012.1 2677.6 2678.1 2698.7 2808.1 2895.7 379868.0 380319.0 380445.1 381611.0 383282.0 62406.7 62853.4 63138.7 63269.0 63308.1 66433.0 66871.7 69727.7 72340.6 72463.0 17012.4 17219.4 17294.8 17306.5 17310.9 11927.0 12173.6 12911.4 13160.5 13162.9 18343.0 19304.0 19544.7 19961.9 19991.8 8119.2 8245.5 8250.0 8267.8 8306.3 964.1 986.6 1001.8 1020.8 1048.8 29145.0 29464.1 29654.1 29751.7 29866.7 1048.5 1084.2 1084.8 1131.6 1147.0 15105.5 15183.8 15265.4 15461.8 15481.8 646298.0 656885.0 658323.0 658874.0 659024.0 59136.0 61771.4 61901.0 62171.0 62245.4 1327.6 1377.1 1495.2 1508.8 1555.6 28820.7 28913.9 28966.1 29357.6 29646.3 48517.3 48526.8 48953.3 49022.0 49029.0 443835.0 450646.7 452171.0 452211.0 452948.0 23649.4 24342.4 24908.5 26421.0 27593.4 43066.1 43905.0 45220.8 45505.8 46288.8 35916.6 37164.0 37741.0 38015.8 38097.9 35812.1 36148.6 36163.5 36767.0 37040.4 37483.6 37634.4 37841.8 38143.4 38767.0 30377.7 31583.1 31691.7 31733.7 31820.0 24183.0 24557.4 24730.3 24799.1 25621.6 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:34177.22 Median:12298.69 stddev:97444.79 (792.3%) stddev-sans-first:97685.03 04:49:50 INFO - PROCESS | 1673 | Values: 340.7 394.5 396.5 405.0 412.1 19813.3 20801.2 21047.6 21057.6 21384.6 21283.6 21315.0 22277.0 22295.7 22350.9 5792.3 6162.6 6171.4 6172.3 6174.2 4274.5 4561.0 5844.4 6393.4 6764.5 6632.9 6728.2 6730.7 6731.0 6752.3 6515.6 6658.1 6673.6 6692.2 6694.2 5646.8 5852.3 5854.0 6016.0 6029.7 13733.2 13964.9 14007.9 20732.1 26564.6 2246.5 2294.9 2410.9 2469.1 2768.9 9473.8 9889.8 9946.2 10279.4 10319.2 1593.6 1683.8 1719.5 1754.4 1755.5 75927.0 111703.4 126394.0 126995.0 130049.0 11717.8 11813.8 11822.0 11828.9 11834.8 15217.5 15252.8 15257.1 15264.6 15295.2 8743.1 8821.5 8840.0 8861.7 8969.8 8686.0 8690.5 8710.9 8769.4 8817.7 4709.1 4714.9 4731.2 4735.3 4750.5 1460.8 1792.2 1809.6 1974.3 1985.7 865.2 900.6 909.1 919.9 1106.9 19357.3 19871.9 20157.0 20904.2 21365.5 992.9 997.9 1005.5 1007.3 1023.1 9521.9 10786.5 10803.3 10974.0 11036.4 576039.0 576799.0 583344.0 588775.0 592167.3 125784.0 127961.0 127982.4 131410.0 133371.0 1028.6 1048.3 1076.9 1094.0 1099.4 17898.6 18238.5 18293.6 18453.4 18454.7 45512.0 46018.8 49284.0 50083.7 51017.7 70344.6 70854.0 72675.9 73874.6 75590.0 7757.9 8130.0 8275.1 8360.0 8456.9 7129.9 9029.9 12008.0 12807.3 13224.3 11188.9 11195.3 11384.3 11502.4 11733.8 11102.7 11103.7 11188.2 11196.8 11260.0 11399.0 11682.5 11691.2 11717.0 11813.4 8180.3 8194.9 8386.5 8557.4 8643.9 10679.5 11333.2 11443.0 11657.0 11756.8 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5764.96 Median:4766.57 stddev:3223.87 (67.6%) stddev-sans-first:3216.48 04:49:50 INFO - PROCESS | 1673 | Values: 1433.6 1605.2 1606.3 1911.8 2048.7 7998.8 8716.1 8933.5 8945.1 8951.0 8526.0 8748.5 8769.5 8794.1 8799.4 2156.5 2383.0 2424.7 2461.5 2474.8 2458.2 2484.7 2484.8 2491.1 2496.9 2406.5 2458.4 2462.2 2462.9 2463.6 2025.0 2124.2 2431.8 2433.1 2437.8 2429.4 2454.6 2462.5 2468.0 2469.5 8791.4 8895.9 8898.0 8901.0 8922.5 5254.3 5481.9 5488.0 5500.4 5533.3 3537.9 3551.3 3567.1 3612.8 3620.0 973.9 1012.5 1014.9 1024.8 1025.5 10075.8 11714.3 11737.1 11742.7 11832.2 4749.6 4783.5 4809.7 4860.4 4923.7 10005.7 10026.4 10028.0 10040.9 10041.1 5388.8 5421.5 5423.1 5448.2 5451.2 4450.6 4631.7 4893.2 5004.2 5038.2 3940.7 3990.3 4070.4 4105.0 4115.4 1348.8 1358.7 1359.3 1373.7 1377.8 916.9 925.9 939.9 973.7 992.6 5371.6 5915.9 6077.7 6099.5 6146.3 440.2 442.4 450.9 465.5 465.7 3970.8 3995.3 4076.9 4078.8 4082.2 10467.4 10792.7 10923.2 10925.8 10929.1 10755.5 10872.6 10873.5 10885.3 10888.6 8186.6 8367.7 8369.2 8371.5 8394.2 5689.9 5939.3 5946.0 6065.6 6199.3 9629.6 10135.9 10152.3 10218.3 10235.2 8530.8 10293.3 10304.2 10316.4 10322.0 6405.1 7483.8 7509.5 8198.8 8389.3 8413.2 8529.7 8530.4 8530.5 8536.6 7442.0 7442.4 7527.0 7661.8 7672.0 7366.3 7388.1 7431.6 7434.8 7494.0 7056.5 7060.8 7138.8 7151.4 7167.8 4737.5 4928.4 4963.8 5031.6 5090.9 4833.9 4911.4 4918.6 5047.4 5193.6 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5078.74 Median:5637.37 stddev:1601.91 (28.4%) stddev-sans-first:1565.83 04:49:50 INFO - PROCESS | 1673 | Values: 305.7 311.1 320.8 324.2 326.1 5739.2 5867.1 5871.2 5877.9 5981.7 5189.9 5266.7 5858.9 5875.9 5907.6 4240.7 4343.3 4437.2 4480.5 4498.9 3628.4 4341.5 4451.5 4487.0 4506.0 4365.7 4397.7 4410.7 4415.3 4419.3 4394.2 4408.7 4430.4 4432.2 4452.8 2906.0 3757.2 3816.2 3821.8 3834.1 5453.9 5629.2 5651.7 5661.9 5676.8 4226.4 4250.5 4697.0 4704.0 5102.2 5181.4 6003.7 6213.3 6217.5 6236.7 4182.7 4226.1 4229.6 4239.4 4240.9 5789.3 6167.8 6239.4 6533.9 6584.2 4168.3 4349.8 4357.6 4358.2 4358.5 4364.6 4404.4 4406.8 4408.2 4419.2 4507.4 4845.4 5147.5 5189.6 5195.3 6239.9 6301.6 6306.9 6327.9 6336.9 1494.2 1527.7 1532.6 1535.3 1538.2 900.9 974.2 1009.9 1023.4 1027.9 4817.9 5330.4 5717.6 5847.9 5871.9 4995.7 5409.5 6487.1 6492.8 6634.8 5667.8 5810.7 5818.5 5823.0 5843.2 2837.9 3390.7 3416.4 3436.9 3441.1 6032.7 6418.6 6568.0 6807.5 6990.2 5294.8 6803.9 6811.3 6837.3 6841.1 6501.9 6918.4 6944.8 6957.2 6992.2 6568.5 6575.2 6592.9 6594.5 6623.4 6370.0 6462.6 6477.7 6483.8 6535.2 4917.9 6885.6 6894.4 6900.4 7005.2 4071.7 4208.2 4268.9 4286.2 4307.8 6423.6 6594.6 6611.9 6618.1 6621.2 5268.3 5519.7 6398.2 6399.6 6411.5 5263.7 5578.4 6143.4 6403.8 6418.4 5571.8 5628.4 6091.5 6217.1 6227.2 4833.6 5645.6 5750.5 5787.2 6409.1 5905.3 6213.7 6250.1 6262.3 6263.8 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:17097.26 Median:30342.32 stddev:22961.14 (75.7%) stddev-sans-first:22992.31 04:49:50 INFO - PROCESS | 1673 | Values: 644.5 646.0 714.6 747.9 751.0 12320.5 15403.0 15408.5 15414.8 15481.2 13967.6 14016.6 14038.5 14060.3 14086.4 700.4 726.6 876.7 919.0 924.4 908.7 910.7 923.3 923.4 924.4 966.4 980.3 981.9 982.7 985.5 742.6 943.3 973.5 977.3 978.7 723.7 723.9 724.8 725.6 726.4 15129.2 15540.3 15579.5 15585.6 15600.9 13063.5 13109.5 13126.4 13293.1 13371.9 8355.7 10279.2 10318.4 10340.5 10531.9 3505.4 3513.5 3525.6 3629.6 3648.9 60084.7 70879.6 76440.0 77100.8 79597.4 9785.7 9820.2 9846.6 10032.7 10652.6 22547.0 22643.9 22692.7 22710.0 22712.8 7638.7 7916.7 8068.2 8155.1 8155.7 4121.2 4123.9 4135.8 4146.8 4166.1 3682.4 3745.2 3750.9 3754.1 3759.7 659.5 669.4 676.5 677.7 679.5 545.5 598.9 599.9 601.7 609.2 7502.4 7836.8 7931.0 7992.7 8275.9 554.8 578.6 594.1 598.1 599.3 3651.7 3838.1 3894.5 3944.5 4090.6 73412.6 75896.5 76194.0 93639.0 94040.1 57123.9 57402.1 59376.0 72264.3 74030.0 61918.7 64551.0 66828.0 67647.3 68851.0 7938.0 7993.8 8004.3 8181.3 8373.4 42206.6 42531.8 44100.0 44239.8 46020.0 61317.1 64078.7 64174.2 64402.0 64451.0 10931.4 10998.8 11096.1 11212.2 11292.9 11631.7 11794.2 11900.0 12026.9 12271.4 11431.8 11653.8 11704.2 11759.5 11795.5 11361.7 11703.6 11751.6 12043.0 12336.5 9948.5 11311.5 11343.4 11465.8 11576.0 7400.4 9312.5 9471.3 9505.6 9607.7 9261.2 9374.6 9427.4 9453.8 9471.6 04:49:50 INFO - PROCESS | 1673 | -------- Summary: end -------- 04:49:50 INFO - PROCESS | 1673 | 04:49:50 INFO - TEST-INFO | 1673: exit 0 04:49:51 INFO - TEST-OK | dromaeo_css | took 1115751ms 04:49:51 INFO - TEST-START | kraken 04:49:51 INFO - operating with platform_type : mac_ 04:49:51 INFO - Initialising browser for kraken test... 04:49:51 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpZSHtiA/profile http://localhost:49288/getInfo.html) 04:49:53 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 04:49:53 INFO - PROCESS | 1678 | colorDepth:24 04:49:53 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 04:49:53 INFO - PROCESS | 1678 | __metrics 04:49:53 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:49:53 ERROR - PROCESS | 1678 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:49:53 INFO - TEST-INFO | 1678: exit 0 04:49:53 INFO - Browser initialized. 04:49:53 INFO - Running cycle 1/1 for kraken test... 04:49:53 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpZSHtiA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:05 INFO - PROCESS | 1680 | RSS: Main: 239124480 04:50:05 INFO - PROCESS | 1680 | 04:50:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:09 INFO - PROCESS | 1680 | RSS: Main: 286855168 04:50:09 INFO - PROCESS | 1680 | 04:50:11 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-dft) 04:50:12 INFO - PROCESS | 1680 | RSS: Main: 300003328 04:50:12 INFO - PROCESS | 1680 | 04:50:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-fft) 04:50:16 INFO - PROCESS | 1680 | RSS: Main: 386842624 04:50:16 INFO - PROCESS | 1680 | 04:50:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator) 04:50:19 INFO - PROCESS | 1680 | RSS: Main: 288096256 04:50:19 INFO - PROCESS | 1680 | 04:50:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:22 INFO - PROCESS | 1680 | RSS: Main: 292196352 04:50:22 INFO - PROCESS | 1680 | 04:50:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:25 INFO - PROCESS | 1680 | RSS: Main: 330190848 04:50:25 INFO - PROCESS | 1680 | 04:50:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:28 INFO - PROCESS | 1680 | RSS: Main: 330543104 04:50:28 INFO - PROCESS | 1680 | 04:50:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial) 04:50:32 INFO - PROCESS | 1680 | RSS: Main: 328331264 04:50:32 INFO - PROCESS | 1680 | 04:50:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:34 INFO - PROCESS | 1680 | RSS: Main: 321359872 04:50:34 INFO - PROCESS | 1680 | 04:50:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:37 INFO - PROCESS | 1680 | RSS: Main: 328245248 04:50:37 INFO - PROCESS | 1680 | 04:50:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:40 INFO - PROCESS | 1680 | RSS: Main: 330014720 04:50:40 INFO - PROCESS | 1680 | 04:50:43 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:43 INFO - PROCESS | 1680 | RSS: Main: 331272192 04:50:43 INFO - PROCESS | 1680 | 04:50:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:47 INFO - PROCESS | 1680 | RSS: Main: 326901760 04:50:47 INFO - PROCESS | 1680 | 04:50:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49288/tests/kraken/driver.html?testName=ai-astar) 04:50:49 INFO - PROCESS | 1680 | RSS: Main: 391368704 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | __start_tp_report 04:50:49 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 04:50:49 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 04:50:49 INFO - PROCESS | 1680 | |i|pagename|runs| 04:50:49 INFO - PROCESS | 1680 | |0;ai-astar;112;112;105;113;112;114;114;114;104;114 04:50:49 INFO - PROCESS | 1680 | |1;audio-beat-detection;157;121;146;169;119;142;141;119;172;117 04:50:49 INFO - PROCESS | 1680 | |2;audio-dft;186;183;186;186;183;181;181;185;183;187 04:50:49 INFO - PROCESS | 1680 | |3;audio-fft;71;76;87;90;55;61;58;80;86;56 04:50:49 INFO - PROCESS | 1680 | |4;audio-oscillator;90;97;139;77;79;80;126;81;81;128 04:50:49 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;93;90;94;91;93;91;94;91;88;117 04:50:49 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;97;98;97;97;97;97;100;97;97 04:50:49 INFO - PROCESS | 1680 | |7;imaging-desaturate;98;142;85;87;84;87;85;85;88;88 04:50:49 INFO - PROCESS | 1680 | |8;json-parse-financial;60;61;60;60;61;60;60;79;60;59 04:50:49 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;68;63;72;75;72;67;68;67;93;91 04:50:49 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;97;100;100;81;83;100;98;98;84;83 04:50:49 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;141;140;139;139;139;155;130;140;232;158 04:50:49 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;171;173;167;156;156;202;212;206;182;171 04:50:49 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;71;67;69;68;68;67;67;72;68;68 04:50:49 INFO - PROCESS | 1680 | __end_tp_report 04:50:49 INFO - PROCESS | 1680 | __start_cc_report 04:50:49 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,2063 04:50:49 INFO - PROCESS | 1680 | __end_cc_report 04:50:49 INFO - PROCESS | 1680 | __startTimestamp1461412249203__endTimestamp 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | ------- Summary: start ------- 04:50:49 INFO - PROCESS | 1680 | Number of tests: 14 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:3.75 (3.3%) stddev-sans-first:3.97 04:50:49 INFO - PROCESS | 1680 | Values: 112.0 112.0 105.0 113.0 112.0 114.0 114.0 114.0 104.0 114.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:144.00 stddev:20.99 (14.6%) stddev-sans-first:21.38 04:50:49 INFO - PROCESS | 1680 | Values: 157.0 121.0 146.0 169.0 119.0 142.0 141.0 119.0 172.0 117.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.50 stddev:2.18 (1.2%) stddev-sans-first:2.20 04:50:49 INFO - PROCESS | 1680 | Values: 186.0 183.0 186.0 186.0 183.0 181.0 181.0 185.0 183.0 187.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:72.00 Median:78.00 stddev:13.70 (17.6%) stddev-sans-first:14.52 04:50:49 INFO - PROCESS | 1680 | Values: 71.0 76.0 87.0 90.0 55.0 61.0 58.0 80.0 86.0 56.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:80.50 stddev:23.88 (29.7%) stddev-sans-first:25.16 04:50:49 INFO - PROCESS | 1680 | Values: 90.0 97.0 139.0 77.0 79.0 80.0 126.0 81.0 81.0 128.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:92.00 stddev:8.23 (8.9%) stddev-sans-first:8.72 04:50:49 INFO - PROCESS | 1680 | Values: 93.0 90.0 94.0 91.0 93.0 91.0 94.0 91.0 88.0 117.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:97.00 stddev:1.45 (1.5%) stddev-sans-first:1.01 04:50:49 INFO - PROCESS | 1680 | Values: 94.0 97.0 98.0 97.0 97.0 97.0 97.0 100.0 97.0 97.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:92.90 Median:87.00 stddev:17.70 (20.3%) stddev-sans-first:18.68 04:50:49 INFO - PROCESS | 1680 | Values: 98.0 142.0 85.0 87.0 84.0 87.0 85.0 85.0 88.0 88.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:60.00 stddev:6.00 (10.0%) stddev-sans-first:6.32 04:50:49 INFO - PROCESS | 1680 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 79.0 60.0 59.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:72.00 stddev:10.27 (14.3%) stddev-sans-first:10.69 04:50:49 INFO - PROCESS | 1680 | Values: 68.0 63.0 72.0 75.0 72.0 67.0 68.0 67.0 93.0 91.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:83.50 stddev:8.40 (10.1%) stddev-sans-first:8.74 04:50:49 INFO - PROCESS | 1680 | Values: 97.0 100.0 100.0 81.0 83.0 100.0 98.0 98.0 84.0 83.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:140.50 stddev:29.51 (21.0%) stddev-sans-first:31.07 04:50:49 INFO - PROCESS | 1680 | Values: 141.0 140.0 139.0 139.0 139.0 155.0 130.0 140.0 232.0 158.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:177.50 stddev:20.33 (11.5%) stddev-sans-first:21.32 04:50:49 INFO - PROCESS | 1680 | Values: 171.0 173.0 167.0 156.0 156.0 202.0 212.0 206.0 182.0 171.0 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.72 (2.5%) stddev-sans-first:1.56 04:50:49 INFO - PROCESS | 1680 | Values: 71.0 67.0 69.0 68.0 68.0 67.0 67.0 72.0 68.0 68.0 04:50:49 INFO - PROCESS | 1680 | -------- Summary: end -------- 04:50:49 INFO - PROCESS | 1680 | 04:50:49 INFO - TEST-INFO | 1680: exit 0 04:50:49 INFO - TEST-OK | kraken | took 58967ms 04:50:49 INFO - SUITE-END | took 1174s 04:50:50 INFO - Completed test suite (00:19:35) 04:50:50 INFO - javascript benchmark 04:50:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.387138700871, 3408.5398471206386, 3491.5460990071297, 3497.825108744562, 3538.203904121571, 5633.605647604659, 5691.459311365424, 5764.991126552853, 5765.452282033205, 5790.36306006339, 5741.569382296334, 5748.2527271454655, 5883.794067207648, 5906.0, 5921.703914804264, 5160.174372100465, 5194.324737784083, 5201.479852014806, 5248.501392367719, 5336.092864213074, 5270.367555893298, 5338.119210330291, 5350.5452036576935, 5358.115910874701, 5406.972965135169, 5133.409657889353, 5188.974055129738, 5243.9213411798855, 5254.133068043769, 5278.076336641092, 5182.222666600002, 5215.713135777531, 5219.42586315505, 5264.394594621629, 5324.148136298212, 5152.458991805844, 5209.218617207449, 5235.136202526579, 5236.6857988520815, 5295.338082739658, 5515.145152501369, 5669.177969194444, 5683.261176047129, 5716.57125715573, 5725.169850371714, 6113.932424433829, 6181.81454556364, 6216.067589861512, 6220.937790622126, 6225.844353891143, 6126.785562505335, 6149.723262453201, 6168.599041062316, 6174.722137503778, 6186.84532886677, 5658.91511627326, 5855.945929732647, 5861.384554621746, 5863.70681465925, 5886.146508756249, 6155.630662160284, 6176.197094377792, 6227.9377206227355, 6231.3145553989025, 6239.0, 6173.074038894202, 6189.81430557075, 6198.845028874314, 6201.720922558496, 6205.410486003822, 6091.5735898487565, 6110.29731580865, 6157.907631385533, 6158.784442544579, 6168.506519478431, 6080.969595151996, 6092.939070609237, 6116.153172518083, 6138.051223665364, 6158.938410615926, 4772.3557319762085, 6127.479164270998, 6189.566730328834, 6199.597026193283, 6205.937940620536, 4905.264210368402, 4938.654294199371, 4944.554990050912, 4952.182889823211, 4997.925031124536, 4385.736855788663, 4404.031113155101, 4422.668299877458, 4433.467983841895, 4458.598726114666, 5567.721613919288, 5631.436856314418, 5650.067738823131, 5663.773449062074, 5737.397573254748, 6150.231221097363, 6157.230346206724, 6158.784442544489, 6160.969195153995, 6162.784302549389, 5651.2935883014625, 5681.886362272731, 5689.6586204827845, 5689.943100569024, 5749.1663708762835, 5377.731113444391, 5390.51485366319, 5394.352677678625, 5398.325209348832, 5450.264214331094, 6223.377662233831, 6274.6548939808745, 6301.747930082745, 6312.147860038928, 6318.8420289492215, 5833.737481813413, 6152.169457123231, 6155.076738489262, 6160.16837726919, 6164.815055548341, 6265.216847894013, 6305.464035557029, 6305.8108256752375, 6318.273398559225, 6346.555741098079, 6088.299845517645, 6136.94800169746, 6154.292256390393, 6157.014877619559, 6177.81466556004, 6096.817095487142, 6136.488442913377, 6155.507559395327, 6168.845778855564, 6179.196704428396, 6149.96925015372, 6158.815235542941, 6170.598911070766, 6174.44430001302, 6179.258488981351, 5898.439648233411, 6055.848603784941, 6155.692215389123, 6165.260168779775, 6192.535559832941, 4989.750512474289, 5937.168796368598, 5961.314448838439, 5968.492678122235, 5982.7307771149535, 4922.581580565692, 4973.626977976739, 6052.969735151472, 6057.121717351048, 6057.606255593372, 4946.0, 6012.518998480198, 6019.699015049143, 6031.36670649593, 6075.513958883367], "value": 5667.904758274866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.85807973767356, 529.4863981937519, 531.0202676062664, 582.2925145947672, 583.5156819839532, 38550.0, 39864.402033969476, 40111.39832902509, 40127.799361003155, 40144.0, 42327.57672423275, 42362.0, 42517.0, 42530.36204456936, 42723.35914961278, 8675.305975521975, 8889.977652569973, 9585.281103917217, 9851.65519206828, 9853.113219810215, 11725.530978760838, 12037.578684746035, 12076.698082547919, 12085.335306558136, 12088.758224835541, 11678.6496405108, 11779.469923853447, 11790.35153066581, 11791.0, 11798.174127811057, 8776.85900832891, 11630.069594432467, 11861.52553897843, 12115.757684846341, 12133.514659413613, 11654.76690466186, 11748.706282342924, 11792.23350482216, 11807.81921807821, 11863.703407414798, 39287.41068883969, 39605.20789584221, 39655.0, 39817.0, 39835.605753798474, 3347.598288205407, 3362.0586235854, 3367.2087059540986, 3386.762926595139, 3739.7943113128767, 28905.56641650377, 29384.265393365124, 29784.80860765567, 29907.401851963055, 30012.099637010706, 2677.598360245959, 2678.102835550093, 2698.743619356158, 2808.129479861229, 2895.7143427727083, 379868.0, 380319.0, 380445.09777451213, 381611.0, 383282.0, 62406.687966559875, 62853.37146628475, 63138.68430657909, 63269.0, 63308.05037924435, 66433.0, 66871.66564167148, 69727.65136174388, 72340.63829680924, 72463.0, 17012.404565840385, 17219.3973210937, 17294.827051729575, 17306.48080557585, 17310.874793138657, 11927.0, 12173.634790956285, 12911.35443227835, 13160.539381121614, 13162.934185329204, 18342.99113548741, 19304.0, 19544.74842280353, 19961.900190498956, 19991.800081999285, 8119.228673276029, 8245.464044837187, 8249.958750206211, 8267.8346433071, 8306.293965012921, 964.1274646444979, 986.6250824686573, 1001.8046480936293, 1020.8315627921459, 1048.7954848804563, 29144.979925702497, 29464.125694485607, 29654.110376688735, 29751.702482975325, 29866.701332986828, 1048.4548035021746, 1084.208527774729, 1084.7938891610568, 1131.615250814727, 1146.9541218351173, 15105.54683359501, 15183.772243416357, 15265.397133301065, 15461.845381546265, 15481.766767287732, 646298.0, 656885.0, 658323.0, 658874.0, 659024.0, 59136.0, 61771.38228617746, 61901.0, 62171.0, 62245.37754622396, 1327.6017194841702, 1377.1461693749939, 1495.155237290927, 1508.8038554987781, 1555.5566663500847, 28820.711792881804, 28913.855430722713, 28966.13101606955, 29357.559636605896, 29646.258843529085, 48517.27224091571, 48526.75736621294, 48953.2657010138, 49022.0, 49029.0, 443835.0, 450646.68209837493, 452171.0, 452211.0, 452948.0, 23649.408764780328, 24342.391440214138, 24908.50548967068, 26421.0, 27593.44813103767, 43066.13867722565, 43905.0, 45220.77389613163, 45505.77247113876, 46288.8427789308, 35916.64083359238, 37164.0, 37741.0, 38015.80992095022, 38097.85706428812, 35812.104697382776, 36148.638513614525, 36163.45754813627, 36767.0, 37040.444393333586, 37483.625163748016, 37634.43548346722, 37841.81079094697, 38143.42784858285, 38767.03082422962, 30377.69622303749, 31583.052508424786, 31691.683083168875, 31733.682663173997, 31820.0, 24183.032678692656, 24557.38606534851, 24730.25809225726, 24799.13203037885, 25621.615675764504], "value": 20155.47256911832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6899721253659, 394.50686641697877, 396.47269132054373, 405.03399392449, 412.09133859839056, 19813.3065342713, 20801.16795328185, 21047.57904841904, 21057.57884842302, 21384.57230855382, 21283.57432851342, 21315.040823162955, 22277.0, 22295.665565016538, 22350.88245587718, 5792.275965504312, 6162.568620196588, 6171.382861713815, 6172.259328880541, 6174.197354343929, 4274.487061552618, 4561.042181141964, 5844.386339434362, 6393.360663933593, 6764.526483146182, 6632.867342653144, 6728.192616885956, 6730.663466826663, 6731.0, 6752.324767523233, 6515.641639709814, 6658.1344425224415, 6673.5662181958505, 6692.23039350476, 6694.230163531183, 5646.774129034834, 5852.268466441695, 5854.0, 6015.969920150371, 6029.728662210211, 13733.176009439465, 13964.93017534916, 14007.879369650404, 20732.067056982472, 26564.601530977052, 2246.4945387287894, 2294.8623082615095, 2410.8794560271917, 2469.086438017945, 2768.920121152752, 9473.810523789554, 9889.80220395588, 9946.20430365569, 10279.383237005728, 10319.226058045677, 1593.55380493462, 1683.770847281479, 1719.5099396672013, 1754.3771960953804, 1755.4558086993072, 75927.0, 111703.44148279288, 126394.0, 126995.0, 130049.0492642611, 11717.765644687059, 11813.763724725457, 11822.0, 11828.88171118295, 11834.822477662841, 15217.467388641344, 15252.771208431883, 15257.08457492554, 15264.618384540254, 15295.235238238043, 8743.071071191222, 8821.470711757314, 8840.0, 8861.689840855539, 8969.820603588023, 8685.956570217108, 8690.522021288889, 8710.864088927981, 8769.38614297006, 8817.735467935972, 4709.105269998689, 4714.882127946828, 4731.219348807477, 4735.266033764772, 4750.477447480844, 1460.8247010358825, 1792.1530133245337, 1809.556658618647, 1974.2991238110264, 1985.6723640599428, 865.16079402979, 900.5542256583034, 909.0909090909091, 919.9328778616773, 1106.9225154239125, 19357.322493712934, 19871.900640496995, 20157.0, 20904.163833446797, 21365.46586335354, 992.9404235745734, 997.8553109799038, 1005.4570531912832, 1007.3401921741271, 1023.1150055202345, 9521.857172142423, 10786.514606842555, 10803.32548454975, 10974.012338889539, 11036.448177591088, 576039.0, 576799.0, 583344.0, 588775.0, 592167.2741454028, 125784.0, 127961.0, 127982.36008819897, 131410.0, 133371.0, 1028.6245520385005, 1048.2976405808126, 1076.8815430302661, 1094.0372472224392, 1099.3898386395467, 17898.642027159643, 18238.544036399195, 18293.634127317644, 18453.446396608124, 18454.666640138457, 45512.0, 46018.849528762046, 49284.0, 50083.74958125186, 51017.74491127521, 70344.59310813653, 70854.0, 72675.90986135318, 73874.63062684653, 75590.0, 7757.93561543176, 8130.0, 8275.089740128702, 8360.0, 8456.900602921582, 7129.857402851811, 9029.909700902906, 12008.039356851255, 12807.29559874216, 13224.338783061, 11188.88811111911, 11195.2723073, 11384.316940983568, 11502.424878756196, 11733.823992640288, 11102.666919992413, 11103.666889993314, 11188.1608879336, 11196.776064478829, 11260.0, 11399.0, 11682.532698691957, 11691.240069395462, 11717.00405465545, 11813.350265735467, 8180.345572354317, 8194.877076843972, 8386.538740369095, 8557.395159966001, 8643.870341945001, 10679.51942162589, 11333.150013749168, 11442.970132687766, 11657.009154221985, 11756.764864702829], "value": 9578.377288545436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.59859239413, 1605.1974012993503, 1606.3333716507645, 1911.8088191180884, 2048.7131801547785, 7998.800029999245, 8716.084811094832, 8933.463992160476, 8945.10548945105, 8951.0, 8525.97688277406, 8748.518831464267, 8769.473831570094, 8794.076621954682, 8799.428037177579, 2156.5147841735643, 2382.9642555361684, 2424.696912885889, 2461.495393444349, 2474.826762126652, 2458.176510868861, 2484.714257860351, 2484.776370126688, 2491.1281051631872, 2496.87515624219, 2406.4946361264156, 2458.373114855718, 2462.2367066209445, 2462.938426539342, 2463.618139188429, 2024.979750202494, 2124.2458927080897, 2431.7598025007374, 2433.111914151331, 2437.7805997460314, 2429.4290841652196, 2454.5949918263464, 2462.5321188974217, 2467.9881248687952, 2469.4814089041324, 8791.384603077788, 8895.866562001574, 8898.021217666052, 8901.0, 8922.509261990588, 5254.343207099113, 5481.945180548223, 5487.972560137174, 5500.4499550045075, 5533.3083364579425, 3537.8949525032563, 3551.289742051574, 3567.126054116732, 3612.801295928723, 3619.986403806938, 973.9415635061919, 1012.4735137728413, 1014.8883622801486, 1024.774549599087, 1025.4976459486888, 10075.848862267072, 11714.297142171497, 11737.06103511717, 11742.706432339175, 11832.230904991235, 4749.62003039756, 4783.521647835259, 4809.709095800591, 4860.392450943632, 4923.729194894244, 10005.749856253651, 10026.448545330077, 10028.047335503261, 10040.949795250977, 10041.146502547219, 5388.811391601275, 5421.539169170585, 5423.05096608092, 5448.210009548593, 5451.209574611738, 4450.643948484114, 4631.652626053059, 4893.241547560134, 5004.174311238678, 5038.168702164176, 3940.7438516496336, 3990.3016972029777, 4070.3894415837863, 4104.958950410517, 4115.36211887158, 1348.8044233586074, 1358.6535433464403, 1359.2931675528669, 1373.7458570164551, 1377.8484366719654, 916.9266458683289, 925.9074092590822, 939.8966113727485, 973.7030205787162, 992.6277645882794, 5371.6239863209985, 5915.881682366415, 6077.696115194222, 6099.512039036867, 6146.293176284695, 440.19224722633686, 442.40275627902076, 450.9008018235983, 465.47866389643815, 465.66704806063825, 3970.841166353371, 3995.2808494471274, 4076.898077548026, 4078.7552746835286, 4082.2039702258367, 10467.424291664032, 10792.730181745363, 10923.235373523778, 10925.781484370267, 10929.071028962468, 10755.462226888625, 10872.61945831892, 10873.456327183609, 10885.346879187275, 10888.564457421773, 8186.631601577943, 8367.665293388318, 8369.204925532065, 8371.497710137412, 8394.160583941557, 5689.943100569107, 5939.287285525592, 5945.983530837402, 6065.60573562717, 6199.256089269316, 9629.614815407585, 10135.898641013495, 10152.289339746147, 10218.335808172445, 10235.181185505291, 8530.829383412172, 10293.330933489298, 10304.227182961158, 10316.381017138996, 10322.019408156213, 6405.135306733718, 7483.812904677427, 7509.51188172767, 8198.795030124294, 8389.286910612665, 8413.242808147295, 8529.658813647384, 8530.445521041112, 8530.530820804915, 8536.615852286537, 7442.0, 7442.4418168636485, 7526.962365188139, 7661.808454788675, 7672.002639656809, 7366.263373662591, 7388.113426388652, 7431.591262480615, 7434.7769566913075, 7493.962530187314, 7056.54132481387, 7060.82347941285, 7138.785836424916, 7151.42788576923, 7167.820804479929, 4737.549932756383, 4928.359313289249, 4963.801447942042, 5031.622628302819, 5090.872728181825, 4833.9274910875665, 4911.435184953776, 4918.631102667243, 5047.394312682502, 5193.584513238856], "value": 4569.655538544176, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.7019406079072, 311.12108294069253, 320.81232478999783, 324.2105473172823, 326.13736666517065, 5739.196512488255, 5867.069063727313, 5871.2367392239, 5877.911831322528, 5981.671008094553, 5189.896202075956, 5266.736663166846, 5858.88282234355, 5875.9118613220835, 5907.5864689471755, 4240.745555266679, 4343.326784348431, 4437.201303765313, 4480.507144214133, 4498.932516012246, 3628.444124757739, 4341.544137865526, 4451.532589078132, 4486.955130448687, 4506.039872655389, 4365.716228445141, 4397.692161548693, 4410.691251612388, 4415.315626077963, 4419.337099435094, 4394.231009573312, 4408.691391602573, 4430.4240448741775, 4432.15789000089, 4452.821887124511, 2906.0, 3757.2354855538824, 3816.2367526494536, 3821.751586146919, 3834.1373191032076, 5453.863653408657, 5629.155626655994, 5651.660900345952, 5661.8584535386535, 5676.801311954062, 4226.387173859773, 4250.532441431471, 4696.976515117437, 4703.988642441891, 5102.183650615883, 5181.357507671115, 6003.699815009276, 6213.260287119614, 6217.502599792051, 6236.7235958875135, 4182.707210495267, 4226.1336426032585, 4229.6404805591565, 4239.427677263561, 4240.936385954213, 5789.263221033673, 6167.779599344232, 6239.37606239377, 6533.934660653427, 6584.209894812653, 4168.333066709312, 4349.847755328548, 4357.586029327209, 4358.215521206213, 4358.455193100863, 4364.585364390377, 4404.361367601744, 4406.845760398371, 4408.184485870061, 4419.226635338803, 4507.3689683444345, 4845.370101886732, 5147.536721695065, 5189.636725429184, 5195.3246078009615, 6239.909630273818, 6301.550643351963, 6306.905396419057, 6327.873442531123, 6336.936630633727, 1494.2080697230485, 1527.747921592947, 1532.578540901261, 1535.3474773221337, 1538.230884557721, 900.9414388064755, 974.2498276327331, 1009.8689467796115, 1023.3808545829814, 1027.9023492768174, 4817.9036419271415, 5330.440303768126, 5717.599768016282, 5847.947369473451, 5871.911921321183, 4995.650304478724, 5409.540189083972, 6487.124238227873, 6492.837679058061, 6634.800955971328, 5667.773289068391, 5810.709464526842, 5818.5054270386645, 5822.970885145547, 5843.2403787507355, 2837.929051773681, 3390.660933906639, 3416.350893330259, 3436.9312613748084, 3441.1245871000365, 6032.728527216286, 6418.550701450947, 6567.9671601641685, 6807.523473356818, 6990.161180658353, 5294.841154765363, 6803.897941530881, 6811.284815094443, 6837.307853759014, 6841.144856892888, 6501.8699626008165, 6918.377346038881, 6944.826379340456, 6957.234704182536, 6992.16094068715, 6568.540202185801, 6575.210974683068, 6592.934285557239, 6594.472442204708, 6623.4038936495945, 6370.0, 6462.644554549545, 6477.676116194078, 6483.805485835433, 6535.150430444012, 4917.926231106465, 6885.621290829053, 6894.449053850108, 6900.413464855343, 7005.194402643558, 4071.6742660587674, 4208.211510108253, 4268.886900984033, 4286.1641979814885, 4307.8276868924895, 6423.64669943139, 6594.637294948632, 6611.867762644816, 6618.113837556273, 6621.172353455818, 5268.341457317835, 5519.668819870821, 6398.232212134573, 6399.55203135776, 6411.4870810336, 5263.73681315925, 5578.358488773681, 6143.447089761764, 6403.8399040022505, 6418.422341989243, 5571.832845014656, 5628.352739434854, 6091.543134264859, 6217.129601855653, 6227.19046523949, 4833.564979151894, 5645.588602849288, 5750.48245657876, 5787.189793429007, 6409.070684750778, 5905.291365036223, 6213.689315534296, 6250.093736408105, 6262.279837818709, 6263.843403914939], "value": 4565.10673765851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.4554351572922, 646.0438550944602, 714.5819695478145, 747.8766003609405, 750.9962450187749, 12320.507179712811, 15403.0, 15408.460703875367, 15414.768778468318, 15481.225938703063, 13967.580972570813, 14016.579502614912, 14038.508652197175, 14060.296985150753, 14086.366113524891, 700.4011570107562, 726.5858460677416, 876.701921346742, 918.9954050229773, 924.3899026642417, 908.6728777640044, 910.7495438754362, 923.2521657457447, 923.445932440537, 924.4453328003178, 966.4201479112546, 980.2794945714929, 981.9116279534841, 982.670805280232, 985.5220218194206, 742.6175519607407, 943.3019565521499, 973.5083782689696, 977.291463688827, 978.6525783346881, 723.6924307169485, 723.8660847743184, 724.8151721311085, 725.6263024542365, 726.4478995963053, 15129.243537823175, 15540.300686469023, 15579.532614021597, 15585.610359741097, 15600.92199538995, 13063.477460901648, 13109.541166059238, 13126.409311581001, 13293.13594616347, 13371.86628133716, 8355.707550235773, 10279.17766578672, 10318.403556492633, 10340.534675939525, 10531.947340263327, 3505.4040813061843, 3513.4905438711244, 3525.6474352564796, 3629.5644522657185, 3648.872289469882, 60084.69957650184, 70879.58240835206, 76440.0, 77100.84348734774, 79597.40805183863, 9785.706428807147, 9820.224607285505, 9846.60613575449, 10032.69901902944, 10652.573897044187, 22546.985385657685, 22643.88678056632, 22692.65961010586, 22710.0, 22712.772872271395, 7638.656260468292, 7916.683332666744, 8068.193180681885, 8155.143709910492, 8155.714549990722, 4121.175764846983, 4123.9175216495505, 4135.813888375031, 4146.813393397304, 4166.0626359068965, 3682.429223470366, 3745.194783121642, 3750.9437358439645, 3754.0614846288427, 3759.661630453272, 659.5350278054057, 669.4109183918121, 676.5162908520432, 677.6984242012257, 679.4530403025514, 545.5226676657925, 598.9011813050798, 599.9370066142992, 601.7472661482101, 609.2384519350811, 7502.437317201232, 7836.764897053097, 7930.9603451982375, 7992.68029278834, 8275.917240827635, 554.8196836028307, 578.6094386289238, 594.1266338482424, 598.0729868703493, 599.3467120838308, 3651.6713495785507, 3838.05967537955, 3894.5131858517684, 3944.4872166618156, 4090.5909409058854, 73412.63293683605, 75896.48207035939, 76194.0, 93639.0, 94040.05959940313, 57123.85818779924, 57402.13896791552, 59376.0, 72264.27735722576, 74030.0, 61918.69040654768, 64551.0, 66828.0, 67647.32352676509, 68850.96723549251, 7938.04743430792, 7993.760187194393, 8004.279614834692, 8181.2636862680265, 8373.37199710012, 42206.577934220266, 42531.78734106434, 44100.0, 44239.778801105786, 46020.0, 61317.080243797274, 64078.67960660167, 64174.18693597906, 64402.03396948956, 64451.0, 10931.398773067558, 10998.780024399308, 11096.112311014938, 11212.215144939775, 11292.943535282271, 11631.709207269885, 11794.233374830952, 11900.0, 12026.879731202576, 12271.386430678609, 11431.828522572334, 11653.825192621947, 11704.180707350404, 11759.47082381312, 11795.469203885674, 11361.695966288402, 11703.590374336858, 11751.647450576496, 12043.0, 12336.50653973831, 9948.452835093849, 11311.547538098714, 11343.432828358715, 11465.828012579985, 11576.0, 7400.40796736249, 9312.48781317034, 9471.337006409485, 9505.572249248939, 9607.711768646952, 9261.16649501548, 9374.5781439834, 9427.434353938786, 9453.763655908657, 9471.573779179816], "value": 6824.554497804927, "unit": "score"}], "name": "dromaeo_css", "value": 7335.443493749661, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 105.0, 113.0, 112.0, 114.0, 114.0, 114.0, 104.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 121.0, 146.0, 169.0, 119.0, 142.0, 141.0, 119.0, 172.0, 117.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 186.0, 186.0, 183.0, 181.0, 181.0, 185.0, 183.0, 187.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 87.0, 90.0, 55.0, 61.0, 58.0, 80.0, 86.0, 56.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 97.0, 139.0, 77.0, 79.0, 80.0, 126.0, 81.0, 81.0, 128.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 94.0, 91.0, 93.0, 91.0, 94.0, 91.0, 88.0, 117.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 98.0, 97.0, 97.0, 97.0, 97.0, 100.0, 97.0, 97.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 142.0, 85.0, 87.0, 84.0, 87.0, 85.0, 85.0, 88.0, 88.0], "value": 92.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 79.0, 60.0, 59.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 72.0, 75.0, 72.0, 67.0, 68.0, 67.0, 93.0, 91.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 100.0, 100.0, 81.0, 83.0, 100.0, 98.0, 98.0, 84.0, 83.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 139.0, 139.0, 139.0, 155.0, 130.0, 140.0, 232.0, 158.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 167.0, 156.0, 156.0, 202.0, 212.0, 206.0, 182.0, 171.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 69.0, 68.0, 68.0, 67.0, 67.0, 72.0, 68.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1517.2, "alertThreshold": 2.0}]} 04:50:50 INFO - Return code: 0 04:50:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:50:50 ERROR - # TBPL SUCCESS # 04:50:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:50:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:50:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:50:50 INFO - 2016-04-23 04:50:50.492 screenresolution[1684:10021] starting screenresolution argv=screenresolution get 04:50:50 INFO - 2016-04-23 04:50:50.494 screenresolution[1684:10021] Display 0: 1600x1200x32@60 04:50:50 INFO - 2016-04-23 04:50:50.500 screenresolution[1685:10024] starting screenresolution argv=screenresolution list 04:50:50 INFO - Available Modes on Display 0 04:50:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:50:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:50:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:50:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:50:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:50:50 INFO - Intel Iris: 04:50:50 INFO - Chipset Model: Intel Iris 04:50:50 INFO - Type: GPU 04:50:50 INFO - Bus: Built-In 04:50:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:50:50 INFO - Vendor: Intel (0x8086) 04:50:50 INFO - Device ID: 0x0a2e 04:50:50 INFO - Revision ID: 0x0009 04:50:50 INFO - Displays: 04:50:50 INFO - Display: 04:50:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:50:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:50:50 INFO - Display Serial Number: 1600x1200 60 04:50:50 INFO - Main Display: Yes 04:50:50 INFO - Mirror: Off 04:50:50 INFO - Online: Yes 04:50:50 INFO - Rotation: Supported 04:50:50 INFO - Return code: 0 04:50:50 INFO - Running post-action listener: _resource_record_post_action 04:50:50 INFO - Running post-run listener: _resource_record_post_run 04:50:51 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32402944; Write bytes: 695328256; Read time: 322; Write time: 2143 04:50:51 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 384481792; Write bytes: 378779136; Read time: 30280; Write time: 867 04:50:51 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30645760; Write bytes: 296757248; Read time: 304; Write time: 1230 04:50:51 INFO - Running post-run listener: _upload_blobber_files 04:50:51 INFO - Blob upload gear active. 04:50:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:50:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:50:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:50:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:50:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:50:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:52 INFO - (blobuploader) - INFO - Done attempting. 04:50:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:50:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:53 INFO - (blobuploader) - INFO - Done attempting. 04:50:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:50:53 INFO - Return code: 0 04:50:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:50:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:50:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4bbc824fca0d2a02ee81b82d1d534ae057d15248a8219835e7743c5674a8e23a8fa0c787764dcd6a50489a052402425a03839a21afd8bd3f454eb0c9b076290e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af0bcc420c65d7125ae70a5c0c62ba9229c16a01b1bcb2615cc2c0ca4903453fe8633bd86661e95428067cc98b2e4d5362b98b2b87070a3c201f5175b4ac5d0"} 04:50:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:50:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:50:53 INFO - Contents: 04:50:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4bbc824fca0d2a02ee81b82d1d534ae057d15248a8219835e7743c5674a8e23a8fa0c787764dcd6a50489a052402425a03839a21afd8bd3f454eb0c9b076290e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af0bcc420c65d7125ae70a5c0c62ba9229c16a01b1bcb2615cc2c0ca4903453fe8633bd86661e95428067cc98b2e4d5362b98b2b87070a3c201f5175b4ac5d0"} 04:50:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:50:53 INFO - Copying logs to upload dir... 04:50:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:50:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.354490 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-23 04:50:53.965475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 04:50:53.968602) ========= 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.N3Uovh4q97/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.8lsmCQThTr/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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/4bbc824fca0d2a02ee81b82d1d534ae057d15248a8219835e7743c5674a8e23a8fa0c787764dcd6a50489a052402425a03839a21afd8bd3f454eb0c9b076290e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af0bcc420c65d7125ae70a5c0c62ba9229c16a01b1bcb2615cc2c0ca4903453fe8633bd86661e95428067cc98b2e4d5362b98b2b87070a3c201f5175b4ac5d0"} build_url:https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/a6u-cI5kR4qz3wj3RXw9kQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4bbc824fca0d2a02ee81b82d1d534ae057d15248a8219835e7743c5674a8e23a8fa0c787764dcd6a50489a052402425a03839a21afd8bd3f454eb0c9b076290e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af0bcc420c65d7125ae70a5c0c62ba9229c16a01b1bcb2615cc2c0ca4903453fe8633bd86661e95428067cc98b2e4d5362b98b2b87070a3c201f5175b4ac5d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 04:50:53.996859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:50:53.997202) ========= 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.N3Uovh4q97/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.8lsmCQThTr/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.004758 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 04:50:54.046563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 04:50:54.046894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 04:50:54.047340) ========= ========= Total master_lag: 0.16 =========