builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0135 starttime: 1457575499.48 results: success (0) buildid: 20160309154625 builduid: eeb220edee3c4fa78e4ddb5f0a0f644d revision: 26e576786f9dbf101119be083c2743803e9ced5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:04:59.476676) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:04:59.477151) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:04:59.477452) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005541 basedir: '/builds/slave/test' ========= master_lag: 0.99 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:00.474304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:00.474620) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:00.941738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:00.942637) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005491 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:01.087976) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:01.088273) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:01.088606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:01.088897) ========= 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.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-03-09 18:05:01-- 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% 15.6M=0.001s 2016-03-09 18:05:01 (15.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.550379 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:01.710919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-09 18:05:01.711252) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.025831 ========= master_lag: 3.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-09 18:05:04.816195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 18:05:04.816538) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 26e576786f9dbf101119be083c2743803e9ced5f --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 26e576786f9dbf101119be083c2743803e9ced5f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-03-09 18:05:05,038 truncating revision to first 12 chars 2016-03-09 18:05:05,038 Setting DEBUG logging. 2016-03-09 18:05:05,038 attempt 1/10 2016-03-09 18:05:05,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/26e576786f9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 18:05:07,132 unpacking tar archive at: fx-team-26e576786f9d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.341608 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 18:05:07.713450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:07.713801) ========= echo 26e576786f9dbf101119be083c2743803e9ced5f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'26e576786f9dbf101119be083c2743803e9ced5f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 26e576786f9dbf101119be083c2743803e9ced5f program finished with exit code 0 elapsedTime=0.006028 script_repo_revision: '26e576786f9dbf101119be083c2743803e9ced5f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:07.756180) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:07.756518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:05:07.797030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-09 18:05:07.797376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:07 INFO - MultiFileLogger online at 20160309 18:05:07 in /builds/slave/test 18:05:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:05:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:05:07 INFO - {'append_to_log': False, 18:05:07 INFO - 'base_work_dir': '/builds/slave/test', 18:05:07 INFO - 'blob_upload_branch': 'Fx-Team', 18:05:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:05:07 INFO - 'branch': 'Fx-Team', 18:05:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:05:07 INFO - 'config_files': ('talos/mac_config.py',), 18:05:07 INFO - 'default_actions': ('clobber', 18:05:07 INFO - 'read-buildbot-config', 18:05:07 INFO - 'download-and-extract', 18:05:07 INFO - 'populate-webroot', 18:05:07 INFO - 'create-virtualenv', 18:05:07 INFO - 'install', 18:05:07 INFO - 'run-tests'), 18:05:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:05:07 INFO - 'download_minidump_stackwalk': True, 18:05:07 INFO - 'download_symbols': 'ondemand', 18:05:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:05:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:05:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:05:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:05:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:05:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:05:07 INFO - 'installer_path': 'installer.exe', 18:05:07 INFO - 'log_level': 'info', 18:05:07 INFO - 'log_name': 'talos', 18:05:07 INFO - 'log_to_console': True, 18:05:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:05:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:05:07 INFO - 'opt_config_files': (), 18:05:07 INFO - 'pip_index': False, 18:05:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:05:07 INFO - 'cmd': ('bash', 18:05:07 INFO - '-c', 18:05:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:05:07 INFO - 'enabled': True, 18:05:07 INFO - 'halt_on_failure': False, 18:05:07 INFO - 'name': 'check_screen_resolution'},), 18:05:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:05:07 INFO - 'cmd': ('bash', 18:05:07 INFO - '-c', 18:05:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:05:07 INFO - 'enabled': True, 18:05:07 INFO - 'halt_on_failure': False, 18:05:07 INFO - 'name': 'check_screen_resolution'},), 18:05:07 INFO - 'run_cmd_checks_enabled': True, 18:05:07 INFO - 'sps_profile': False, 18:05:07 INFO - 'sps_profile_interval': 0, 18:05:07 INFO - 'suite': 'dromaeojs-e10s', 18:05:07 INFO - 'system_bits': '32', 18:05:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:05:07 INFO - 'title': 't-yosemite-r7-0135', 18:05:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:05:07 INFO - 'use_talos_json': True, 18:05:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:05:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:05:07 INFO - 'work_dir': 'build'} 18:05:07 INFO - ##### 18:05:07 INFO - ##### Running clobber step. 18:05:07 INFO - ##### 18:05:07 INFO - Running pre-action listener: _resource_record_pre_action 18:05:07 INFO - Running main action method: clobber 18:05:07 INFO - rmtree: /builds/slave/test/build 18:05:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:05:10 INFO - Running post-action listener: _resource_record_post_action 18:05:10 INFO - ##### 18:05:10 INFO - ##### Running read-buildbot-config step. 18:05:10 INFO - ##### 18:05:10 INFO - Running pre-action listener: _resource_record_pre_action 18:05:10 INFO - Running main action method: read_buildbot_config 18:05:10 INFO - Using buildbot properties: 18:05:10 INFO - { 18:05:10 INFO - "project": "", 18:05:10 INFO - "product": "firefox", 18:05:10 INFO - "script_repo_revision": "production", 18:05:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:05:10 INFO - "repository": "", 18:05:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:05:10 INFO - "buildid": "20160309154625", 18:05:10 INFO - "pgo_build": "False", 18:05:10 INFO - "basedir": "/builds/slave/test", 18:05:10 INFO - "buildnumber": 489, 18:05:10 INFO - "slavename": "t-yosemite-r7-0135", 18:05:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:05:10 INFO - "platform": "yosemite_r7", 18:05:10 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 18:05:10 INFO - "branch": "fx-team", 18:05:10 INFO - "repo_path": "integration/fx-team", 18:05:10 INFO - "revision": "26e576786f9dbf101119be083c2743803e9ced5f", 18:05:10 INFO - "stage_platform": "macosx64", 18:05:10 INFO - "builduid": "eeb220edee3c4fa78e4ddb5f0a0f644d", 18:05:10 INFO - "slavebuilddir": "test" 18:05:10 INFO - } 18:05:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:05:10 INFO - Running post-action listener: _resource_record_post_action 18:05:10 INFO - ##### 18:05:10 INFO - ##### Running download-and-extract step. 18:05:10 INFO - ##### 18:05:10 INFO - Running pre-action listener: _resource_record_pre_action 18:05:10 INFO - Running main action method: download_and_extract 18:05:10 INFO - mkdir: /builds/slave/test/build/tests 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:10 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:11 INFO - Downloaded 1199 bytes. 18:05:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:05:11 INFO - Using the following test package requirements: 18:05:11 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:05:11 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:05:11 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:05:11 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'jsshell-mac.zip'], 18:05:11 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:05:11 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:05:11 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:05:11 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:05:11 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:05:11 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:05:11 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:05:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:11 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:05:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:05:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:05:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:13 INFO - Downloaded 17866293 bytes. 18:05:13 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'] 18:05:13 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 18:05:16 INFO - Return code: 0 18:05:16 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 18:05:16 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')]} 18:05:16 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:17 INFO - Downloaded 17866293 bytes. 18:05:17 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'] 18:05:17 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 18:05:20 INFO - Return code: 0 18:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:20 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:21 INFO - Downloaded 10845161 bytes. 18:05:21 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'] 18:05:21 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 18:05:21 INFO - Return code: 0 18:05: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')]} 18:05:21 INFO - https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:05:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:05:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:05:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SyinLjrPQ4CelEGiqtn09w/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 18:05:31 INFO - Downloaded 110926064 bytes. 18:05:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:05:31 INFO - mkdir: /builds/slave/test/properties 18:05:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:05:31 INFO - Writing to file /builds/slave/test/properties/build_url 18:05:31 INFO - Contents: 18:05:31 INFO - build_url:https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:05:33 INFO - Running post-action listener: _resource_record_post_action 18:05:33 INFO - Running post-action listener: set_extra_try_arguments 18:05:33 INFO - ##### 18:05:33 INFO - ##### Running populate-webroot step. 18:05:33 INFO - ##### 18:05:33 INFO - Running pre-action listener: _resource_record_pre_action 18:05:33 INFO - Running main action method: populate_webroot 18:05:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:05:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:05:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:05:33 INFO - '--tppagecycles', 18:05:33 INFO - '7'], 18:05:33 INFO - 'tests': ['tsvgm']}}, 18:05:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:05:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:05:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:05:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:05:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:05:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:05:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'tests': ['damp', 'tps']}, 18:05:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['damp', 'tps']}, 18:05:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:05:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:05:33 INFO - 'other': {'tests': ['a11yr', 18:05:33 INFO - 'ts_paint', 18:05:33 INFO - 'tpaint', 18:05:33 INFO - 'sessionrestore', 18:05:33 INFO - 'sessionrestore_no_auto_restore', 18:05:33 INFO - 'tabpaint']}, 18:05:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['a11yr', 18:05:33 INFO - 'ts_paint', 18:05:33 INFO - 'tpaint', 18:05:33 INFO - 'sessionrestore', 18:05:33 INFO - 'sessionrestore_no_auto_restore', 18:05:33 INFO - 'tabpaint']}, 18:05:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['a11yr', 18:05:33 INFO - 'ts_paint', 18:05:33 INFO - 'tpaint', 18:05:33 INFO - 'sessionrestore', 18:05:33 INFO - 'sessionrestore_no_auto_restore', 18:05:33 INFO - 'tabpaint']}, 18:05:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['a11yr', 18:05:33 INFO - 'ts_paint', 18:05:33 INFO - 'tpaint', 18:05:33 INFO - 'sessionrestore', 18:05:33 INFO - 'sessionrestore_no_auto_restore', 18:05:33 INFO - 'tabpaint']}, 18:05:33 INFO - 'other_l64': {'tests': ['a11yr', 18:05:33 INFO - 'ts_paint', 18:05:33 INFO - 'tpaint', 18:05:33 INFO - 'sessionrestore', 18:05:33 INFO - 'sessionrestore_no_auto_restore', 18:05:33 INFO - 'tabpaint']}, 18:05:33 INFO - 'other_nol64': {'tests': ['a11yr', 18:05:33 INFO - 'ts_paint', 18:05:33 INFO - 'tpaint', 18:05:33 INFO - 'sessionrestore', 18:05:33 INFO - 'sessionrestore_no_auto_restore', 18:05:33 INFO - 'tabpaint']}, 18:05:33 INFO - 'svgr': {'tests': ['tsvgx', 18:05:33 INFO - 'tsvgr_opacity', 18:05:33 INFO - 'tart', 18:05:33 INFO - 'tscrollx', 18:05:33 INFO - 'cart']}, 18:05:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['tsvgx', 18:05:33 INFO - 'tsvgr_opacity', 18:05:33 INFO - 'tart', 18:05:33 INFO - 'tscrollx', 18:05:33 INFO - 'cart']}, 18:05:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'tests': ['tp5o']}, 18:05:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'talos_options': ['--e10s'], 18:05:33 INFO - 'tests': ['tp5o']}, 18:05:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'talos_options': ['--xperf_path', 18:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:05:33 INFO - 'tests': ['tp5n']}, 18:05:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:33 INFO - 'talos_options': ['--e10s', 18:05:33 INFO - '--xperf_path', 18:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:05:33 INFO - 'tests': ['tp5n']}}, 18:05:33 INFO - 'talos.zip': {'path': '', 18:05:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:05:33 INFO - Running post-action listener: _resource_record_post_action 18:05:33 INFO - ##### 18:05:33 INFO - ##### Running create-virtualenv step. 18:05:33 INFO - ##### 18:05:33 INFO - Running pre-action listener: _resource_record_pre_action 18:05:33 INFO - Running main action method: create_virtualenv 18:05:33 INFO - Creating virtualenv /builds/slave/test/build/venv 18:05:33 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 18:05:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:05:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:05:33 INFO - Using real prefix '/tools/python27' 18:05:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:05:34 INFO - Installing distribute.............................................................................................................................................................................................done. 18:05:37 INFO - Installing pip.................done. 18:05:37 INFO - Return code: 0 18:05:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:05:37 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')]} 18:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:37 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')]} 18:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:37 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:37 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 18:05:37 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 18:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:37 INFO - 'HOME': '/Users/cltbld', 18:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:37 INFO - 'LOGNAME': 'cltbld', 18:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:37 INFO - 'MOZ_NO_REMOTE': '1', 18:05:37 INFO - 'NO_EM_RESTART': '1', 18:05:37 INFO - 'PAGER': '/bin/cat', 18:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:37 INFO - 'PWD': '/builds/slave/test', 18:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:37 INFO - 'SHELL': '/bin/bash', 18:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:37 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:37 INFO - 'USER': 'cltbld', 18:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:37 INFO - 'XPC_FLAGS': '0x0', 18:05:37 INFO - 'XPC_SERVICE_NAME': '0', 18:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:37 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 18:05:37 INFO - Cleaning up... 18:05:37 INFO - Return code: 0 18:05:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:05:37 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')]} 18:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:37 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')]} 18:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:37 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:37 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 18:05:37 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 18:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:37 INFO - 'HOME': '/Users/cltbld', 18:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:37 INFO - 'LOGNAME': 'cltbld', 18:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:37 INFO - 'MOZ_NO_REMOTE': '1', 18:05:37 INFO - 'NO_EM_RESTART': '1', 18:05:37 INFO - 'PAGER': '/bin/cat', 18:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:37 INFO - 'PWD': '/builds/slave/test', 18:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:37 INFO - 'SHELL': '/bin/bash', 18:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:37 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:37 INFO - 'USER': 'cltbld', 18:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:37 INFO - 'XPC_FLAGS': '0x0', 18:05:37 INFO - 'XPC_SERVICE_NAME': '0', 18:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:37 INFO - Downloading/unpacking psutil>=0.7.1 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:40 INFO - Installing collected packages: psutil 18:05:40 INFO - Running setup.py install for psutil 18:05:40 INFO - building 'psutil._psutil_osx' extension 18:05:40 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 18:05:41 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 18:05:41 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 18:05:41 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 18:05:41 INFO - building 'psutil._psutil_posix' extension 18:05:41 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 18:05:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:05:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:05:41 INFO - ^ 18:05:41 INFO - 1 warning generated. 18:05:41 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 18:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:41 INFO - Successfully installed psutil 18:05:41 INFO - Cleaning up... 18:05:41 INFO - Return code: 0 18:05:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:05:41 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')]} 18:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:41 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')]} 18:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:41 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:41 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 18:05:41 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 18:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:41 INFO - 'HOME': '/Users/cltbld', 18:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:41 INFO - 'LOGNAME': 'cltbld', 18:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:41 INFO - 'MOZ_NO_REMOTE': '1', 18:05:41 INFO - 'NO_EM_RESTART': '1', 18:05:41 INFO - 'PAGER': '/bin/cat', 18:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:41 INFO - 'PWD': '/builds/slave/test', 18:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:41 INFO - 'SHELL': '/bin/bash', 18:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:41 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:41 INFO - 'USER': 'cltbld', 18:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:41 INFO - 'XPC_FLAGS': '0x0', 18:05:41 INFO - 'XPC_SERVICE_NAME': '0', 18:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:05:41 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 18:05:41 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 18:05:41 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 18:05:41 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 18:05:41 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 18:05:41 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 18:05:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:05:44 INFO - Installing collected packages: mozsystemmonitor 18:05:44 INFO - Running setup.py install for mozsystemmonitor 18:05:44 INFO - Successfully installed mozsystemmonitor 18:05:44 INFO - Cleaning up... 18:05:44 INFO - Return code: 0 18:05:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:05:44 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')]} 18:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:44 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')]} 18:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:44 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:44 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 18:05:44 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 18:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:44 INFO - 'HOME': '/Users/cltbld', 18:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:44 INFO - 'LOGNAME': 'cltbld', 18:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:44 INFO - 'MOZ_NO_REMOTE': '1', 18:05:44 INFO - 'NO_EM_RESTART': '1', 18:05:44 INFO - 'PAGER': '/bin/cat', 18:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:44 INFO - 'PWD': '/builds/slave/test', 18:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:44 INFO - 'SHELL': '/bin/bash', 18:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:44 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:44 INFO - 'USER': 'cltbld', 18:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:44 INFO - 'XPC_FLAGS': '0x0', 18:05:44 INFO - 'XPC_SERVICE_NAME': '0', 18:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:44 INFO - Downloading/unpacking blobuploader==1.2.4 18:05:44 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 18:05:44 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 18:05:44 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 18:05:44 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 18:05:44 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 18:05:44 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 18:05:47 INFO - Downloading blobuploader-1.2.4.tar.gz 18:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:05:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:05:47 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 18:05:47 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 18:05:47 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 18:05:47 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 18:05:47 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 18:05:47 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 18:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:05:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:05:47 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 18:05:47 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 18:05:47 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 18:05:47 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 18:05:47 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 18:05:47 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 18:05:48 INFO - Downloading docopt-0.6.1.tar.gz 18:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:05:48 INFO - Installing collected packages: blobuploader, requests, docopt 18:05:48 INFO - Running setup.py install for blobuploader 18:05:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:05:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:05:48 INFO - Running setup.py install for requests 18:05:48 INFO - Running setup.py install for docopt 18:05:49 INFO - Successfully installed blobuploader requests docopt 18:05:49 INFO - Cleaning up... 18:05:49 INFO - Return code: 0 18:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:49 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:49 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 18:05:49 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 18:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:49 INFO - 'HOME': '/Users/cltbld', 18:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:49 INFO - 'LOGNAME': 'cltbld', 18:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:49 INFO - 'MOZ_NO_REMOTE': '1', 18:05:49 INFO - 'NO_EM_RESTART': '1', 18:05:49 INFO - 'PAGER': '/bin/cat', 18:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:49 INFO - 'PWD': '/builds/slave/test', 18:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:49 INFO - 'SHELL': '/bin/bash', 18:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:49 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:49 INFO - 'USER': 'cltbld', 18:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:49 INFO - 'XPC_FLAGS': '0x0', 18:05:49 INFO - 'XPC_SERVICE_NAME': '0', 18:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-P6xRCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-pVKgn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-44kxLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sQxFmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-3tX0DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4sznqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-h5ig34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-U3R7wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-uMpJui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-H9YXuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-9M__c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-gY9bvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-lsH6Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aOVEUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:50 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-E7EbzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:51 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-MHJFzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:51 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-WcNW24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:05:51 INFO - Running setup.py install for manifestparser 18:05:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:05:51 INFO - Running setup.py install for mozcrash 18:05:51 INFO - Running setup.py install for mozdebug 18:05:51 INFO - Running setup.py install for mozdevice 18:05:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:05:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:05:51 INFO - Running setup.py install for mozfile 18:05:51 INFO - Running setup.py install for mozhttpd 18:05:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Running setup.py install for mozinfo 18:05:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Running setup.py install for mozInstall 18:05:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Running setup.py install for mozleak 18:05:52 INFO - Running setup.py install for mozlog 18:05:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Running setup.py install for moznetwork 18:05:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:05:52 INFO - Running setup.py install for mozprocess 18:05:53 INFO - Running setup.py install for mozprofile 18:05:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:05:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:05:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:05:53 INFO - Running setup.py install for mozrunner 18:05:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:05:53 INFO - Running setup.py install for mozscreenshot 18:05:53 INFO - Running setup.py install for moztest 18:05:53 INFO - Running setup.py install for mozversion 18:05:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:05:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:05:53 INFO - Cleaning up... 18:05:53 INFO - Return code: 0 18:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:53 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:53 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 18:05:53 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 18:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:53 INFO - 'HOME': '/Users/cltbld', 18:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:53 INFO - 'LOGNAME': 'cltbld', 18:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:53 INFO - 'MOZ_NO_REMOTE': '1', 18:05:53 INFO - 'NO_EM_RESTART': '1', 18:05:53 INFO - 'PAGER': '/bin/cat', 18:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:53 INFO - 'PWD': '/builds/slave/test', 18:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:53 INFO - 'SHELL': '/bin/bash', 18:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:53 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:53 INFO - 'USER': 'cltbld', 18:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:53 INFO - 'XPC_FLAGS': '0x0', 18:05:53 INFO - 'XPC_SERVICE_NAME': '0', 18:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-rULVSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-5uIV3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-bR5oUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CnJNqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-pN7TTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-6aunPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sJfrK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CT7rmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:54 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)) 18:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-X5DKeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-MhFvBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-0z80GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-0EsFqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-rQexfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-gkr4Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-63OZzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-nNjeby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:55 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)) 18:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-I03NEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:55 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)) 18:05:55 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)) 18:05:55 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)) 18:05:55 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)) 18:05:55 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)) 18:05:55 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)) 18:05:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:55 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 18:05:55 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 18:05:55 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 18:05:55 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 18:05:55 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 18:05:55 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 18:05:58 INFO - Downloading blessings-1.6.tar.gz 18:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:58 INFO - Installing collected packages: blessings 18:05:58 INFO - Running setup.py install for blessings 18:05:58 INFO - Successfully installed blessings 18:05:58 INFO - Cleaning up... 18:05:58 INFO - Return code: 0 18:05:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:58 INFO - Reading from file tmpfile_stdout 18:05:58 INFO - Current package versions: 18:05:58 INFO - blessings == 1.6 18:05:58 INFO - blobuploader == 1.2.4 18:05:58 INFO - docopt == 0.6.1 18:05:58 INFO - manifestparser == 1.1 18:05:58 INFO - mozInstall == 1.12 18:05:58 INFO - mozcrash == 0.17 18:05:58 INFO - mozdebug == 0.1 18:05:58 INFO - mozdevice == 0.48 18:05:58 INFO - mozfile == 1.2 18:05:58 INFO - mozhttpd == 0.7 18:05:58 INFO - mozinfo == 0.9 18:05:58 INFO - mozleak == 0.1 18:05:58 INFO - mozlog == 3.1 18:05:58 INFO - moznetwork == 0.27 18:05:58 INFO - mozprocess == 0.22 18:05:58 INFO - mozprofile == 0.28 18:05:58 INFO - mozrunner == 6.11 18:05:58 INFO - mozscreenshot == 0.1 18:05:58 INFO - mozsystemmonitor == 0.0 18:05:58 INFO - moztest == 0.7 18:05:58 INFO - mozversion == 1.4 18:05:58 INFO - psutil == 3.1.1 18:05:58 INFO - requests == 1.2.3 18:05:58 INFO - wsgiref == 0.1.2 18:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:58 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:58 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 18:05:58 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 18:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:58 INFO - 'HOME': '/Users/cltbld', 18:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:58 INFO - 'LOGNAME': 'cltbld', 18:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:58 INFO - 'MOZ_NO_REMOTE': '1', 18:05:58 INFO - 'NO_EM_RESTART': '1', 18:05:58 INFO - 'PAGER': '/bin/cat', 18:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:58 INFO - 'PWD': '/builds/slave/test', 18:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:58 INFO - 'SHELL': '/bin/bash', 18:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:58 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:58 INFO - 'USER': 'cltbld', 18:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:58 INFO - 'XPC_FLAGS': '0x0', 18:05:58 INFO - 'XPC_SERVICE_NAME': '0', 18:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 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)) 18:05:59 INFO - Cleaning up... 18:05:59 INFO - Return code: 0 18:05:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:59 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 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:05:59 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 18:05:59 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 18:05:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:05:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:59 INFO - 'HOME': '/Users/cltbld', 18:05:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:59 INFO - 'LOGNAME': 'cltbld', 18:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:59 INFO - 'MOZ_NO_REMOTE': '1', 18:05:59 INFO - 'NO_EM_RESTART': '1', 18:05:59 INFO - 'PAGER': '/bin/cat', 18:05:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:59 INFO - 'PWD': '/builds/slave/test', 18:05:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:59 INFO - 'SHELL': '/bin/bash', 18:05:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:05:59 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:05:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:59 INFO - 'USER': 'cltbld', 18:05:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:59 INFO - 'XPC_FLAGS': '0x0', 18:05:59 INFO - 'XPC_SERVICE_NAME': '0', 18:05:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:59 INFO - Downloading/unpacking jsonschema 18:05:59 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 18:05:59 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 18:05:59 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 18:05:59 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 18:05:59 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 18:05:59 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 18:06:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:06:01 INFO - Downloading/unpacking functools32 (from jsonschema) 18:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:06:02 INFO - warning: no files found matching '*.txt' 18:06:02 INFO - no previously-included directories found matching 'build' 18:06:02 INFO - no previously-included directories found matching 'dist' 18:06:02 INFO - no previously-included directories found matching '.git*' 18:06:02 INFO - Installing collected packages: jsonschema, functools32 18:06:02 INFO - Running setup.py install for functools32 18:06:02 INFO - warning: no files found matching '*.txt' 18:06:02 INFO - no previously-included directories found matching 'build' 18:06:02 INFO - no previously-included directories found matching 'dist' 18:06:02 INFO - no previously-included directories found matching '.git*' 18:06:02 INFO - Successfully installed jsonschema functools32 18:06:02 INFO - Cleaning up... 18:06:02 INFO - Return code: 0 18:06:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1080fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081054c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd980d89d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, '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.NscrllcX6u/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.kgbbjKcNHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 18:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:02 INFO - 'HOME': '/Users/cltbld', 18:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:02 INFO - 'LOGNAME': 'cltbld', 18:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:02 INFO - 'MOZ_NO_REMOTE': '1', 18:06:02 INFO - 'NO_EM_RESTART': '1', 18:06:02 INFO - 'PAGER': '/bin/cat', 18:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:02 INFO - 'PWD': '/builds/slave/test', 18:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:02 INFO - 'SHELL': '/bin/bash', 18:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:06:02 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:02 INFO - 'USER': 'cltbld', 18:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:02 INFO - 'XPC_FLAGS': '0x0', 18:06:02 INFO - 'XPC_SERVICE_NAME': '0', 18:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:02 INFO - Downloading/unpacking flake8 18:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:06:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:06:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:05 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 18:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:06:06 INFO - no previously-included directories found matching 'docs/_build' 18:06:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:06:06 INFO - Running setup.py install for pep8 18:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:06:06 INFO - no previously-included directories found matching 'docs/_build' 18:06:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:06:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:06:06 INFO - Cleaning up... 18:06:06 INFO - Return code: 0 18:06:06 INFO - Running post-action listener: _resource_record_post_action 18:06:06 INFO - Running post-action listener: _start_resource_monitoring 18:06:06 INFO - Starting resource monitoring. 18:06:06 INFO - ##### 18:06:06 INFO - ##### Running install step. 18:06:06 INFO - ##### 18:06:06 INFO - Running pre-action listener: _resource_record_pre_action 18:06:06 INFO - Running main action method: install 18:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:06:06 INFO - Reading from file tmpfile_stdout 18:06:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:06:07 INFO - Reading from file tmpfile_stdout 18:06:07 INFO - Output received: 18:06:07 INFO - Usage: mozinstall [options] installer 18:06:07 INFO - Options: 18:06:07 INFO - -h, --help show this help message and exit 18:06:07 INFO - -d DEST, --destination=DEST 18:06:07 INFO - Directory to install application into. [default: 18:06:07 INFO - "/builds/slave/test"] 18:06:07 INFO - --app=APP Application being installed. [default: firefox] 18:06:07 INFO - mkdir: /builds/slave/test/build/application 18:06:07 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'] 18:06:07 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 18:06:40 INFO - Reading from file tmpfile_stdout 18:06:40 INFO - Output received: 18:06:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:06:40 INFO - Running post-action listener: _resource_record_post_action 18:06:40 INFO - ##### 18:06:40 INFO - ##### Running run-tests step. 18:06:40 INFO - ##### 18:06:40 INFO - Running pre-action listener: _resource_record_pre_action 18:06:40 INFO - Running main action method: run_tests 18:06:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:06:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:06:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:06:40 INFO - 2016-03-09 18:06:40.550 screenresolution[1650:7919] starting screenresolution argv=screenresolution get 18:06:40 INFO - 2016-03-09 18:06:40.553 screenresolution[1650:7919] Display 0: 1600x1200x32@60 18:06:40 INFO - 2016-03-09 18:06:40.558 screenresolution[1651:7921] starting screenresolution argv=screenresolution list 18:06:40 INFO - Available Modes on Display 0 18:06:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:06:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:06:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:06:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:06:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:06:40 INFO - Intel Iris: 18:06:40 INFO - Chipset Model: Intel Iris 18:06:40 INFO - Type: GPU 18:06:40 INFO - Bus: Built-In 18:06:40 INFO - VRAM (Dynamic, Max): 1536 MB 18:06:40 INFO - Vendor: Intel (0x8086) 18:06:40 INFO - Device ID: 0x0a2e 18:06:40 INFO - Revision ID: 0x0009 18:06:40 INFO - Displays: 18:06:40 INFO - Display: 18:06:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:06:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:06:40 INFO - Display Serial Number: 1600x1200 60 18:06:40 INFO - Main Display: Yes 18:06:40 INFO - Mirror: Off 18:06:40 INFO - Online: Yes 18:06:40 INFO - Rotation: Supported 18:06:40 INFO - Return code: 0 18:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:06:40 INFO - Python 2.7.3 18:06:40 INFO - Return code: 0 18:06:40 INFO - grabbing minidump binary from tooltool 18:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:40 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 0x107fa2d30>, '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 0x107dc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f99b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:06:40 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 18:06:40 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 18:06:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:06:40 INFO - Return code: 0 18:06:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:06:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:06:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:06:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:06:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:06:42 INFO - Return code: 0 18:06:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:06:42 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NscrllcX6u/Render', 18:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:42 INFO - 'HOME': '/Users/cltbld', 18:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:42 INFO - 'LOGNAME': 'cltbld', 18:06:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:06:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:42 INFO - 'MOZ_NO_REMOTE': '1', 18:06:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:06:42 INFO - 'NO_EM_RESTART': '1', 18:06:42 INFO - 'PAGER': '/bin/cat', 18:06:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:42 INFO - 'PWD': '/builds/slave/test', 18:06:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:42 INFO - 'SHELL': '/bin/bash', 18:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kgbbjKcNHD/Listeners', 18:06:42 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 18:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:42 INFO - 'USER': 'cltbld', 18:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:42 INFO - 'XPC_FLAGS': '0x0', 18:06:42 INFO - 'XPC_SERVICE_NAME': '0', 18:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:06:42 INFO - mozversion application_buildid: 20160309154625 18:06:42 INFO - mozversion application_changeset: 26e576786f9dbf101119be083c2743803e9ced5f 18:06:42 INFO - mozversion application_display_name: Nightly 18:06:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:06:42 INFO - mozversion application_name: Firefox 18:06:42 INFO - mozversion application_remotingname: firefox 18:06:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:06:42 INFO - mozversion application_vendor: Mozilla 18:06:42 INFO - mozversion application_version: 48.0a1 18:06:42 INFO - mozversion platform_buildid: 20160309154625 18:06:42 INFO - mozversion platform_changeset: 26e576786f9dbf101119be083c2743803e9ced5f 18:06:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:06:42 INFO - mozversion platform_version: 48.0a1 18:06:42 INFO - using testdate: 1457575602 18:06:42 INFO - actual date: 1457575602 18:06:42 INFO - starting webserver on 'localhost:49270' 18:06:42 INFO - SUITE-START | Running 2 tests 18:06:42 INFO - TEST-START | dromaeo_css 18:06:42 INFO - operating with platform_type : mac_ 18:06:42 INFO - Initialising browser for dromaeo_css test... 18:06:42 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpjJJCax/profile http://localhost:49270/getInfo.html) 18:06:45 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 18:06:45 INFO - PROCESS | 1669 | colorDepth:24 18:06:45 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 18:06:45 INFO - PROCESS | 1669 | __metrics 18:06:45 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 18:06:45 INFO - TEST-INFO | 1669: exit 0 18:06:45 INFO - Browser initialized. 18:06:45 INFO - Running cycle 1/1 for dromaeo_css test... 18:06:45 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpjJJCax/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:57 INFO - PROCESS | 1674 | RSS: Main: 256102400 18:06:57 INFO - PROCESS | 1674 | 18:07:47 INFO - PROCESS | 1674 | 1457575667504 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] 18:09:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 18:09:59 INFO - PROCESS | 1674 | RSS: Main: 267292672 18:09:59 INFO - PROCESS | 1674 | 18:13:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 18:13:02 INFO - PROCESS | 1674 | RSS: Main: 281112576 18:13:02 INFO - PROCESS | 1674 | 18:16:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 18:16:04 INFO - PROCESS | 1674 | RSS: Main: 282816512 18:16:04 INFO - PROCESS | 1674 | 18:19:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 18:19:07 INFO - PROCESS | 1674 | RSS: Main: 284270592 18:19:07 INFO - PROCESS | 1674 | 18:22:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 18:22:10 INFO - PROCESS | 1674 | RSS: Main: 286253056 18:22:10 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 18:25:12 INFO - PROCESS | 1674 | RSS: Main: 288907264 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | __start_tp_report 18:25:12 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 18:25:12 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 18:25:12 INFO - PROCESS | 1674 | |i|pagename|runs| 18:25:12 INFO - PROCESS | 1674 | |0;dojo.html;3207.9037628871133;3530.9117272068197;3538.221591249924;3540.6459354064596;3599.370110230709;4972.4033116026085;5794.710264486775;5872.941270587293;5882.5588080893995;5896.793612223573;4625.352450656902;5717.2281741964825;5818.534517238621;5931.466168044875;5961.582689211757;4558.951441168533;5080.364954380702;5229.3201883755155;5284.550813180865;5401.594880383967;5346.893062138755;5351.331083614548;5364.383095943957;5394;5402.6758394496255;5219.373675158986;5302.522772950453;5330.120530112566;5344.225087362311;5347.759350829222;5294.867628309285;5321.148616221425;5325.094733895208;5328.227407025959;5329.467053294639;5181.455947125535;5250.133727934886;5327;5353.57171426285;5380.838574842761;5528.778848846041;5668.121441176624;5774.566907481913;5785.942140578624;5839.328477225088;6236.220472440945;6265.71804268809;6272.686365681698;6284.434400903895;6286.46565041972;6187.257529096492;6210.4100110489435;6306.716197771066;6319.3680631936895;6320.367963203689;6024.277086749575;6036.245469316335;6040.969795150996;6041.0636351365165;6113.113598528189;6446.3553644636095;6452.1289625900845;6482.967585162044;6488.318726533646;6508.8047358579315;6094.2899497761455;6153.8307721532765;6213.65824879636;6226.782062627786;6270.404311590391;5799.159121927297;5802.1296805479515;6262.373762623793;6338.809835704844;6339.397757213057;6205.875882482325;6251;6273.37266273369;6276.592021518587;6286.214223222098;5874.471297583238;6147.692615369303;6174.969125154345;6299.559030867887;6305.495560355161;4974.552290293818;5006;5018.698878067327;5030.144875371196;5063.139266324733;4479.865604031819;4491.708038977456;4499.572540608702;4506.233940230103;4536.296873984537;5182.844514664491;5789.94210057894;5935.881282374415;5988.550858685616;6030.216071910623;6290.182276304143;6305.621662700252;6337.6197428154455;6344.333844946214;6405.455536279375;6011.338752737195;6027.6684782336515;6035.486983606443;6038.396160384014;6048.153258543719;5401.5948803839865;5449.237106805051;5452.672839629635;5477.945220547823;5515.4760297771645;6512.218533775977;6518.608883467007;6533.705983230671;6538.574992625464;6553.377429144223;6307;6326.8734625306315;6329.620222786648;6331.746730130927;6343.429091381798;5353.892922141613;6247.562670613195;6490.448311893353;6546.738130474918;6550.148480697479;6172.290186628596;6245.906311405423;6247.468965138014;6274.874502510015;6295.055741638791;6155.1382806406245;6325.462335701517;6328.367163283635;6337.366263373626;6346.7143978522;5468.9179662304305;6024.608400453956;6091.299500557493;6114.266954506099;6225.782097626561;6128.142060111677;6202.782902598387;6222.875542489034;6230.50155987529;6234.594751341148;5926.940730592639;6002.189704390026;6083.878322433615;6153.476954458921;6189.752409903554;6116.0010150213275;6187.133801267916;6217.782377616762;6254;6263.123162757127;6109.541784366102;6143.754249830135;6157.0456579230295;6157.722902469489;6179.443850053517 18:25:12 INFO - PROCESS | 1674 | |1;ext.html;431.4649834205586;520.6927912531605;574.3796699564471;600.5645906717629;646.6378827856399;37627.62372376276;37794.24411511768;38010.23979520415;38120.80939595305;38217.23565528688;39362.8031859841;39685.40471892917;39759.40360894589;39803.60196398035;39807.40288895669;9372.906270937272;9589.993050729678;9604.711858644252;9605.18355939746;9699.321047526675;9452.952735236315;9580.856287155664;9650.986646402132;9717.271204659644;9730.318877678565;9665.178459830922;9719.708408747714;9722.902770972305;9783.315167938246;9794.314397992144;8379.413441059129;9608.951955240214;9661.855072173923;9693.51532423376;9710.980347063527;9613.759656008586;9809.411435313905;9819.705408837746;9832.606695732162;9842.212622990144;38917.02707432309;38924.416133758015;38925.41611875824;39027.60972390296;39046.82859514219;2572.4597834454785;3004.3841012592366;3392.694657480814;3581.803000834953;3822;26948.59577106345;27957;28091.29771755702;28195.87216511337;28434.85782571074;2686.2747058294153;2830.1085158175315;2852.686204517501;2861.955386284012;2865.7420832125;282001;305552;326883;327076;331476;51321.486785131674;66569.00146497806;66870;67158.99261511081;67714.98427523591;56989.870911618156;70676.6466167666;70984;71306;71319;16976.32094716222;17205.827941720672;17337.739933901;17376.91311543434;17409.912950435166;11498.08015358786;12328.32194229326;12990.740185196431;13105.885999690134;13231.603051908458;19078.14148363327;19423;21392.78607213939;21454.785452145592;21584.352469425943;7301.634918254066;8545.145485451405;8597.5701214939;8800.823983520293;8839.337049721296;918.9891119768201;925.2366797392178;952.7237101240563;1014.5333146752429;1127.3179726265655;29873.551896721565;31047.68952310493;31288.843555782074;31588.684113158575;32017.359652806812;1025.6051420203125;1057.4078516031047;1108.700650824273;1180.5631916191064;1181.6632259805915;14738.484153054591;14742.11547307165;14911.850881491264;15063.397464101532;15167.393304267927;567137;645153;645490;648207;654217;60922.695386522784;61606.69196653988;61682;61746.38253617496;61787.07319390213;1452.3609611770787;1457.5408746244898;1488.7990121333482;1499.2503748125937;1503.090630168754;28389.716102838705;28692.426151476437;29591.852040739657;29644.25889352697;30067.849660751555;52322;52890.47109528856;52964.4703552975;53106.73446632897;53252.73373633107;476628.6168569135;493341;493889;494489;497089;33377.332453351286;33785.32429351448;34022.48966265458;34203.94776313429;34303.97088087361;44969.55030449654;45246.773766132275;45281.77359113183;45691.08617827691;45957.540424595325;37150.44274335941;37242.8137859309;37442.43836342402;38038.429423559224;38500.42249366318;30719.692803072576;36976.26047479089;37305.81347093247;37717.245655087296;37808;36480.723174688756;36735.448968266035;37354.8132259337;37381.25237495181;38344.61655383522;30637.693623063486;32064.51903221407;33171.834140830106;33572.328553428306;33665.15837104092;25025;25060.248192554252;25421.721963230186;25551.361215969748;25665.23004309799 18:25:12 INFO - PROCESS | 1674 | |2;jquery.html;356.2572037302224;360.8268031344956;369.25226416506575;376.7626395370916;377.54317276095924;18677.06614669266;19077.23691052358;19788.802111978875;19793.703094453595;19810.009499525037;20142;20744.48138796531;20758.377248682526;20928.89535552324;20939.685904711405;5779.21980532629;5951.285845698522;6065.969670151665;6074.605150665193;6076.939230607703;5529.723513824313;5815.883682326351;5820.38885916979;5954.404559544033;6044.153818465418;5613.8596535086745;5728.885422291552;5780.393058728815;5786.479216870481;5807.9419205808035;4975.925361119586;5872.471477567018;5890.587658863881;5903.35063143054;5906.291245050621;5501.734601041783;5638.71806409682;5656.490915817555;5659.207710920433;5660.094384898438;23991;24327.513449731083;24455.63316550253;24759;24914.003439862565;1977.6637971544728;1993.7408136942104;1999.9100040498213;2106.3786183075877;2184.994187259658;9637.469939153343;9644.228461723045;9872.259580531489;9950.670610357678;10228.64199753005;1743.8529184624174;1778.6175972166047;1797.640471905611;1811.9456416307532;1827.1503750755962;108429.91570084356;108506;109066.36400454;110284.25167721427;111364;10866.185036122322;10989.835152472719;11041.227114102096;11050.281731687415;11176;12987.090903636843;13053;13055.543055992996;13085.953123750078;13196.60410187696;6802.795916122524;8247.21651443112;8324.292435143081;8332;8373.665053397795;8321.126281740451;8412.327013838878;8436.78908027292;8451.873221901677;8543.957280213559;4222.852200172979;4340;4343.3484977253665;4348.260795664744;4367.912641747147;1655.4454257823522;1860.479065861561;1917.2810196176433;1928.7781905080815;1951.4828570428847;402.4948689394791;413.4686927298407;898.4699027573632;919.6551293265026;946.8295706772847;11415.086793056536;11761.647150585497;11804.822927656092;11833.408329583486;11947.880521194851;434.96912317807;452.116112999086;453.97503137327766;468.4121427608398;487.70250147410053;5983.910241346383;6087.6956152192215;6139.631622102688;6149.2313460817395;6175.135481032659;586628;588004;595749;596697;628893;115128.42435787768;116291;118480;119566;129959.70040299476;392.33107551624414;469.28668423995333;469.6383784485927;472.2962785449724;472.4566748239552;18751.624967500848;18850.811491884906;19174.13716382738;19583;20120.49698757543;55181.896362073334;56116;56523;57082.287531374124;58747.41252587419;69786.65106674434;73043.26956730365;73430.16424589428;74484.25515744773;75352;8006.799830004064;8103.351731861555;8131.186881312058;8298.70954516589;8409.369297302605;9484.288678349014;12828.358582071045;13199.93400033032;13728.382222800197;13739.381727822472;4577.382053422879;5386.111291636836;11418.429078546205;11600.187986841178;11918;11060.612878549213;11404.372759498307;11509.07927365792;11701.2979221247;11844.111691623335;11618.88381116178;11673.299602023906;11786.116041296766;12090.576829810914;12118.757624847278;7066.187388450188;7918.208179182036;8182.1817818217705;8228.341732661493;8559.57202139903;8371.874421883798;11326.660200193677;11516.82724759146;11603.709907252387;11879.22785018971 18:25:12 INFO - PROCESS | 1674 | |3;mootools.html;1316.3549860568323;1574.6457047164386;1799.154397433206;1974.7136665183557;1976.2095161935233;7937.40469464791;8647;8737.038925718165;8942.55287235638;8976.551172441375;7571.205023472525;8431.95784021079;8572.071283961106;8585.742427727178;8705.65177392905;2473.4805690804906;2498.4128729748495;2499.8375105618165;2501.262127672341;2514.1326242446326;2441.2432146034785;2504.1235567551303;2510.9121180758675;2515.371157210697;2520.218732193017;2472.678551788265;2495.4135778092223;2514.7233804281514;2528.0646160920487;2528.6080657498023;2492.6510288559616;2506.887190076442;2515.371157210697;2515.434027343842;2524.7096583892903;2481.560694797013;2494.2267896952003;2496.463260399005;2508.2475257422884;2517.785988191006;8703.782405439852;8720.956395218047;8722.08418116095;8728.825423491495;8743.387962842604;4478.39541661878;5050.595952323805;5055.8988820223385;5593.608447408642;5597;3615.385384484644;3670.467782171597;3738.6635202831876;3746.1758413149337;3763.73653844231;977.8924318324979;1056.1761825775907;1064.276292121357;1066.4880857188593;1069.35838496902;11866.347350895783;11884.108691848232;11938.22401543897;11975.161738678209;12001.819972700416;4903.681260718042;4934.309196712463;4975.402951645753;4984.800607975641;5033.723145227048;10065.849012264822;10173.135283500837;10185.490725463696;10192.592296308065;10209.234307426972;5451.373092094381;5518.779248830002;5521.5306698930235;5559.722013899289;5567.860803479945;4067.5525692173837;4453.977730111329;4950.8267210647455;4964.8758781030765;5038.546530812245;3904.511936007999;3911.5697273299916;3980.8805735827973;4009.3785463253244;4054.7972601369815;1137.85645426346;1330.8469526004633;1337.2645045225088;1344.7512210241136;1348.5684580934007;1333.4599487207697;1340.1021315718492;1363.5636596289291;1369.1921766158014;1374.299107455185;8199.71301004462;8203.548804815673;8233.135520770233;8243.464174828618;8277.793055173668;514.9871253218624;524.7900839664164;527.2618334331889;527.6886636884257;535.266684642043;5119.897602047939;5151.4333423323405;6236.688165591702;6249.437550620466;6251.937480625135;8011.759647210593;10871.456427178768;10897.237193396544;10900.836487452694;11006.724831879266;10391.53238104287;10729.195310351755;10824.837627435594;10860.674179774462;10872.130229581615;8366.205210504992;8447.98624165104;8497.150284971576;8510.574471276412;8541.291741651694;7829.153294504555;7891.526508409514;7938.603069846369;7981.002374703162;8058.798530036796;8964.506952117696;9482.099200575934;9641.37331073478;9665.840099188143;10019.849702254618;8357.874631880404;9347.672831450867;9808.65669701557;10118.342307749972;10294.742631433974;6761.628110453972;7211.747588834365;7441.293077157661;7547.245275472409;7603.619819009138;8252.257296843072;8341.290990265896;8352.039515455557;8389.993200815697;8409.579521024047;7320.414366850746;7410.740624078131;7439.181690013986;7564.281393267631;7603.315701586884;7288.708451661874;7291.744788932362;7341.155767086853;7373.705051797868;7381.889271660822;7724.613769311624;7775.57234352116;7829.491083079582;7831.725889593837;7845.411594130349;6826.214985276757;7020.087388639444;7033.331833475811;7068;7099.36105750485;7108.466864985044;7141.143062832493;7194.568325900463;7201;7234.348908598251 18:25:12 INFO - PROCESS | 1674 | |4;prototype.html;270.69141179055873;332.68395024726516;335.9916002099947;337.98141102239373;339.57044338911265;6792.456603471716;6877.862442751149;6878.965605171968;6892.069570607979;6914.44684425246;5098.413682426522;5355.946440535594;6520.67396630169;6749.156355455568;6779.932200677992;4299.935500967488;4323.891902702442;4543;4981.476944920785;4985.700857948535;4961.702297862122;4971.552560269575;4991.825286114987;5055.342805435288;5067.163917953533;5034.0686972910125;5034.496550344955;5037.370328708911;5047.965167140727;5080.364954380702;5051.166557518042;5058.064258112261;5067.138586440314;5073.959838233153;5078.1874900016;4301.333293339538;4302.978485107586;4310.504292006428;4310.784460776948;4331.613883557263;5297.602679799031;6273.12176295319;6523.575967562141;6624.436922861562;6654.966725166343;4737.73942433166;5811.186433899257;5873.765049398019;5922.851928701773;5971.701414929236;7317.59753213573;7337.559746415232;7346.897965305194;7395.223501532316;7414.962925185394;4659.603933665642;4664.090502352043;4666.719996800169;4676.438827340741;4685.367475390813;7451.739189128409;7681.846363072763;7760.223977602251;7783.883241751379;7797;4519.570640789119;4555.794989225493;4629.699069560468;4755.500672429414;4771.06964141989;4845.103655823684;4847.3698419205275;4855;4857.805687772449;4867.683600565952;5803.245578074823;5816.447437493432;5834.912476312858;5837.795677151279;5844.094165404369;7391.260873912674;7397.889031664529;7406.222346653632;7415.851682966419;7433.479656423999;1616.4261687101146;1666.150263365668;1686.4856218853367;1690.729483282669;1695.482877722282;1054.0302921312411;1064.8775390829999;1068.8931106889404;1073.098597178374;1077.2459278505078;6607.603543787292;6644.734210631617;6646.8005959821285;6659.234188068337;6707.128073350434;6341.397567231198;6692.665366731644;7241.2396698346965;7406.407487400995;7427.368673662691;6678.3989440950545;6685.997100434974;6705.765298214539;6706.061151438803;6706.865862682816;3892.785896775648;3976.1252524444576;3999.6200360965663;4009.3785463253244;4021.8391264349684;6430;6475.384838440341;7705.189280519186;7846;7957.880631790527;7937.166597507294;7941.563214023168;7942.3646108311195;7969.840603187904;7970.681172753141;8038.155993620586;8039.638216280281;8051.838963220585;8064.395170362246;8081.717139900193;7343.192248852729;7630.923690763021;7689.154193038873;7704.845903081795;7747;7523.210062943531;7546.1321947976685;7564.054493188351;7564.659590318339;7603.771886843404;8011.959940200261;8022.318102961313;8045.99425071866;8055.234752698484;8066.878996814935;4701.106789709944;4728.45622753374;4753.263244197155;4760.190767569591;4764.690295130944;7426.962865185639;7573.35626471756;7681.347085497795;7683.538987660758;7688.8462230756195;7344.522606030591;7379.372753316028;7405.296496832792;7411.962940185264;7418.925810741824;7359.1169059713175;7370.262973702587;7371.520851144658;7393.408527317694;7395.778126656209;6986.895196571953;7218.530795498275;7219.819504512429;7224.8916266255;7262.31008054234;6430.356964303533;6520.217573891164;7014.772414827283;7434.219406962191;7463.141738700119;5374.946250537601;5922.911156332572;6304.802087603524;6712.53012289135;7258.745943891939 18:25:12 INFO - PROCESS | 1674 | |5;yui.html;652.4649787174517;711.0365454808734;721.7004942948673;750.1560744162815;754.5510421299325;14902.254887255634;15055.698886022274;15131.243437828105;15135.940484166113;15190.468333608313;14414.918881083935;14449.422023119063;15898.76151857723;16261.593460163473;16275;910.968116115936;910.9954450227756;921.3412410126758;923.5428462910869;925.5603588295539;745.5154149802645;916.6470908700165;922.3912217936163;922.912323329286;925.676013395313;964.430985718426;966.2704657983213;971.4122955611859;973.9464329461877;982.7788747531783;948.340903072365;961.8749562556893;964.0263334032643;966.227018385296;978.427619842393;698.4970821008916;715.9821004474878;717.7452004538366;719.5035425556349;723.2478222648492;15535.145566993811;15629.531114066596;15648.843511564966;15651.530454086396;15662.451814186448;12461.688457788538;12518.874811251953;12534.561290354794;12693.428795704216;12725.981921446355;8907.777305567348;9761.316707830454;9902.356346837432;10101.49492525378;10194.490275486196;3432.3135372925517;3472.947905781415;3487.128217945514;3500.6674365935196;3583.175869549992;85811;86593.56703216507;86623;86832.56583717105;87033.56483217607;9286.535673216313;9374.90625093754;9375.296852736072;9392.95303523478;9444.433333999981;21246.893765531073;21310.573788524143;21394.572108557742;21698.13207471715;21727;7290.635468226567;7335.449841261927;7349.265073492608;7483.812904677427;7579.924200758032;4064.7561146330722;4082.755034697928;4118.444010058603;4120.464339635828;4160.729552579072;3618.6924111450294;3640.872569460056;3659.030356955409;3668.761530500509;3670.834812433447;657.9243387010459;668.38174688414;675.0212192321154;680.1158493957835;680.6766785776716;528.8651393894532;578.5507304202945;603.1279187615519;607.1742430294795;610.914471973924;7750.682383994735;7967.8406431871035;8057.677692892219;8232.50604963704;8267.255946964802;513.4018868018791;576.7692922830901;586.8679547101868;604.7701873288122;617.3579477343512;3397.3884700753606;3597.94603080954;3632.5651367709606;3837.597052309523;3884.3590807517007;88303.67544486838;91000;91149.08850911407;91821;91863;73525.16187095366;75063;75938.62030689811;76547.61726191333;77748;51685.74157129265;63516.04725929022;67314.32685673081;67845;67952;5484.8354549363585;6917.754804135304;7562.222877623864;7631.275028872248;7866.842663146591;48858;49107.77230569264;49722.50277497323;49904.75047624738;51202.97594048172;59191.816163677344;60691;63446;64068.3593164081;66953;10993.780124397308;11185.496652650812;11241.437928103398;11251.38117403518;11569.363684997406;11813.173077884809;11829.82255266189;11954;12007.939960300142;12483.001359891368;9200.815983680423;11449.771004580029;11473.770524589294;11663.650090497298;11862.584809531625;11193.440327983406;11419.771604567695;11429.542818287175;11823.940880295544;12258.20321679088;8988.730338089868;10830.566777328819;10949.726256843642;11542.653720388402;11559.479823407799;9231.399959002643;9480.668176613786;9527.209973519097;9709.951450242703;9868.703938881845;8095.23095305945;9327.393719408217;9509.953905070575;9626.95186524063;9640.807183856425 18:25:12 INFO - PROCESS | 1674 | __end_tp_report 18:25:12 INFO - PROCESS | 1674 | __start_cc_report 18:25:12 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,362 18:25:12 INFO - PROCESS | 1674 | __end_cc_report 18:25:12 INFO - PROCESS | 1674 | __startTimestamp1457576712923__endTimestamp 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | ------- Summary: start ------- 18:25:12 INFO - PROCESS | 1674 | Number of tests: 6 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5820.79 Median:6083.88 stddev:655.81 (10.8%) stddev-sans-first:624.97 18:25:12 INFO - PROCESS | 1674 | Values: 3207.9 3530.9 3538.2 3540.6 3599.4 4972.4 5794.7 5872.9 5882.6 5896.8 4625.4 5717.2 5818.5 5931.5 5961.6 4559.0 5080.4 5229.3 5284.6 5401.6 5346.9 5351.3 5364.4 5394.0 5402.7 5219.4 5302.5 5330.1 5344.2 5347.8 5294.9 5321.1 5325.1 5328.2 5329.5 5181.5 5250.1 5327.0 5353.6 5380.8 5528.8 5668.1 5774.6 5785.9 5839.3 6236.2 6265.7 6272.7 6284.4 6286.5 6187.3 6210.4 6306.7 6319.4 6320.4 6024.3 6036.2 6041.0 6041.1 6113.1 6446.4 6452.1 6483.0 6488.3 6508.8 6094.3 6153.8 6213.7 6226.8 6270.4 5799.2 5802.1 6262.4 6338.8 6339.4 6205.9 6251.0 6273.4 6276.6 6286.2 5874.5 6147.7 6175.0 6299.6 6305.5 4974.6 5006.0 5018.7 5030.1 5063.1 4479.9 4491.7 4499.6 4506.2 4536.3 5182.8 5789.9 5935.9 5988.6 6030.2 6290.2 6305.6 6337.6 6344.3 6405.5 6011.3 6027.7 6035.5 6038.4 6048.2 5401.6 5449.2 5452.7 5477.9 5515.5 6512.2 6518.6 6533.7 6538.6 6553.4 6307.0 6326.9 6329.6 6331.7 6343.4 5353.9 6247.6 6490.4 6546.7 6550.1 6172.3 6245.9 6247.5 6274.9 6295.1 6155.1 6325.5 6328.4 6337.4 6346.7 5468.9 6024.6 6091.3 6114.3 6225.8 6128.1 6202.8 6222.9 6230.5 6234.6 5926.9 6002.2 6083.9 6153.5 6189.8 6116.0 6187.1 6217.8 6254.0 6263.1 6109.5 6143.8 6157.0 6157.7 6179.4 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:63052.53 Median:38024.33 stddev:132784.08 (349.2%) stddev-sans-first:133073.33 18:25:12 INFO - PROCESS | 1674 | Values: 431.5 520.7 574.4 600.6 646.6 37627.6 37794.2 38010.2 38120.8 38217.2 39362.8 39685.4 39759.4 39803.6 39807.4 9372.9 9590.0 9604.7 9605.2 9699.3 9453.0 9580.9 9651.0 9717.3 9730.3 9665.2 9719.7 9722.9 9783.3 9794.3 8379.4 9609.0 9661.9 9693.5 9711.0 9613.8 9809.4 9819.7 9832.6 9842.2 38917.0 38924.4 38925.4 39027.6 39046.8 2572.5 3004.4 3392.7 3581.8 3822.0 26948.6 27957.0 28091.3 28195.9 28434.9 2686.3 2830.1 2852.7 2862.0 2865.7 282001.0 305552.0 326883.0 327076.0 331476.0 51321.5 66569.0 66870.0 67159.0 67715.0 56989.9 70676.6 70984.0 71306.0 71319.0 16976.3 17205.8 17337.7 17376.9 17409.9 11498.1 12328.3 12990.7 13105.9 13231.6 19078.1 19423.0 21392.8 21454.8 21584.4 7301.6 8545.1 8597.6 8800.8 8839.3 919.0 925.2 952.7 1014.5 1127.3 29873.6 31047.7 31288.8 31588.7 32017.4 1025.6 1057.4 1108.7 1180.6 1181.7 14738.5 14742.1 14911.9 15063.4 15167.4 567137.0 645153.0 645490.0 648207.0 654217.0 60922.7 61606.7 61682.0 61746.4 61787.1 1452.4 1457.5 1488.8 1499.3 1503.1 28389.7 28692.4 29591.9 29644.3 30067.8 52322.0 52890.5 52964.5 53106.7 53252.7 476628.6 493341.0 493889.0 494489.0 497089.0 33377.3 33785.3 34022.5 34203.9 34304.0 44969.6 45246.8 45281.8 45691.1 45957.5 37150.4 37242.8 37442.4 38038.4 38500.4 30719.7 36976.3 37305.8 37717.2 37808.0 36480.7 36735.4 37354.8 37381.3 38344.6 30637.7 32064.5 33171.8 33572.3 33665.2 25025.0 25060.2 25421.7 25551.4 25665.2 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:33992.77 Median:2328.91 stddev:99735.83 (4282.5%) stddev-sans-first:99983.63 18:25:12 INFO - PROCESS | 1674 | Values: 356.3 360.8 369.3 376.8 377.5 18677.1 19077.2 19788.8 19793.7 19810.0 20142.0 20744.5 20758.4 20928.9 20939.7 5779.2 5951.3 6066.0 6074.6 6076.9 5529.7 5815.9 5820.4 5954.4 6044.2 5613.9 5728.9 5780.4 5786.5 5807.9 4975.9 5872.5 5890.6 5903.4 5906.3 5501.7 5638.7 5656.5 5659.2 5660.1 23991.0 24327.5 24455.6 24759.0 24914.0 1977.7 1993.7 1999.9 2106.4 2185.0 9637.5 9644.2 9872.3 9950.7 10228.6 1743.9 1778.6 1797.6 1811.9 1827.2 108429.9 108506.0 109066.4 110284.3 111364.0 10866.2 10989.8 11041.2 11050.3 11176.0 12987.1 13053.0 13055.5 13086.0 13196.6 6802.8 8247.2 8324.3 8332.0 8373.7 8321.1 8412.3 8436.8 8451.9 8544.0 4222.9 4340.0 4343.3 4348.3 4367.9 1655.4 1860.5 1917.3 1928.8 1951.5 402.5 413.5 898.5 919.7 946.8 11415.1 11761.6 11804.8 11833.4 11947.9 435.0 452.1 454.0 468.4 487.7 5983.9 6087.7 6139.6 6149.2 6175.1 586628.0 588004.0 595749.0 596697.0 628893.0 115128.4 116291.0 118480.0 119566.0 129959.7 392.3 469.3 469.6 472.3 472.5 18751.6 18850.8 19174.1 19583.0 20120.5 55181.9 56116.0 56523.0 57082.3 58747.4 69786.7 73043.3 73430.2 74484.3 75352.0 8006.8 8103.4 8131.2 8298.7 8409.4 9484.3 12828.4 13199.9 13728.4 13739.4 4577.4 5386.1 11418.4 11600.2 11918.0 11060.6 11404.4 11509.1 11701.3 11844.1 11618.9 11673.3 11786.1 12090.6 12118.8 7066.2 7918.2 8182.2 8228.3 8559.6 8371.9 11326.7 11516.8 11603.7 11879.2 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6040.16 Median:2833.21 stddev:3192.06 (112.7%) stddev-sans-first:3181.26 18:25:12 INFO - PROCESS | 1674 | Values: 1316.4 1574.6 1799.2 1974.7 1976.2 7937.4 8647.0 8737.0 8942.6 8976.6 7571.2 8432.0 8572.1 8585.7 8705.7 2473.5 2498.4 2499.8 2501.3 2514.1 2441.2 2504.1 2510.9 2515.4 2520.2 2472.7 2495.4 2514.7 2528.1 2528.6 2492.7 2506.9 2515.4 2515.4 2524.7 2481.6 2494.2 2496.5 2508.2 2517.8 8703.8 8721.0 8722.1 8728.8 8743.4 4478.4 5050.6 5055.9 5593.6 5597.0 3615.4 3670.5 3738.7 3746.2 3763.7 977.9 1056.2 1064.3 1066.5 1069.4 11866.3 11884.1 11938.2 11975.2 12001.8 4903.7 4934.3 4975.4 4984.8 5033.7 10065.8 10173.1 10185.5 10192.6 10209.2 5451.4 5518.8 5521.5 5559.7 5567.9 4067.6 4454.0 4950.8 4964.9 5038.5 3904.5 3911.6 3980.9 4009.4 4054.8 1137.9 1330.8 1337.3 1344.8 1348.6 1333.5 1340.1 1363.6 1369.2 1374.3 8199.7 8203.5 8233.1 8243.5 8277.8 515.0 524.8 527.3 527.7 535.3 5119.9 5151.4 6236.7 6249.4 6251.9 8011.8 10871.5 10897.2 10900.8 11006.7 10391.5 10729.2 10824.8 10860.7 10872.1 8366.2 8448.0 8497.2 8510.6 8541.3 7829.2 7891.5 7938.6 7981.0 8058.8 8964.5 9482.1 9641.4 9665.8 10019.8 8357.9 9347.7 9808.7 10118.3 10294.7 6761.6 7211.7 7441.3 7547.2 7603.6 8252.3 8341.3 8352.0 8390.0 8409.6 7320.4 7410.7 7439.2 7564.3 7603.3 7288.7 7291.7 7341.2 7373.7 7381.9 7724.6 7775.6 7829.5 7831.7 7845.4 6826.2 7020.1 7033.3 7068.0 7099.4 7108.5 7141.1 7194.6 7201.0 7234.3 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5915.43 Median:6634.59 stddev:1927.37 (29.1%) stddev-sans-first:1885.63 18:25:12 INFO - PROCESS | 1674 | Values: 270.7 332.7 336.0 338.0 339.6 6792.5 6877.9 6879.0 6892.1 6914.4 5098.4 5355.9 6520.7 6749.2 6779.9 4299.9 4323.9 4543.0 4981.5 4985.7 4961.7 4971.6 4991.8 5055.3 5067.2 5034.1 5034.5 5037.4 5048.0 5080.4 5051.2 5058.1 5067.1 5074.0 5078.2 4301.3 4303.0 4310.5 4310.8 4331.6 5297.6 6273.1 6523.6 6624.4 6655.0 4737.7 5811.2 5873.8 5922.9 5971.7 7317.6 7337.6 7346.9 7395.2 7415.0 4659.6 4664.1 4666.7 4676.4 4685.4 7451.7 7681.8 7760.2 7783.9 7797.0 4519.6 4555.8 4629.7 4755.5 4771.1 4845.1 4847.4 4855.0 4857.8 4867.7 5803.2 5816.4 5834.9 5837.8 5844.1 7391.3 7397.9 7406.2 7415.9 7433.5 1616.4 1666.2 1686.5 1690.7 1695.5 1054.0 1064.9 1068.9 1073.1 1077.2 6607.6 6644.7 6646.8 6659.2 6707.1 6341.4 6692.7 7241.2 7406.4 7427.4 6678.4 6686.0 6705.8 6706.1 6706.9 3892.8 3976.1 3999.6 4009.4 4021.8 6430.0 6475.4 7705.2 7846.0 7957.9 7937.2 7941.6 7942.4 7969.8 7970.7 8038.2 8039.6 8051.8 8064.4 8081.7 7343.2 7630.9 7689.2 7704.8 7747.0 7523.2 7546.1 7564.1 7564.7 7603.8 8012.0 8022.3 8046.0 8055.2 8066.9 4701.1 4728.5 4753.3 4760.2 4764.7 7427.0 7573.4 7681.3 7683.5 7688.8 7344.5 7379.4 7405.3 7412.0 7418.9 7359.1 7370.3 7371.5 7393.4 7395.8 6986.9 7218.5 7219.8 7224.9 7262.3 6430.4 6520.2 7014.8 7434.2 7463.1 5374.9 5922.9 6304.8 6712.5 7258.7 18:25:12 INFO - PROCESS | 1674 | 18:25:12 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18025.94 Median:63792.20 stddev:25287.52 (39.6%) stddev-sans-first:25324.81 18:25:12 INFO - PROCESS | 1674 | Values: 652.5 711.0 721.7 750.2 754.6 14902.3 15055.7 15131.2 15135.9 15190.5 14414.9 14449.4 15898.8 16261.6 16275.0 911.0 911.0 921.3 923.5 925.6 745.5 916.6 922.4 922.9 925.7 964.4 966.3 971.4 973.9 982.8 948.3 961.9 964.0 966.2 978.4 698.5 716.0 717.7 719.5 723.2 15535.1 15629.5 15648.8 15651.5 15662.5 12461.7 12518.9 12534.6 12693.4 12726.0 8907.8 9761.3 9902.4 10101.5 10194.5 3432.3 3472.9 3487.1 3500.7 3583.2 85811.0 86593.6 86623.0 86832.6 87033.6 9286.5 9374.9 9375.3 9393.0 9444.4 21246.9 21310.6 21394.6 21698.1 21727.0 7290.6 7335.4 7349.3 7483.8 7579.9 4064.8 4082.8 4118.4 4120.5 4160.7 3618.7 3640.9 3659.0 3668.8 3670.8 657.9 668.4 675.0 680.1 680.7 528.9 578.6 603.1 607.2 610.9 7750.7 7967.8 8057.7 8232.5 8267.3 513.4 576.8 586.9 604.8 617.4 3397.4 3597.9 3632.6 3837.6 3884.4 88303.7 91000.0 91149.1 91821.0 91863.0 73525.2 75063.0 75938.6 76547.6 77748.0 51685.7 63516.0 67314.3 67845.0 67952.0 5484.8 6917.8 7562.2 7631.3 7866.8 48858.0 49107.8 49722.5 49904.8 51203.0 59191.8 60691.0 63446.0 64068.4 66953.0 10993.8 11185.5 11241.4 11251.4 11569.4 11813.2 11829.8 11954.0 12007.9 12483.0 9200.8 11449.8 11473.8 11663.7 11862.6 11193.4 11419.8 11429.5 11823.9 12258.2 8988.7 10830.6 10949.7 11542.7 11559.5 9231.4 9480.7 9527.2 9710.0 9868.7 8095.2 9327.4 9510.0 9627.0 9640.8 18:25:12 INFO - PROCESS | 1674 | -------- Summary: end -------- 18:25:12 INFO - PROCESS | 1674 | 18:25:13 INFO - TEST-INFO | 1674: exit 0 18:25:13 INFO - TEST-OK | dromaeo_css | took 1111157ms 18:25:13 INFO - TEST-START | kraken 18:25:13 INFO - operating with platform_type : mac_ 18:25:13 INFO - Initialising browser for kraken test... 18:25:13 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpKfoVYq/profile http://localhost:49270/getInfo.html) 18:25:16 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 18:25:16 INFO - PROCESS | 1682 | colorDepth:24 18:25:16 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 18:25:16 INFO - PROCESS | 1682 | __metrics 18:25:16 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 18:25:17 INFO - TEST-INFO | 1682: exit 0 18:25:17 INFO - Browser initialized. 18:25:17 INFO - Running cycle 1/1 for kraken test... 18:25:17 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpKfoVYq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:29 INFO - PROCESS | 1685 | RSS: Main: 255442944 18:25:29 INFO - PROCESS | 1685 | 18:25:31 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 18:25:32 INFO - PROCESS | 1685 | RSS: Main: 269262848 18:25:32 INFO - PROCESS | 1685 | 18:25:34 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 18:25:35 INFO - PROCESS | 1685 | RSS: Main: 277323776 18:25:35 INFO - PROCESS | 1685 | 18:25:38 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 18:25:39 INFO - PROCESS | 1685 | RSS: Main: 281534464 18:25:39 INFO - PROCESS | 1685 | 18:25:41 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 18:25:42 INFO - PROCESS | 1685 | RSS: Main: 281886720 18:25:42 INFO - PROCESS | 1685 | 18:25:44 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:25:44 INFO - PROCESS | 1685 | RSS: Main: 281886720 18:25:44 INFO - PROCESS | 1685 | 18:25:47 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 18:25:48 INFO - PROCESS | 1685 | RSS: Main: 283422720 18:25:48 INFO - PROCESS | 1685 | 18:25:51 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 18:25:51 INFO - PROCESS | 1685 | RSS: Main: 283791360 18:25:51 INFO - PROCESS | 1685 | 18:25:54 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 18:25:55 INFO - PROCESS | 1685 | RSS: Main: 283529216 18:25:55 INFO - PROCESS | 1685 | 18:25:56 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:25:57 INFO - PROCESS | 1685 | RSS: Main: 282701824 18:25:57 INFO - PROCESS | 1685 | 18:25:59 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:26:00 INFO - PROCESS | 1685 | RSS: Main: 282247168 18:26:00 INFO - PROCESS | 1685 | 18:26:02 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:26:02 INFO - PROCESS | 1685 | RSS: Main: 283299840 18:26:02 INFO - PROCESS | 1685 | 18:26:05 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:26:05 INFO - PROCESS | 1685 | RSS: Main: 282935296 18:26:05 INFO - PROCESS | 1685 | 18:26:08 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:26:09 INFO - PROCESS | 1685 | RSS: Main: 283054080 18:26:09 INFO - PROCESS | 1685 | 18:26:10 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 18:26:11 INFO - PROCESS | 1685 | RSS: Main: 285999104 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | __start_tp_report 18:26:11 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 18:26:11 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 18:26:11 INFO - PROCESS | 1685 | |i|pagename|runs| 18:26:11 INFO - PROCESS | 1685 | |0;ai-astar;115;111;110;113;114;125;115;114;114;114 18:26:11 INFO - PROCESS | 1685 | |1;audio-beat-detection;153;122;141;156;125;140;126;161;188;152 18:26:11 INFO - PROCESS | 1685 | |2;audio-dft;195;199;197;195;201;237;219;197;197;201 18:26:11 INFO - PROCESS | 1685 | |3;audio-fft;60;93;81;80;88;86;62;114;58;58 18:26:11 INFO - PROCESS | 1685 | |4;audio-oscillator;114;89;116;78;78;82;116;80;80;114 18:26:11 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;87;86;88;86;89;84;89;107;86;73 18:26:11 INFO - PROCESS | 1685 | |6;imaging-darkroom;91;126;149;95;94;104;93;143;114;94 18:26:11 INFO - PROCESS | 1685 | |7;imaging-desaturate;78;154;149;91;90;96;138;87;155;143 18:26:11 INFO - PROCESS | 1685 | |8;json-parse-financial;57;56;56;56;54;56;56;63;59;55 18:26:11 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;60;67;73;73;73;71;66;67;66;68 18:26:11 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;88;85;85;86;87;84;87;86;88;85 18:26:11 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;128;133;137;134;109;149;114;108;135;139 18:26:11 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;175;144;139;141;141;134;155;176;156;145 18:26:11 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;67;71;66;69;69;68;66;70;67;70 18:26:11 INFO - PROCESS | 1685 | __end_tp_report 18:26:11 INFO - PROCESS | 1685 | __start_cc_report 18:26:11 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,971 18:26:11 INFO - PROCESS | 1685 | __end_cc_report 18:26:11 INFO - PROCESS | 1685 | __startTimestamp1457576771026__endTimestamp 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | ------- Summary: start ------- 18:26:11 INFO - PROCESS | 1685 | Number of tests: 14 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:4.03 (3.5%) stddev-sans-first:4.28 18:26:11 INFO - PROCESS | 1685 | Values: 115.0 111.0 110.0 113.0 114.0 125.0 115.0 114.0 114.0 114.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.50 stddev:20.14 (13.2%) stddev-sans-first:21.22 18:26:11 INFO - PROCESS | 1685 | Values: 153.0 122.0 141.0 156.0 125.0 140.0 126.0 161.0 188.0 152.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:203.80 Median:200.00 stddev:13.60 (6.8%) stddev-sans-first:14.05 18:26:11 INFO - PROCESS | 1685 | Values: 195.0 199.0 197.0 195.0 201.0 237.0 219.0 197.0 197.0 201.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:78.00 Median:80.50 stddev:18.49 (23.0%) stddev-sans-first:18.43 18:26:11 INFO - PROCESS | 1685 | Values: 60.0 93.0 81.0 80.0 88.0 86.0 62.0 114.0 58.0 58.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:17.75 (22.5%) stddev-sans-first:17.40 18:26:11 INFO - PROCESS | 1685 | Values: 114.0 89.0 116.0 78.0 78.0 82.0 116.0 80.0 80.0 114.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:86.50 stddev:8.26 (9.6%) stddev-sans-first:8.76 18:26:11 INFO - PROCESS | 1685 | Values: 87.0 86.0 88.0 86.0 89.0 84.0 89.0 107.0 86.0 73.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:92.00 stddev:21.87 (23.8%) stddev-sans-first:22.05 18:26:11 INFO - PROCESS | 1685 | Values: 91.0 126.0 149.0 95.0 94.0 104.0 93.0 143.0 114.0 94.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:118.10 Median:82.50 stddev:31.99 (38.8%) stddev-sans-first:30.46 18:26:11 INFO - PROCESS | 1685 | Values: 78.0 154.0 149.0 91.0 90.0 96.0 138.0 87.0 155.0 143.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:2.53 (4.5%) stddev-sans-first:2.68 18:26:11 INFO - PROCESS | 1685 | Values: 57.0 56.0 56.0 56.0 54.0 56.0 56.0 63.0 59.0 55.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.50 stddev:4.17 (6.0%) stddev-sans-first:3.12 18:26:11 INFO - PROCESS | 1685 | Values: 60.0 67.0 73.0 73.0 73.0 71.0 66.0 67.0 66.0 68.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.50 stddev:1.37 (1.6%) stddev-sans-first:1.27 18:26:11 INFO - PROCESS | 1685 | Values: 88.0 85.0 85.0 86.0 87.0 84.0 87.0 86.0 88.0 85.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:134.50 stddev:13.77 (10.2%) stddev-sans-first:14.60 18:26:11 INFO - PROCESS | 1685 | Values: 128.0 133.0 137.0 134.0 109.0 149.0 114.0 108.0 135.0 139.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:150.00 stddev:14.75 (9.8%) stddev-sans-first:12.73 18:26:11 INFO - PROCESS | 1685 | Values: 175.0 144.0 139.0 141.0 141.0 134.0 155.0 176.0 156.0 145.0 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.77 (2.6%) stddev-sans-first:1.81 18:26:11 INFO - PROCESS | 1685 | Values: 67.0 71.0 66.0 69.0 69.0 68.0 66.0 70.0 67.0 70.0 18:26:11 INFO - PROCESS | 1685 | -------- Summary: end -------- 18:26:11 INFO - PROCESS | 1685 | 18:26:11 INFO - TEST-INFO | 1685: exit 0 18:26:11 INFO - TEST-OK | kraken | took 58362ms 18:26:11 INFO - SUITE-END | took 1169s 18:26:12 INFO - Completed test suite (00:19:29) 18:26:12 INFO - javascript benchmark 18:26:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.9037628871133, 3530.9117272068197, 3538.221591249924, 3540.6459354064596, 3599.370110230709, 4972.4033116026085, 5794.710264486775, 5872.941270587293, 5882.5588080893995, 5896.793612223573, 4625.352450656902, 5717.2281741964825, 5818.534517238621, 5931.466168044875, 5961.582689211757, 4558.951441168533, 5080.364954380702, 5229.3201883755155, 5284.550813180865, 5401.594880383967, 5346.893062138755, 5351.331083614548, 5364.383095943957, 5394.0, 5402.6758394496255, 5219.373675158986, 5302.522772950453, 5330.120530112566, 5344.225087362311, 5347.759350829222, 5294.867628309285, 5321.148616221425, 5325.094733895208, 5328.227407025959, 5329.467053294639, 5181.455947125535, 5250.133727934886, 5327.0, 5353.57171426285, 5380.838574842761, 5528.778848846041, 5668.121441176624, 5774.566907481913, 5785.942140578624, 5839.328477225088, 6236.220472440945, 6265.71804268809, 6272.686365681698, 6284.434400903895, 6286.46565041972, 6187.257529096492, 6210.4100110489435, 6306.716197771066, 6319.3680631936895, 6320.367963203689, 6024.277086749575, 6036.245469316335, 6040.969795150996, 6041.0636351365165, 6113.113598528189, 6446.3553644636095, 6452.1289625900845, 6482.967585162044, 6488.318726533646, 6508.8047358579315, 6094.2899497761455, 6153.8307721532765, 6213.65824879636, 6226.782062627786, 6270.404311590391, 5799.159121927297, 5802.1296805479515, 6262.373762623793, 6338.809835704844, 6339.397757213057, 6205.875882482325, 6251.0, 6273.37266273369, 6276.592021518587, 6286.214223222098, 5874.471297583238, 6147.692615369303, 6174.969125154345, 6299.559030867887, 6305.495560355161, 4974.552290293818, 5006.0, 5018.698878067327, 5030.144875371196, 5063.139266324733, 4479.865604031819, 4491.708038977456, 4499.572540608702, 4506.233940230103, 4536.296873984537, 5182.844514664491, 5789.94210057894, 5935.881282374415, 5988.550858685616, 6030.216071910623, 6290.182276304143, 6305.621662700252, 6337.6197428154455, 6344.333844946214, 6405.455536279375, 6011.338752737195, 6027.6684782336515, 6035.486983606443, 6038.396160384014, 6048.153258543719, 5401.5948803839865, 5449.237106805051, 5452.672839629635, 5477.945220547823, 5515.4760297771645, 6512.218533775977, 6518.608883467007, 6533.705983230671, 6538.574992625464, 6553.377429144223, 6307.0, 6326.8734625306315, 6329.620222786648, 6331.746730130927, 6343.429091381798, 5353.892922141613, 6247.562670613195, 6490.448311893353, 6546.738130474918, 6550.148480697479, 6172.290186628596, 6245.906311405423, 6247.468965138014, 6274.874502510015, 6295.055741638791, 6155.1382806406245, 6325.462335701517, 6328.367163283635, 6337.366263373626, 6346.7143978522, 5468.9179662304305, 6024.608400453956, 6091.299500557493, 6114.266954506099, 6225.782097626561, 6128.142060111677, 6202.782902598387, 6222.875542489034, 6230.50155987529, 6234.594751341148, 5926.940730592639, 6002.189704390026, 6083.878322433615, 6153.476954458921, 6189.752409903554, 6116.0010150213275, 6187.133801267916, 6217.782377616762, 6254.0, 6263.123162757127, 6109.541784366102, 6143.754249830135, 6157.0456579230295, 6157.722902469489, 6179.443850053517], "unit": "score", "name": "dojo.html", "value": 5780.5167961476645}, {"lowerIsBetter": false, "replicates": [431.4649834205586, 520.6927912531605, 574.3796699564471, 600.5645906717629, 646.6378827856399, 37627.62372376276, 37794.24411511768, 38010.23979520415, 38120.80939595305, 38217.23565528688, 39362.8031859841, 39685.40471892917, 39759.40360894589, 39803.60196398035, 39807.40288895669, 9372.906270937272, 9589.993050729678, 9604.711858644252, 9605.18355939746, 9699.321047526675, 9452.952735236315, 9580.856287155664, 9650.986646402132, 9717.271204659644, 9730.318877678565, 9665.178459830922, 9719.708408747714, 9722.902770972305, 9783.315167938246, 9794.314397992144, 8379.413441059129, 9608.951955240214, 9661.855072173923, 9693.51532423376, 9710.980347063527, 9613.759656008586, 9809.411435313905, 9819.705408837746, 9832.606695732162, 9842.212622990144, 38917.02707432309, 38924.416133758015, 38925.41611875824, 39027.60972390296, 39046.82859514219, 2572.4597834454785, 3004.3841012592366, 3392.694657480814, 3581.803000834953, 3822.0, 26948.59577106345, 27957.0, 28091.29771755702, 28195.87216511337, 28434.85782571074, 2686.2747058294153, 2830.1085158175315, 2852.686204517501, 2861.955386284012, 2865.7420832125, 282001.0, 305552.0, 326883.0, 327076.0, 331476.0, 51321.486785131674, 66569.00146497806, 66870.0, 67158.99261511081, 67714.98427523591, 56989.870911618156, 70676.6466167666, 70984.0, 71306.0, 71319.0, 16976.32094716222, 17205.827941720672, 17337.739933901, 17376.91311543434, 17409.912950435166, 11498.08015358786, 12328.32194229326, 12990.740185196431, 13105.885999690134, 13231.603051908458, 19078.14148363327, 19423.0, 21392.78607213939, 21454.785452145592, 21584.352469425943, 7301.634918254066, 8545.145485451405, 8597.5701214939, 8800.823983520293, 8839.337049721296, 918.9891119768201, 925.2366797392178, 952.7237101240563, 1014.5333146752429, 1127.3179726265655, 29873.551896721565, 31047.68952310493, 31288.843555782074, 31588.684113158575, 32017.359652806812, 1025.6051420203125, 1057.4078516031047, 1108.700650824273, 1180.5631916191064, 1181.6632259805915, 14738.484153054591, 14742.11547307165, 14911.850881491264, 15063.397464101532, 15167.393304267927, 567137.0, 645153.0, 645490.0, 648207.0, 654217.0, 60922.695386522784, 61606.69196653988, 61682.0, 61746.38253617496, 61787.07319390213, 1452.3609611770787, 1457.5408746244898, 1488.7990121333482, 1499.2503748125937, 1503.090630168754, 28389.716102838705, 28692.426151476437, 29591.852040739657, 29644.25889352697, 30067.849660751555, 52322.0, 52890.47109528856, 52964.4703552975, 53106.73446632897, 53252.73373633107, 476628.6168569135, 493341.0, 493889.0, 494489.0, 497089.0, 33377.332453351286, 33785.32429351448, 34022.48966265458, 34203.94776313429, 34303.97088087361, 44969.55030449654, 45246.773766132275, 45281.77359113183, 45691.08617827691, 45957.540424595325, 37150.44274335941, 37242.8137859309, 37442.43836342402, 38038.429423559224, 38500.42249366318, 30719.692803072576, 36976.26047479089, 37305.81347093247, 37717.245655087296, 37808.0, 36480.723174688756, 36735.448968266035, 37354.8132259337, 37381.25237495181, 38344.61655383522, 30637.693623063486, 32064.51903221407, 33171.834140830106, 33572.328553428306, 33665.15837104092, 25025.0, 25060.248192554252, 25421.721963230186, 25551.361215969748, 25665.23004309799], "unit": "score", "name": "ext.html", "value": 19847.688504853348}, {"lowerIsBetter": false, "replicates": [356.2572037302224, 360.8268031344956, 369.25226416506575, 376.7626395370916, 377.54317276095924, 18677.06614669266, 19077.23691052358, 19788.802111978875, 19793.703094453595, 19810.009499525037, 20142.0, 20744.48138796531, 20758.377248682526, 20928.89535552324, 20939.685904711405, 5779.21980532629, 5951.285845698522, 6065.969670151665, 6074.605150665193, 6076.939230607703, 5529.723513824313, 5815.883682326351, 5820.38885916979, 5954.404559544033, 6044.153818465418, 5613.8596535086745, 5728.885422291552, 5780.393058728815, 5786.479216870481, 5807.9419205808035, 4975.925361119586, 5872.471477567018, 5890.587658863881, 5903.35063143054, 5906.291245050621, 5501.734601041783, 5638.71806409682, 5656.490915817555, 5659.207710920433, 5660.094384898438, 23991.0, 24327.513449731083, 24455.63316550253, 24759.0, 24914.003439862565, 1977.6637971544728, 1993.7408136942104, 1999.9100040498213, 2106.3786183075877, 2184.994187259658, 9637.469939153343, 9644.228461723045, 9872.259580531489, 9950.670610357678, 10228.64199753005, 1743.8529184624174, 1778.6175972166047, 1797.640471905611, 1811.9456416307532, 1827.1503750755962, 108429.91570084356, 108506.0, 109066.36400454, 110284.25167721427, 111364.0, 10866.185036122322, 10989.835152472719, 11041.227114102096, 11050.281731687415, 11176.0, 12987.090903636843, 13053.0, 13055.543055992996, 13085.953123750078, 13196.60410187696, 6802.795916122524, 8247.21651443112, 8324.292435143081, 8332.0, 8373.665053397795, 8321.126281740451, 8412.327013838878, 8436.78908027292, 8451.873221901677, 8543.957280213559, 4222.852200172979, 4340.0, 4343.3484977253665, 4348.260795664744, 4367.912641747147, 1655.4454257823522, 1860.479065861561, 1917.2810196176433, 1928.7781905080815, 1951.4828570428847, 402.4948689394791, 413.4686927298407, 898.4699027573632, 919.6551293265026, 946.8295706772847, 11415.086793056536, 11761.647150585497, 11804.822927656092, 11833.408329583486, 11947.880521194851, 434.96912317807, 452.116112999086, 453.97503137327766, 468.4121427608398, 487.70250147410053, 5983.910241346383, 6087.6956152192215, 6139.631622102688, 6149.2313460817395, 6175.135481032659, 586628.0, 588004.0, 595749.0, 596697.0, 628893.0, 115128.42435787768, 116291.0, 118480.0, 119566.0, 129959.70040299476, 392.33107551624414, 469.28668423995333, 469.6383784485927, 472.2962785449724, 472.4566748239552, 18751.624967500848, 18850.811491884906, 19174.13716382738, 19583.0, 20120.49698757543, 55181.896362073334, 56116.0, 56523.0, 57082.287531374124, 58747.41252587419, 69786.65106674434, 73043.26956730365, 73430.16424589428, 74484.25515744773, 75352.0, 8006.799830004064, 8103.351731861555, 8131.186881312058, 8298.70954516589, 8409.369297302605, 9484.288678349014, 12828.358582071045, 13199.93400033032, 13728.382222800197, 13739.381727822472, 4577.382053422879, 5386.111291636836, 11418.429078546205, 11600.187986841178, 11918.0, 11060.612878549213, 11404.372759498307, 11509.07927365792, 11701.2979221247, 11844.111691623335, 11618.88381116178, 11673.299602023906, 11786.116041296766, 12090.576829810914, 12118.757624847278, 7066.187388450188, 7918.208179182036, 8182.1817818217705, 8228.341732661493, 8559.57202139903, 8371.874421883798, 11326.660200193677, 11516.82724759146, 11603.709907252387, 11879.22785018971], "unit": "score", "name": "jquery.html", "value": 8632.733140521523}, {"lowerIsBetter": false, "replicates": [1316.3549860568323, 1574.6457047164386, 1799.154397433206, 1974.7136665183557, 1976.2095161935233, 7937.40469464791, 8647.0, 8737.038925718165, 8942.55287235638, 8976.551172441375, 7571.205023472525, 8431.95784021079, 8572.071283961106, 8585.742427727178, 8705.65177392905, 2473.4805690804906, 2498.4128729748495, 2499.8375105618165, 2501.262127672341, 2514.1326242446326, 2441.2432146034785, 2504.1235567551303, 2510.9121180758675, 2515.371157210697, 2520.218732193017, 2472.678551788265, 2495.4135778092223, 2514.7233804281514, 2528.0646160920487, 2528.6080657498023, 2492.6510288559616, 2506.887190076442, 2515.371157210697, 2515.434027343842, 2524.7096583892903, 2481.560694797013, 2494.2267896952003, 2496.463260399005, 2508.2475257422884, 2517.785988191006, 8703.782405439852, 8720.956395218047, 8722.08418116095, 8728.825423491495, 8743.387962842604, 4478.39541661878, 5050.595952323805, 5055.8988820223385, 5593.608447408642, 5597.0, 3615.385384484644, 3670.467782171597, 3738.6635202831876, 3746.1758413149337, 3763.73653844231, 977.8924318324979, 1056.1761825775907, 1064.276292121357, 1066.4880857188593, 1069.35838496902, 11866.347350895783, 11884.108691848232, 11938.22401543897, 11975.161738678209, 12001.819972700416, 4903.681260718042, 4934.309196712463, 4975.402951645753, 4984.800607975641, 5033.723145227048, 10065.849012264822, 10173.135283500837, 10185.490725463696, 10192.592296308065, 10209.234307426972, 5451.373092094381, 5518.779248830002, 5521.5306698930235, 5559.722013899289, 5567.860803479945, 4067.5525692173837, 4453.977730111329, 4950.8267210647455, 4964.8758781030765, 5038.546530812245, 3904.511936007999, 3911.5697273299916, 3980.8805735827973, 4009.3785463253244, 4054.7972601369815, 1137.85645426346, 1330.8469526004633, 1337.2645045225088, 1344.7512210241136, 1348.5684580934007, 1333.4599487207697, 1340.1021315718492, 1363.5636596289291, 1369.1921766158014, 1374.299107455185, 8199.71301004462, 8203.548804815673, 8233.135520770233, 8243.464174828618, 8277.793055173668, 514.9871253218624, 524.7900839664164, 527.2618334331889, 527.6886636884257, 535.266684642043, 5119.897602047939, 5151.4333423323405, 6236.688165591702, 6249.437550620466, 6251.937480625135, 8011.759647210593, 10871.456427178768, 10897.237193396544, 10900.836487452694, 11006.724831879266, 10391.53238104287, 10729.195310351755, 10824.837627435594, 10860.674179774462, 10872.130229581615, 8366.205210504992, 8447.98624165104, 8497.150284971576, 8510.574471276412, 8541.291741651694, 7829.153294504555, 7891.526508409514, 7938.603069846369, 7981.002374703162, 8058.798530036796, 8964.506952117696, 9482.099200575934, 9641.37331073478, 9665.840099188143, 10019.849702254618, 8357.874631880404, 9347.672831450867, 9808.65669701557, 10118.342307749972, 10294.742631433974, 6761.628110453972, 7211.747588834365, 7441.293077157661, 7547.245275472409, 7603.619819009138, 8252.257296843072, 8341.290990265896, 8352.039515455557, 8389.993200815697, 8409.579521024047, 7320.414366850746, 7410.740624078131, 7439.181690013986, 7564.281393267631, 7603.315701586884, 7288.708451661874, 7291.744788932362, 7341.155767086853, 7373.705051797868, 7381.889271660822, 7724.613769311624, 7775.57234352116, 7829.491083079582, 7831.725889593837, 7845.411594130349, 6826.214985276757, 7020.087388639444, 7033.331833475811, 7068.0, 7099.36105750485, 7108.466864985044, 7141.143062832493, 7194.568325900463, 7201.0, 7234.348908598251], "unit": "score", "name": "mootools.html", "value": 4861.863483689705}, {"lowerIsBetter": false, "replicates": [270.69141179055873, 332.68395024726516, 335.9916002099947, 337.98141102239373, 339.57044338911265, 6792.456603471716, 6877.862442751149, 6878.965605171968, 6892.069570607979, 6914.44684425246, 5098.413682426522, 5355.946440535594, 6520.67396630169, 6749.156355455568, 6779.932200677992, 4299.935500967488, 4323.891902702442, 4543.0, 4981.476944920785, 4985.700857948535, 4961.702297862122, 4971.552560269575, 4991.825286114987, 5055.342805435288, 5067.163917953533, 5034.0686972910125, 5034.496550344955, 5037.370328708911, 5047.965167140727, 5080.364954380702, 5051.166557518042, 5058.064258112261, 5067.138586440314, 5073.959838233153, 5078.1874900016, 4301.333293339538, 4302.978485107586, 4310.504292006428, 4310.784460776948, 4331.613883557263, 5297.602679799031, 6273.12176295319, 6523.575967562141, 6624.436922861562, 6654.966725166343, 4737.73942433166, 5811.186433899257, 5873.765049398019, 5922.851928701773, 5971.701414929236, 7317.59753213573, 7337.559746415232, 7346.897965305194, 7395.223501532316, 7414.962925185394, 4659.603933665642, 4664.090502352043, 4666.719996800169, 4676.438827340741, 4685.367475390813, 7451.739189128409, 7681.846363072763, 7760.223977602251, 7783.883241751379, 7797.0, 4519.570640789119, 4555.794989225493, 4629.699069560468, 4755.500672429414, 4771.06964141989, 4845.103655823684, 4847.3698419205275, 4855.0, 4857.805687772449, 4867.683600565952, 5803.245578074823, 5816.447437493432, 5834.912476312858, 5837.795677151279, 5844.094165404369, 7391.260873912674, 7397.889031664529, 7406.222346653632, 7415.851682966419, 7433.479656423999, 1616.4261687101146, 1666.150263365668, 1686.4856218853367, 1690.729483282669, 1695.482877722282, 1054.0302921312411, 1064.8775390829999, 1068.8931106889404, 1073.098597178374, 1077.2459278505078, 6607.603543787292, 6644.734210631617, 6646.8005959821285, 6659.234188068337, 6707.128073350434, 6341.397567231198, 6692.665366731644, 7241.2396698346965, 7406.407487400995, 7427.368673662691, 6678.3989440950545, 6685.997100434974, 6705.765298214539, 6706.061151438803, 6706.865862682816, 3892.785896775648, 3976.1252524444576, 3999.6200360965663, 4009.3785463253244, 4021.8391264349684, 6430.0, 6475.384838440341, 7705.189280519186, 7846.0, 7957.880631790527, 7937.166597507294, 7941.563214023168, 7942.3646108311195, 7969.840603187904, 7970.681172753141, 8038.155993620586, 8039.638216280281, 8051.838963220585, 8064.395170362246, 8081.717139900193, 7343.192248852729, 7630.923690763021, 7689.154193038873, 7704.845903081795, 7747.0, 7523.210062943531, 7546.1321947976685, 7564.054493188351, 7564.659590318339, 7603.771886843404, 8011.959940200261, 8022.318102961313, 8045.99425071866, 8055.234752698484, 8066.878996814935, 4701.106789709944, 4728.45622753374, 4753.263244197155, 4760.190767569591, 4764.690295130944, 7426.962865185639, 7573.35626471756, 7681.347085497795, 7683.538987660758, 7688.8462230756195, 7344.522606030591, 7379.372753316028, 7405.296496832792, 7411.962940185264, 7418.925810741824, 7359.1169059713175, 7370.262973702587, 7371.520851144658, 7393.408527317694, 7395.778126656209, 6986.895196571953, 7218.530795498275, 7219.819504512429, 7224.8916266255, 7262.31008054234, 6430.356964303533, 6520.217573891164, 7014.772414827283, 7434.219406962191, 7463.141738700119, 5374.946250537601, 5922.911156332572, 6304.802087603524, 6712.53012289135, 7258.745943891939], "unit": "score", "name": "prototype.html", "value": 5267.632363368219}, {"lowerIsBetter": false, "replicates": [652.4649787174517, 711.0365454808734, 721.7004942948673, 750.1560744162815, 754.5510421299325, 14902.254887255634, 15055.698886022274, 15131.243437828105, 15135.940484166113, 15190.468333608313, 14414.918881083935, 14449.422023119063, 15898.76151857723, 16261.593460163473, 16275.0, 910.968116115936, 910.9954450227756, 921.3412410126758, 923.5428462910869, 925.5603588295539, 745.5154149802645, 916.6470908700165, 922.3912217936163, 922.912323329286, 925.676013395313, 964.430985718426, 966.2704657983213, 971.4122955611859, 973.9464329461877, 982.7788747531783, 948.340903072365, 961.8749562556893, 964.0263334032643, 966.227018385296, 978.427619842393, 698.4970821008916, 715.9821004474878, 717.7452004538366, 719.5035425556349, 723.2478222648492, 15535.145566993811, 15629.531114066596, 15648.843511564966, 15651.530454086396, 15662.451814186448, 12461.688457788538, 12518.874811251953, 12534.561290354794, 12693.428795704216, 12725.981921446355, 8907.777305567348, 9761.316707830454, 9902.356346837432, 10101.49492525378, 10194.490275486196, 3432.3135372925517, 3472.947905781415, 3487.128217945514, 3500.6674365935196, 3583.175869549992, 85811.0, 86593.56703216507, 86623.0, 86832.56583717105, 87033.56483217607, 9286.535673216313, 9374.90625093754, 9375.296852736072, 9392.95303523478, 9444.433333999981, 21246.893765531073, 21310.573788524143, 21394.572108557742, 21698.13207471715, 21727.0, 7290.635468226567, 7335.449841261927, 7349.265073492608, 7483.812904677427, 7579.924200758032, 4064.7561146330722, 4082.755034697928, 4118.444010058603, 4120.464339635828, 4160.729552579072, 3618.6924111450294, 3640.872569460056, 3659.030356955409, 3668.761530500509, 3670.834812433447, 657.9243387010459, 668.38174688414, 675.0212192321154, 680.1158493957835, 680.6766785776716, 528.8651393894532, 578.5507304202945, 603.1279187615519, 607.1742430294795, 610.914471973924, 7750.682383994735, 7967.8406431871035, 8057.677692892219, 8232.50604963704, 8267.255946964802, 513.4018868018791, 576.7692922830901, 586.8679547101868, 604.7701873288122, 617.3579477343512, 3397.3884700753606, 3597.94603080954, 3632.5651367709606, 3837.597052309523, 3884.3590807517007, 88303.67544486838, 91000.0, 91149.08850911407, 91821.0, 91863.0, 73525.16187095366, 75063.0, 75938.62030689811, 76547.61726191333, 77748.0, 51685.74157129265, 63516.04725929022, 67314.32685673081, 67845.0, 67952.0, 5484.8354549363585, 6917.754804135304, 7562.222877623864, 7631.275028872248, 7866.842663146591, 48858.0, 49107.77230569264, 49722.50277497323, 49904.75047624738, 51202.97594048172, 59191.816163677344, 60691.0, 63446.0, 64068.3593164081, 66953.0, 10993.780124397308, 11185.496652650812, 11241.437928103398, 11251.38117403518, 11569.363684997406, 11813.173077884809, 11829.82255266189, 11954.0, 12007.939960300142, 12483.001359891368, 9200.815983680423, 11449.771004580029, 11473.770524589294, 11663.650090497298, 11862.584809531625, 11193.440327983406, 11419.771604567695, 11429.542818287175, 11823.940880295544, 12258.20321679088, 8988.730338089868, 10830.566777328819, 10949.726256843642, 11542.653720388402, 11559.479823407799, 9231.399959002643, 9480.668176613786, 9527.209973519097, 9709.951450242703, 9868.703938881845, 8095.23095305945, 9327.393719408217, 9509.953905070575, 9626.95186524063, 9640.807183856425], "unit": "score", "name": "yui.html", "value": 6864.399255762742}], "name": "dromaeo_css", "value": 7472.74025343008}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 110.0, 113.0, 114.0, 125.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [153.0, 122.0, 141.0, 156.0, 125.0, 140.0, 126.0, 161.0, 188.0, 152.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [195.0, 199.0, 197.0, 195.0, 201.0, 237.0, 219.0, 197.0, 197.0, 201.0], "unit": "score", "name": "audio-dft", "value": 203.8}, {"lowerIsBetter": true, "replicates": [60.0, 93.0, 81.0, 80.0, 88.0, 86.0, 62.0, 114.0, 58.0, 58.0], "unit": "score", "name": "audio-fft", "value": 78.0}, {"lowerIsBetter": true, "replicates": [114.0, 89.0, 116.0, 78.0, 78.0, 82.0, 116.0, 80.0, 80.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 86.0, 89.0, 84.0, 89.0, 107.0, 86.0, 73.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.5}, {"lowerIsBetter": true, "replicates": [91.0, 126.0, 149.0, 95.0, 94.0, 104.0, 93.0, 143.0, 114.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 110.3}, {"lowerIsBetter": true, "replicates": [78.0, 154.0, 149.0, 91.0, 90.0, 96.0, 138.0, 87.0, 155.0, 143.0], "unit": "score", "name": "imaging-desaturate", "value": 118.1}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 54.0, 56.0, 56.0, 63.0, 59.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [60.0, 67.0, 73.0, 73.0, 73.0, 71.0, 66.0, 67.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 85.0, 86.0, 87.0, 84.0, 87.0, 86.0, 88.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [128.0, 133.0, 137.0, 134.0, 109.0, 149.0, 114.0, 108.0, 135.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.6}, {"lowerIsBetter": true, "replicates": [175.0, 144.0, 139.0, 141.0, 141.0, 134.0, 155.0, 176.0, 156.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.6}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 66.0, 69.0, 69.0, 68.0, 66.0, 70.0, 67.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1512.0999999999997}]} 18:26:12 INFO - Return code: 0 18:26:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:26:12 ERROR - # TBPL SUCCESS # 18:26:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:26:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:26:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:26:12 INFO - 2016-03-09 18:26:12.346 screenresolution[1690:10793] starting screenresolution argv=screenresolution get 18:26:12 INFO - 2016-03-09 18:26:12.349 screenresolution[1690:10793] Display 0: 1600x1200x32@60 18:26:12 INFO - 2016-03-09 18:26:12.354 screenresolution[1691:10796] starting screenresolution argv=screenresolution list 18:26:12 INFO - Available Modes on Display 0 18:26:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:26:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:26:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:26:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:26:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:26:12 INFO - Intel Iris: 18:26:12 INFO - Chipset Model: Intel Iris 18:26:12 INFO - Type: GPU 18:26:12 INFO - Bus: Built-In 18:26:12 INFO - VRAM (Dynamic, Max): 1536 MB 18:26:12 INFO - Vendor: Intel (0x8086) 18:26:12 INFO - Device ID: 0x0a2e 18:26:12 INFO - Revision ID: 0x0009 18:26:12 INFO - Displays: 18:26:12 INFO - Display: 18:26:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:26:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:26:12 INFO - Display Serial Number: 1600x1200 60 18:26:12 INFO - Main Display: Yes 18:26:12 INFO - Mirror: Off 18:26:12 INFO - Online: Yes 18:26:12 INFO - Rotation: Supported 18:26:12 INFO - Return code: 0 18:26:12 INFO - Running post-action listener: _resource_record_post_action 18:26:12 INFO - Running post-run listener: _resource_record_post_run 18:26:13 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 34156032; Write bytes: 707924480; Read time: 373; Write time: 1943 18:26:13 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382702080; Write bytes: 377210880; Read time: 28542; Write time: 721 18:26:13 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 33218048; Write bytes: 303790592; Read time: 358; Write time: 1167 18:26:13 INFO - Running post-run listener: _upload_blobber_files 18:26:13 INFO - Blob upload gear active. 18:26:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:26:13 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 18:26:13 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'] 18:26:13 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 18:26:14 INFO - (blobuploader) - INFO - Open directory for files ... 18:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:26:15 INFO - (blobuploader) - INFO - Done attempting. 18:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:26:16 INFO - (blobuploader) - INFO - Done attempting. 18:26:16 INFO - (blobuploader) - INFO - Iteration through files over. 18:26:16 INFO - Return code: 0 18:26:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:26:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:26:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0f713697c2bd455c3822be64591f8a3e06a01bb97f8a3d63a28bf9b721d89c1dae86fb161ce473f8686c5a0152b180720f541c0037bad4a93793fcc39fc2bfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab0a04103cc640c34a8f8e4299847e23efd70685792961289af09c901e3020d4a9bb8ac0175e7e4b1e5a88b16b675a87547a1fc5c94565dfe0d42a17c4e38cc"} 18:26:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:26:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:26:16 INFO - Contents: 18:26:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0f713697c2bd455c3822be64591f8a3e06a01bb97f8a3d63a28bf9b721d89c1dae86fb161ce473f8686c5a0152b180720f541c0037bad4a93793fcc39fc2bfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab0a04103cc640c34a8f8e4299847e23efd70685792961289af09c901e3020d4a9bb8ac0175e7e4b1e5a88b16b675a87547a1fc5c94565dfe0d42a17c4e38cc"} 18:26:16 INFO - Running post-run listener: copy_logs_to_upload_dir 18:26:16 INFO - Copying logs to upload dir... 18:26:16 INFO - mkdir: /builds/slave/test/build/upload/logs 18:26:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.655700 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-09 18:26:16.484793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 18:26:16.488570) ========= 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.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0f713697c2bd455c3822be64591f8a3e06a01bb97f8a3d63a28bf9b721d89c1dae86fb161ce473f8686c5a0152b180720f541c0037bad4a93793fcc39fc2bfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab0a04103cc640c34a8f8e4299847e23efd70685792961289af09c901e3020d4a9bb8ac0175e7e4b1e5a88b16b675a87547a1fc5c94565dfe0d42a17c4e38cc"} build_url:https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/SyinLjrPQ4CelEGiqtn09w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0f713697c2bd455c3822be64591f8a3e06a01bb97f8a3d63a28bf9b721d89c1dae86fb161ce473f8686c5a0152b180720f541c0037bad4a93793fcc39fc2bfb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab0a04103cc640c34a8f8e4299847e23efd70685792961289af09c901e3020d4a9bb8ac0175e7e4b1e5a88b16b675a87547a1fc5c94565dfe0d42a17c4e38cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 18:26:16.516375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:26:16.516703) ========= 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.NscrllcX6u/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.kgbbjKcNHD/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.004552 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:26:16.565147) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 18:26:16.565464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 18:26:16.565850) ========= ========= Total master_lag: 4.97 =========